builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-008 starttime: 1477920207.46 results: success (0) buildid: 20161031061044 builduid: 6cfbb8440354496dbaf13c4247aef9bf revision: 1b170b39ed6bdbde366233ab84594bdaaa960a5a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-31 06:23:27.464811) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-31 06:23:27.465310) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-31 06:23:27.465622) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-31 06:23:27.480555) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 06:23:27.480908) ========= 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=32c5991c409366f7fec8a718000001d2-1477920206.148172-952636325 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-31 06:23:27-- 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% 215M=0s 2016-10-31 06:23:27 (215 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.117720 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 06:23:27.612674) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 06:23:27.612986) ========= 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=32c5991c409366f7fec8a718000001d2-1477920206.148172-952636325 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016698 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 06:23:27.663317) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-31 06:23:27.663670) ========= 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=32c5991c409366f7fec8a718000001d2-1477920206.148172-952636325 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-31 06:23:28,103 truncating revision to first 12 chars 2016-10-31 06:23:28,103 Setting DEBUG logging. 2016-10-31 06:23:28,103 attempt 1/10 2016-10-31 06:23:28,103 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-31 06:23:29,535 unpacking tar archive at: fx-team-1b170b39ed6b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.721586 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-31 06:23:29.398972) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-31 06:23:29.399302) ========= script_repo_revision: 1b170b39ed6bdbde366233ab84594bdaaa960a5a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-31 06:23:29.399722) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-31 06:23:29.399984) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-31 06:23:29.410112) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-10-31 06:23:29.410507) ========= /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=32c5991c409366f7fec8a718000001d2-1477920206.148172-952636325 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:23:29 INFO - MultiFileLogger online at 20161031 06:23:29 in /builds/slave/test 06:23:29 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 06:23:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:23:29 INFO - {'append_to_log': False, 06:23:29 INFO - 'base_work_dir': '/builds/slave/test', 06:23:29 INFO - 'blob_upload_branch': 'Fx-Team', 06:23:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:23:29 INFO - 'branch': 'Fx-Team', 06:23:29 INFO - 'buildbot_json_path': 'buildprops.json', 06:23:29 INFO - 'config_files': ('talos/linux_config.py',), 06:23:29 INFO - 'default_actions': ('clobber', 06:23:29 INFO - 'read-buildbot-config', 06:23:29 INFO - 'download-and-extract', 06:23:29 INFO - 'populate-webroot', 06:23:29 INFO - 'create-virtualenv', 06:23:29 INFO - 'install', 06:23:29 INFO - 'run-tests'), 06:23:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:23:29 INFO - 'download_minidump_stackwalk': True, 06:23:29 INFO - 'download_symbols': 'ondemand', 06:23:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:23:29 INFO - 'tooltool.py': '/tools/tooltool.py', 06:23:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:23:29 INFO - '/tools/misc-python/virtualenv.py')}, 06:23:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:23:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:23:29 INFO - 'installer_path': 'installer.exe', 06:23:29 INFO - 'log_level': 'info', 06:23:29 INFO - 'log_name': 'talos', 06:23:29 INFO - 'log_to_console': True, 06:23:29 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:23:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:23:29 INFO - 'opt_config_files': (), 06:23:29 INFO - 'pip_index': False, 06:23:29 INFO - 'sps_profile': False, 06:23:29 INFO - 'sps_profile_interval': 0, 06:23:29 INFO - 'suite': 'dromaeojs', 06:23:29 INFO - 'system_bits': '32', 06:23:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:23:29 INFO - 'title': 'talos-linux64-ix-008', 06:23:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:23:29 INFO - 'use_talos_json': True, 06:23:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:23:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:23:29 INFO - 'work_dir': 'build'} 06:23:29 INFO - [mozharness: 2016-10-31 13:23:29.948401Z] Running clobber step. 06:23:29 INFO - Running pre-action listener: _resource_record_pre_action 06:23:29 INFO - Running main action method: clobber 06:23:29 INFO - rmtree: /builds/slave/test/build 06:23:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:23:30 INFO - Running post-action listener: _resource_record_post_action 06:23:30 INFO - [mozharness: 2016-10-31 13:23:30.407283Z] Finished clobber step (success) 06:23:30 INFO - [mozharness: 2016-10-31 13:23:30.407383Z] Running read-buildbot-config step. 06:23:30 INFO - Running pre-action listener: _resource_record_pre_action 06:23:30 INFO - Running main action method: read_buildbot_config 06:23:30 INFO - Using buildbot properties: 06:23:30 INFO - { 06:23:30 INFO - "project": "", 06:23:30 INFO - "product": "firefox", 06:23:30 INFO - "script_repo_revision": "production", 06:23:30 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 06:23:30 INFO - "repository": "", 06:23:30 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 06:23:30 INFO - "buildid": "20161031061044", 06:23:30 INFO - "stage_platform": "linux64-pgo", 06:23:30 INFO - "basedir": "/builds/slave/test", 06:23:30 INFO - "buildnumber": 576, 06:23:30 INFO - "platform": "ubuntu64_hw", 06:23:30 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 06:23:30 INFO - "slavebuilddir": "test", 06:23:30 INFO - "branch": "fx-team", 06:23:30 INFO - "revision": "1b170b39ed6bdbde366233ab84594bdaaa960a5a", 06:23:30 INFO - "slavename": "talos-linux64-ix-008", 06:23:30 INFO - "builduid": "6cfbb8440354496dbaf13c4247aef9bf", 06:23:30 INFO - "repo_path": "integration/fx-team" 06:23:30 INFO - } 06:23:30 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. 06:23:30 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. 06:23:30 INFO - Running post-action listener: _resource_record_post_action 06:23:30 INFO - [mozharness: 2016-10-31 13:23:30.409975Z] Finished read-buildbot-config step (success) 06:23:30 INFO - [mozharness: 2016-10-31 13:23:30.410063Z] Running download-and-extract step. 06:23:30 INFO - Running pre-action listener: _resource_record_pre_action 06:23:30 INFO - Running main action method: download_and_extract 06:23:30 INFO - mkdir: /builds/slave/test/build/tests 06:23:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:23:30 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 06:23:30 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 06:23:30 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 06:23:30 INFO - Downloaded 1361 bytes. 06:23:30 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 06:23:30 INFO - Using the following test package requirements: 06:23:30 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 06:23:30 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:23:30 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:23:30 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:23:30 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:23:30 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:23:30 INFO - u'jsshell-linux-x86_64.zip'], 06:23:30 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:23:30 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:23:30 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 06:23:30 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:23:30 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:23:30 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:23:30 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:23:30 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:23:30 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:23:30 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:23:30 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:23:30 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:23:30 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 06:23:30 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 06:23:30 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 06:23:30 INFO - Http code: 200 06:23:30 INFO - via: 1.1 5ed093c37d643652e278a198e0556a40.cloudfront.net (CloudFront) 06:23:30 INFO - x-amz-cf-id: ecefNgm-Q6e2tuVOie_VT1b63eeItHFmh8Ps9hjy1y8Nv4BY_FLJkA== 06:23:30 INFO - x-amz-replication-status: PENDING 06:23:30 INFO - x-amz-version-id: osZ4AQHSLmYHTnKNoyV3cZDRYrTso.BD 06:23:30 INFO - Expected file size: 22006612 06:23:30 INFO - Obtained file size: 22006612 06:23:34 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 06:23:34 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 06:23:34 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 06:23:34 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 06:23:34 INFO - Http code: 200 06:23:34 INFO - via: 1.1 37af14ee951b12568cf1cc160d08abe6.cloudfront.net (CloudFront) 06:23:34 INFO - x-amz-cf-id: aRuWnX-lhIUgQgn75Z4sWd_cAUs8QgQvEwA-eyG0ZCJ9AVTTZyfaiA== 06:23:34 INFO - x-amz-replication-status: PENDING 06:23:34 INFO - x-amz-version-id: osZ4AQHSLmYHTnKNoyV3cZDRYrTso.BD 06:23:35 INFO - Expected file size: 22006612 06:23:35 INFO - Obtained file size: 22006612 06:23:39 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 06:23:39 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 06:23:39 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 06:23:39 INFO - Http code: 200 06:23:39 INFO - via: 1.1 0cf1d7257c633ae75623c5e75bf3805e.cloudfront.net (CloudFront) 06:23:39 INFO - x-amz-cf-id: onm0BwgVExc4gUUB6l1RRnlHQseIQkPV1rI_qVJeIf5Vk4d4GM-cuQ== 06:23:39 INFO - x-amz-replication-status: PENDING 06:23:39 INFO - x-amz-version-id: OEkE0NHKtrItDByKteAlalVk7PCLvBv7 06:23:40 INFO - Expected file size: 14409038 06:23:40 INFO - Obtained file size: 14409038 06: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')]} 06:23:40 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 06:23:40 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 06:23:40 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 06:23:40 INFO - Downloaded 59632139 bytes. 06:23:40 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 06:23:40 INFO - mkdir: /builds/slave/test/properties 06:23:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:23:40 INFO - Writing to file /builds/slave/test/properties/build_url 06:23:40 INFO - Contents: 06:23:40 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 06:23:40 INFO - Running post-action listener: _resource_record_post_action 06:23:40 INFO - Running post-action listener: set_extra_try_arguments 06:23:40 INFO - [mozharness: 2016-10-31 13:23:40.954316Z] Finished download-and-extract step (success) 06:23:40 INFO - [mozharness: 2016-10-31 13:23:40.954491Z] Running populate-webroot step. 06:23:40 INFO - Running pre-action listener: _resource_record_pre_action 06:23:40 INFO - Running main action method: populate_webroot 06:23:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:23:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:23:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:23:40 INFO - '--tppagecycles', 06:23:40 INFO - '7'], 06:23:40 INFO - 'tests': ['tsvgm']}}, 06:23:40 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:23:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:23:40 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:23:40 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:23:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:23:40 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:23:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:23:40 INFO - 'talos_options': ['--disable-e10s'], 06:23:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:23:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:23:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:23:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:23:40 INFO - 'talos_options': ['--disable-e10s'], 06:23:40 INFO - 'tests': ['damp', 'tps']}, 06:23:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:23:40 INFO - 'tests': ['damp', 'tps']}, 06:23:40 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:23:40 INFO - 'tests': ['dromaeo_dom']}, 06:23:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:23:40 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:23:40 INFO - 'tests': ['basic_compositor_video']}, 06:23:40 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:23:40 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:23:40 INFO - 'tests': ['a11yr', 06:23:40 INFO - 'ts_paint', 06:23:40 INFO - 'tpaint', 06:23:40 INFO - 'sessionrestore', 06:23:40 INFO - 'sessionrestore_no_auto_restore', 06:23:40 INFO - 'tabpaint']}, 06:23:40 INFO - 'other-e10s': {'tests': ['a11yr', 06:23:40 INFO - 'ts_paint', 06:23:40 INFO - 'tpaint', 06:23:40 INFO - 'sessionrestore', 06:23:40 INFO - 'sessionrestore_no_auto_restore', 06:23:40 INFO - 'tabpaint']}, 06:23:40 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:23:40 INFO - 'ts_paint', 06:23:40 INFO - 'tpaint', 06:23:40 INFO - 'sessionrestore', 06:23:40 INFO - 'sessionrestore_no_auto_restore', 06:23:40 INFO - 'tabpaint']}, 06:23:40 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:23:40 INFO - 'ts_paint', 06:23:40 INFO - 'tpaint', 06:23:40 INFO - 'sessionrestore', 06:23:40 INFO - 'sessionrestore_no_auto_restore', 06:23:40 INFO - 'tabpaint']}, 06:23:40 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:23:40 INFO - 'tests': ['a11yr', 06:23:40 INFO - 'ts_paint', 06:23:40 INFO - 'tpaint', 06:23:40 INFO - 'sessionrestore', 06:23:40 INFO - 'sessionrestore_no_auto_restore', 06:23:40 INFO - 'tabpaint']}, 06:23:40 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:23:40 INFO - 'tests': ['a11yr', 06:23:40 INFO - 'ts_paint', 06:23:40 INFO - 'tpaint', 06:23:40 INFO - 'sessionrestore', 06:23:40 INFO - 'sessionrestore_no_auto_restore', 06:23:40 INFO - 'tabpaint']}, 06:23:40 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:23:40 INFO - 'tests': ['tsvgx', 06:23:40 INFO - 'tsvgr_opacity', 06:23:40 INFO - 'tart', 06:23:40 INFO - 'tscrollx', 06:23:40 INFO - 'cart']}, 06:23:40 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:23:40 INFO - 'tsvgr_opacity', 06:23:40 INFO - 'tart', 06:23:40 INFO - 'tscrollx', 06:23:40 INFO - 'cart']}, 06:23:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:23:40 INFO - 'talos_options': ['--disable-e10s'], 06:23:40 INFO - 'tests': ['tp5o']}, 06:23:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:23:40 INFO - 'tests': ['tp5o']}, 06:23:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:23:40 INFO - 'talos_options': ['--disable-e10s', 06:23:40 INFO - '--xperf_path', 06:23:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:23:40 INFO - 'tests': ['tp5n']}, 06:23:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:23:40 INFO - 'talos_options': ['--xperf_path', 06:23:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:23:40 INFO - 'tests': ['tp5n']}}, 06:23:40 INFO - 'talos.zip': {'path': '', 06:23:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:23:40 INFO - Running post-action listener: _resource_record_post_action 06:23:40 INFO - [mozharness: 2016-10-31 13:23:40.971785Z] Finished populate-webroot step (success) 06:23:40 INFO - [mozharness: 2016-10-31 13:23:40.971872Z] Running create-virtualenv step. 06:23:40 INFO - Running pre-action listener: _resource_record_pre_action 06:23:40 INFO - Running main action method: create_virtualenv 06:23:40 INFO - Creating virtualenv /builds/slave/test/build/venv 06:23:40 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 06:23:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:23:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:23:41 INFO - Using real prefix '/usr' 06:23:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:23:41 INFO - Installing distribute.............................................................................................................................................................................................done. 06:23:43 INFO - Installing pip.................done. 06:23:43 INFO - Return code: 0 06:23:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:23:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:23:43 INFO - Reading from file tmpfile_stdout 06:23:43 INFO - Output received: 06:23:43 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) 06:23:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:23:43 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')]} 06:23:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:23:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23:43 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')]} 06:23:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:23:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23:43 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 0x7f465d725f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fc87b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2057790>, '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 0x2058690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2058b20>, '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': '32c5991c409366f7fec8a718000001d2-1477920206.148172-952636325', '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 06:23:43 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 06:23:43 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 06:23:43 INFO - Using env: {'DISPLAY': ':0', 06:23:43 INFO - 'HOME': '/home/cltbld', 06:23:43 INFO - 'LANG': 'en_US.UTF-8', 06:23:43 INFO - 'LANGUAGE': 'en_US:en', 06:23:43 INFO - 'LOGNAME': 'cltbld', 06:23:43 INFO - 'MAIL': '/var/mail/cltbld', 06:23:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:23:43 INFO - 'MOZ_NO_REMOTE': '1', 06:23:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:23:43 INFO - 'NO_EM_RESTART': '1', 06:23:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:23:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:23:43 INFO - 'PWD': '/builds/slave/test', 06:23:43 INFO - 'SHELL': '/bin/bash', 06:23:43 INFO - 'SHLVL': '1', 06:23:43 INFO - 'TERM': 'linux', 06:23:43 INFO - 'TMOUT': '86400', 06:23:43 INFO - 'USER': 'cltbld', 06:23:43 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1477920206.148172-952636325', 06:23:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:23:43 INFO - '_': '/tools/buildbot/bin/python'} 06:23:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:23:43 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 06:23:43 INFO - Cleaning up... 06:23:43 INFO - Return code: 0 06:23:43 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:23:43 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')]} 06:23:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:23:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23:43 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')]} 06:23:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:23:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23:43 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 0x7f465d725f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fc87b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2057790>, '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 0x2058690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2058b20>, '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': '32c5991c409366f7fec8a718000001d2-1477920206.148172-952636325', '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 06:23:43 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 06:23:43 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 06:23:43 INFO - Using env: {'DISPLAY': ':0', 06:23:43 INFO - 'HOME': '/home/cltbld', 06:23:44 INFO - 'LANG': 'en_US.UTF-8', 06:23:44 INFO - 'LANGUAGE': 'en_US:en', 06:23:44 INFO - 'LOGNAME': 'cltbld', 06:23:44 INFO - 'MAIL': '/var/mail/cltbld', 06:23:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:23:44 INFO - 'MOZ_NO_REMOTE': '1', 06:23:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:23:44 INFO - 'NO_EM_RESTART': '1', 06:23:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:23:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:23:44 INFO - 'PWD': '/builds/slave/test', 06:23:44 INFO - 'SHELL': '/bin/bash', 06:23:44 INFO - 'SHLVL': '1', 06:23:44 INFO - 'TERM': 'linux', 06:23:44 INFO - 'TMOUT': '86400', 06:23:44 INFO - 'USER': 'cltbld', 06:23:44 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1477920206.148172-952636325', 06:23:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:23:44 INFO - '_': '/tools/buildbot/bin/python'} 06:23:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:23:44 INFO - Downloading/unpacking psutil>=3.1.1 06:23:44 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 06:23:44 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 06:23:44 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 06:23:44 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 06:23:44 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 06:23:44 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 06:23:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:23:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:23:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:23:46 INFO - Installing collected packages: psutil 06:23:46 INFO - Running setup.py install for psutil 06:23:46 INFO - building 'psutil._psutil_linux' extension 06:23:46 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 06:23:46 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 06:23:46 INFO - building 'psutil._psutil_posix' extension 06:23:46 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 06:23:46 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 06:23:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:23:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:23:46 INFO - Successfully installed psutil 06:23:46 INFO - Cleaning up... 06:23:46 INFO - Return code: 0 06:23:46 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:23:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:23:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:23:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:23:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:23:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f465d725f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fc87b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2057790>, '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 0x2058690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2058b20>, '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': '32c5991c409366f7fec8a718000001d2-1477920206.148172-952636325', '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 06:23:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 06:23:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 06:23:46 INFO - Using env: {'DISPLAY': ':0', 06:23:46 INFO - 'HOME': '/home/cltbld', 06:23:46 INFO - 'LANG': 'en_US.UTF-8', 06:23:46 INFO - 'LANGUAGE': 'en_US:en', 06:23:46 INFO - 'LOGNAME': 'cltbld', 06:23:46 INFO - 'MAIL': '/var/mail/cltbld', 06:23:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:23:46 INFO - 'MOZ_NO_REMOTE': '1', 06:23:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:23:46 INFO - 'NO_EM_RESTART': '1', 06:23:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:23:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:23:46 INFO - 'PWD': '/builds/slave/test', 06:23:46 INFO - 'SHELL': '/bin/bash', 06:23:46 INFO - 'SHLVL': '1', 06:23:46 INFO - 'TERM': 'linux', 06:23:46 INFO - 'TMOUT': '86400', 06:23:46 INFO - 'USER': 'cltbld', 06:23:46 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1477920206.148172-952636325', 06:23:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:23:46 INFO - '_': '/tools/buildbot/bin/python'} 06:23:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:23:47 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:23:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:23:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:23:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:23:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:23:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:23:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:23:48 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:23:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:23:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:23:48 INFO - Installing collected packages: mozsystemmonitor 06:23:48 INFO - Running setup.py install for mozsystemmonitor 06:23:49 INFO - Successfully installed mozsystemmonitor 06:23:49 INFO - Cleaning up... 06:23:49 INFO - Return code: 0 06:23:49 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:23:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:23:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:23:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:23:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:23:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f465d725f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fc87b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2057790>, '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 0x2058690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2058b20>, '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': '32c5991c409366f7fec8a718000001d2-1477920206.148172-952636325', '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 06:23:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 06:23:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 06:23:49 INFO - Using env: {'DISPLAY': ':0', 06:23:49 INFO - 'HOME': '/home/cltbld', 06:23:49 INFO - 'LANG': 'en_US.UTF-8', 06:23:49 INFO - 'LANGUAGE': 'en_US:en', 06:23:49 INFO - 'LOGNAME': 'cltbld', 06:23:49 INFO - 'MAIL': '/var/mail/cltbld', 06:23:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:23:49 INFO - 'MOZ_NO_REMOTE': '1', 06:23:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:23:49 INFO - 'NO_EM_RESTART': '1', 06:23:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:23:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:23:49 INFO - 'PWD': '/builds/slave/test', 06:23:49 INFO - 'SHELL': '/bin/bash', 06:23:49 INFO - 'SHLVL': '1', 06:23:49 INFO - 'TERM': 'linux', 06:23:49 INFO - 'TMOUT': '86400', 06:23:49 INFO - 'USER': 'cltbld', 06:23:49 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1477920206.148172-952636325', 06:23:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:23:49 INFO - '_': '/tools/buildbot/bin/python'} 06:23:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:23:49 INFO - Downloading/unpacking jsonschema==2.5.1 06:23:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:23:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:23:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:23:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:23:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:23:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:23:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:23:51 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:23:51 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 06:23:51 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 06:23:51 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 06:23:51 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 06:23:51 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 06:23:51 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 06:23:51 INFO - Downloading functools32-3.2.3-2.tar.gz 06:23:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:23:51 INFO - warning: no files found matching '*.txt' 06:23:51 INFO - no previously-included directories found matching 'build' 06:23:51 INFO - no previously-included directories found matching 'dist' 06:23:51 INFO - no previously-included directories found matching '.git*' 06:23:51 INFO - Installing collected packages: jsonschema, functools32 06:23:51 INFO - Running setup.py install for functools32 06:23:51 INFO - warning: no files found matching '*.txt' 06:23:51 INFO - no previously-included directories found matching 'build' 06:23:51 INFO - no previously-included directories found matching 'dist' 06:23:51 INFO - no previously-included directories found matching '.git*' 06:23:51 INFO - Successfully installed jsonschema functools32 06:23:51 INFO - Cleaning up... 06:23:51 INFO - Return code: 0 06:23:51 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:23:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:23:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:23:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:23:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:23:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23:51 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 0x7f465d725f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fc87b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2057790>, '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 0x2058690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2058b20>, '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': '32c5991c409366f7fec8a718000001d2-1477920206.148172-952636325', '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 06:23:51 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 06:23:51 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 06:23:51 INFO - Using env: {'DISPLAY': ':0', 06:23:51 INFO - 'HOME': '/home/cltbld', 06:23:51 INFO - 'LANG': 'en_US.UTF-8', 06:23:51 INFO - 'LANGUAGE': 'en_US:en', 06:23:51 INFO - 'LOGNAME': 'cltbld', 06:23:51 INFO - 'MAIL': '/var/mail/cltbld', 06:23:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:23:51 INFO - 'MOZ_NO_REMOTE': '1', 06:23:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:23:51 INFO - 'NO_EM_RESTART': '1', 06:23:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:23:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:23:51 INFO - 'PWD': '/builds/slave/test', 06:23:51 INFO - 'SHELL': '/bin/bash', 06:23:51 INFO - 'SHLVL': '1', 06:23:51 INFO - 'TERM': 'linux', 06:23:51 INFO - 'TMOUT': '86400', 06:23:51 INFO - 'USER': 'cltbld', 06:23:51 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1477920206.148172-952636325', 06:23:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:23:51 INFO - '_': '/tools/buildbot/bin/python'} 06:23:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:23:52 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:23:52 INFO - Cleaning up... 06:23:52 INFO - Return code: 0 06:23:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:23:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:23:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:23:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:23:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:23:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f465d725f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fc87b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2057790>, '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 0x2058690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2058b20>, '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': '32c5991c409366f7fec8a718000001d2-1477920206.148172-952636325', '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 06:23:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:23:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:23:52 INFO - Using env: {'DISPLAY': ':0', 06:23:52 INFO - 'HOME': '/home/cltbld', 06:23:52 INFO - 'LANG': 'en_US.UTF-8', 06:23:52 INFO - 'LANGUAGE': 'en_US:en', 06:23:52 INFO - 'LOGNAME': 'cltbld', 06:23:52 INFO - 'MAIL': '/var/mail/cltbld', 06:23:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:23:52 INFO - 'MOZ_NO_REMOTE': '1', 06:23:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:23:52 INFO - 'NO_EM_RESTART': '1', 06:23:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:23:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:23:52 INFO - 'PWD': '/builds/slave/test', 06:23:52 INFO - 'SHELL': '/bin/bash', 06:23:52 INFO - 'SHLVL': '1', 06:23:52 INFO - 'TERM': 'linux', 06:23:52 INFO - 'TMOUT': '86400', 06:23:52 INFO - 'USER': 'cltbld', 06:23:52 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1477920206.148172-952636325', 06:23:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:23:52 INFO - '_': '/tools/buildbot/bin/python'} 06:23:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:23:52 INFO - Downloading/unpacking blobuploader==1.2.4 06:23:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:23:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:23:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:23:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:23:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:23:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:23:54 INFO - Downloading blobuploader-1.2.4.tar.gz 06:23:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:23:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:23:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:23:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:23:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:23:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:23:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:23:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:23:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:23:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:23:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:23:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:23:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:23:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:23:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:23:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:23:54 INFO - Downloading docopt-0.6.1.tar.gz 06:23:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:23:54 INFO - Installing collected packages: blobuploader, requests, docopt 06:23:54 INFO - Running setup.py install for blobuploader 06:23:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:23:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:23:55 INFO - Running setup.py install for requests 06:23:55 INFO - Running setup.py install for docopt 06:23:55 INFO - Successfully installed blobuploader requests docopt 06:23:55 INFO - Cleaning up... 06:23:55 INFO - Return code: 0 06:23:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:23:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:23:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:23:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:23:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:23:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23:55 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 0x7f465d725f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fc87b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2057790>, '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 0x2058690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2058b20>, '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': '32c5991c409366f7fec8a718000001d2-1477920206.148172-952636325', '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 06:23:55 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 06:23:55 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 06:23:55 INFO - Using env: {'DISPLAY': ':0', 06:23:55 INFO - 'HOME': '/home/cltbld', 06:23:55 INFO - 'LANG': 'en_US.UTF-8', 06:23:55 INFO - 'LANGUAGE': 'en_US:en', 06:23:55 INFO - 'LOGNAME': 'cltbld', 06:23:55 INFO - 'MAIL': '/var/mail/cltbld', 06:23:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:23:55 INFO - 'MOZ_NO_REMOTE': '1', 06:23:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:23:55 INFO - 'NO_EM_RESTART': '1', 06:23:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:23:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:23:55 INFO - 'PWD': '/builds/slave/test', 06:23:55 INFO - 'SHELL': '/bin/bash', 06:23:55 INFO - 'SHLVL': '1', 06:23:55 INFO - 'TERM': 'linux', 06:23:55 INFO - 'TMOUT': '86400', 06:23:55 INFO - 'USER': 'cltbld', 06:23:55 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1477920206.148172-952636325', 06:23:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:23:55 INFO - '_': '/tools/buildbot/bin/python'} 06:23:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:23:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:23:55 INFO - Running setup.py (path:/tmp/pip-KSjvdz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:23:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:23:55 INFO - Running setup.py (path:/tmp/pip-q7S6az-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:23:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:23:55 INFO - Running setup.py (path:/tmp/pip-Wridh7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:23:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:23:56 INFO - Running setup.py (path:/tmp/pip-i4oiJ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:23:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:23:56 INFO - Running setup.py (path:/tmp/pip-uWviGd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:23:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:23:56 INFO - Running setup.py (path:/tmp/pip-8oFIq8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:23:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:23:56 INFO - Running setup.py (path:/tmp/pip-L9b4ng-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:23:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:23:56 INFO - Running setup.py (path:/tmp/pip-SxL4Rq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:23:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:23:56 INFO - Running setup.py (path:/tmp/pip-YSyREu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:23:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:23:56 INFO - Running setup.py (path:/tmp/pip-LobtwU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:23:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:23:56 INFO - Running setup.py (path:/tmp/pip-HyaRUE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:23:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:23:56 INFO - Running setup.py (path:/tmp/pip-AwFoEx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:23:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:23:56 INFO - Running setup.py (path:/tmp/pip-zf1T6e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:23:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:23:56 INFO - Running setup.py (path:/tmp/pip-lmAys9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:23:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:23:56 INFO - Running setup.py (path:/tmp/pip-BlpXcz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:23:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:23:56 INFO - Running setup.py (path:/tmp/pip-f5FERV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:23:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:23:56 INFO - Running setup.py (path:/tmp/pip-fIhN7M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:23:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:23:57 INFO - Running setup.py install for manifestparser 06:23:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:23:57 INFO - Running setup.py install for mozcrash 06:23:57 INFO - Running setup.py install for mozdebug 06:23:57 INFO - Running setup.py install for mozdevice 06:23:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:23:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:23:57 INFO - Running setup.py install for mozfile 06:23:57 INFO - Running setup.py install for mozhttpd 06:23:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:23:57 INFO - Running setup.py install for mozinfo 06:23:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:23:57 INFO - Running setup.py install for mozInstall 06:23:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:23:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:23:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:23:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:23:57 INFO - Running setup.py install for mozleak 06:23:57 INFO - Running setup.py install for mozlog 06:23:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:23:58 INFO - Running setup.py install for moznetwork 06:23:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:23:58 INFO - Running setup.py install for mozprocess 06:23:58 INFO - Running setup.py install for mozprofile 06:23:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:23:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:23:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:23:58 INFO - Running setup.py install for mozrunner 06:23:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:23:58 INFO - Running setup.py install for mozscreenshot 06:23:58 INFO - Running setup.py install for moztest 06:23:58 INFO - Running setup.py install for mozversion 06:23:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:23:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:23:58 INFO - Cleaning up... 06:23:58 INFO - Return code: 0 06:23:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:23:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:23:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:23:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:23:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:23:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23:58 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 0x7f465d725f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fc87b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2057790>, '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 0x2058690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2058b20>, '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': '32c5991c409366f7fec8a718000001d2-1477920206.148172-952636325', '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 06:23:58 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 06:23:58 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 06:23:58 INFO - Using env: {'DISPLAY': ':0', 06:23:58 INFO - 'HOME': '/home/cltbld', 06:23:58 INFO - 'LANG': 'en_US.UTF-8', 06:23:58 INFO - 'LANGUAGE': 'en_US:en', 06:23:58 INFO - 'LOGNAME': 'cltbld', 06:23:58 INFO - 'MAIL': '/var/mail/cltbld', 06:23:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:23:58 INFO - 'MOZ_NO_REMOTE': '1', 06:23:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:23:58 INFO - 'NO_EM_RESTART': '1', 06:23:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:23:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:23:58 INFO - 'PWD': '/builds/slave/test', 06:23:58 INFO - 'SHELL': '/bin/bash', 06:23:58 INFO - 'SHLVL': '1', 06:23:58 INFO - 'TERM': 'linux', 06:23:58 INFO - 'TMOUT': '86400', 06:23:58 INFO - 'USER': 'cltbld', 06:23:58 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1477920206.148172-952636325', 06:23:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:23:58 INFO - '_': '/tools/buildbot/bin/python'} 06:23:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:23:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:23:59 INFO - Running setup.py (path:/tmp/pip-s44PGn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:23:59 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)) 06:23:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:23:59 INFO - Running setup.py (path:/tmp/pip-nJzUQ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:23:59 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)) 06:23:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:23:59 INFO - Running setup.py (path:/tmp/pip-oJJQ4z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:23:59 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)) 06:23:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:23:59 INFO - Running setup.py (path:/tmp/pip-1bYBx3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:23:59 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)) 06:23:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:23:59 INFO - Running setup.py (path:/tmp/pip-fnBGIl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:23:59 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)) 06:23:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:23:59 INFO - Running setup.py (path:/tmp/pip-Lcicxj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:23:59 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)) 06:23:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:23:59 INFO - Running setup.py (path:/tmp/pip-X4heal-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:23:59 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)) 06:23:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:23:59 INFO - Running setup.py (path:/tmp/pip-dThZ__-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:23:59 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)) 06:23:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:23:59 INFO - Running setup.py (path:/tmp/pip-OR8XOj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:23:59 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)) 06:23:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:23:59 INFO - Running setup.py (path:/tmp/pip-S2Wr8l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:23:59 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)) 06:23:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:23:59 INFO - Running setup.py (path:/tmp/pip-DCZmTM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:23:59 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)) 06:23:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:23:59 INFO - Running setup.py (path:/tmp/pip-cZWMG2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:23:59 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)) 06:23:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:23:59 INFO - Running setup.py (path:/tmp/pip-OOdbEw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:24:00 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)) 06:24:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:24:00 INFO - Running setup.py (path:/tmp/pip-5WWejR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:24:00 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)) 06:24:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:24:00 INFO - Running setup.py (path:/tmp/pip-C45d7l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:24:00 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)) 06:24:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:24:00 INFO - Running setup.py (path:/tmp/pip-upNcj_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:24:00 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)) 06:24:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:24:00 INFO - Running setup.py (path:/tmp/pip-Z7JU8M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:24:00 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)) 06:24:00 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)) 06:24:00 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)) 06:24:00 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)) 06:24:00 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)) 06:24:00 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)) 06:24:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:24:00 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 06:24:00 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 06:24:00 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 06:24:00 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 06:24:00 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 06:24:00 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 06:24:02 INFO - Downloading blessings-1.6.tar.gz 06:24:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:24:02 INFO - Installing collected packages: blessings 06:24:02 INFO - Running setup.py install for blessings 06:24:02 INFO - Successfully installed blessings 06:24:02 INFO - Cleaning up... 06:24:02 INFO - Return code: 0 06:24:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:24:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:24:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:24:02 INFO - Reading from file tmpfile_stdout 06:24:02 INFO - Current package versions: 06:24:02 INFO - argparse == 1.2.1 06:24:02 INFO - blessings == 1.6 06:24:02 INFO - blobuploader == 1.2.4 06:24:02 INFO - docopt == 0.6.1 06:24:02 INFO - functools32 == 3.2.3-2 06:24:02 INFO - jsonschema == 2.5.1 06:24:02 INFO - manifestparser == 1.1 06:24:02 INFO - mozInstall == 1.12 06:24:02 INFO - mozcrash == 0.17 06:24:02 INFO - mozdebug == 0.1 06:24:02 INFO - mozdevice == 0.48 06:24:02 INFO - mozfile == 1.2 06:24:02 INFO - mozhttpd == 0.7 06:24:02 INFO - mozinfo == 0.9 06:24:02 INFO - mozleak == 0.1 06:24:02 INFO - mozlog == 3.4 06:24:02 INFO - moznetwork == 0.27 06:24:02 INFO - mozprocess == 0.23 06:24:02 INFO - mozprofile == 0.28 06:24:02 INFO - mozrunner == 6.12 06:24:02 INFO - mozscreenshot == 0.1 06:24:02 INFO - mozsystemmonitor == 0.3 06:24:02 INFO - moztest == 0.7 06:24:02 INFO - mozversion == 1.4 06:24:02 INFO - psutil == 3.1.1 06:24:02 INFO - requests == 1.2.3 06:24:02 INFO - wsgiref == 0.1.2 06:24:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06: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')]} 06:24:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:24:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06: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')]} 06:24:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:24:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:24:02 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 0x7f465d725f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fc87b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2057790>, '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 0x2058690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2058b20>, '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': '32c5991c409366f7fec8a718000001d2-1477920206.148172-952636325', '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 06:24:02 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 06:24:02 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 06:24:02 INFO - Using env: {'DISPLAY': ':0', 06:24:02 INFO - 'HOME': '/home/cltbld', 06:24:02 INFO - 'LANG': 'en_US.UTF-8', 06:24:02 INFO - 'LANGUAGE': 'en_US:en', 06:24:02 INFO - 'LOGNAME': 'cltbld', 06:24:02 INFO - 'MAIL': '/var/mail/cltbld', 06:24:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:24:02 INFO - 'MOZ_NO_REMOTE': '1', 06:24:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:24:02 INFO - 'NO_EM_RESTART': '1', 06:24:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:24:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:24:02 INFO - 'PWD': '/builds/slave/test', 06:24:02 INFO - 'SHELL': '/bin/bash', 06:24:02 INFO - 'SHLVL': '1', 06:24:02 INFO - 'TERM': 'linux', 06:24:02 INFO - 'TMOUT': '86400', 06:24:02 INFO - 'USER': 'cltbld', 06:24:02 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1477920206.148172-952636325', 06:24:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:24:02 INFO - '_': '/tools/buildbot/bin/python'} 06:24:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:24:02 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)) 06:24:02 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)) 06:24:02 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)) 06:24:02 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)) 06:24:02 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)) 06:24:02 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)) 06:24:02 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)) 06:24:02 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)) 06:24:02 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)) 06:24:02 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)) 06:24:02 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)) 06:24:02 INFO - Cleaning up... 06:24:02 INFO - Return code: 0 06:24:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06: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')]} 06:24:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:24:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06: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')]} 06:24:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:24:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:24:02 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 0x7f465d725f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fc87b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2057790>, '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 0x2058690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2058b20>, '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': '32c5991c409366f7fec8a718000001d2-1477920206.148172-952636325', '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 06:24:02 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 06:24:02 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 06:24:02 INFO - Using env: {'DISPLAY': ':0', 06:24:02 INFO - 'HOME': '/home/cltbld', 06:24:02 INFO - 'LANG': 'en_US.UTF-8', 06:24:02 INFO - 'LANGUAGE': 'en_US:en', 06:24:02 INFO - 'LOGNAME': 'cltbld', 06:24:02 INFO - 'MAIL': '/var/mail/cltbld', 06:24:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:24:02 INFO - 'MOZ_NO_REMOTE': '1', 06:24:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:24:02 INFO - 'NO_EM_RESTART': '1', 06:24:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:24:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:24:02 INFO - 'PWD': '/builds/slave/test', 06:24:02 INFO - 'SHELL': '/bin/bash', 06:24:02 INFO - 'SHLVL': '1', 06:24:02 INFO - 'TERM': 'linux', 06:24:02 INFO - 'TMOUT': '86400', 06:24:02 INFO - 'USER': 'cltbld', 06:24:02 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1477920206.148172-952636325', 06:24:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:24:02 INFO - '_': '/tools/buildbot/bin/python'} 06:24:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:24:03 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:24:03 INFO - Cleaning up... 06:24:03 INFO - Return code: 0 06:24:03 INFO - Running post-action listener: _resource_record_post_action 06:24:03 INFO - Running post-action listener: _start_resource_monitoring 06:24:03 INFO - Starting resource monitoring. 06:24:03 INFO - [mozharness: 2016-10-31 13:24:03.223685Z] Finished create-virtualenv step (success) 06:24:03 INFO - [mozharness: 2016-10-31 13:24:03.224146Z] Running install step. 06:24:03 INFO - Running pre-action listener: _resource_record_pre_action 06:24:03 INFO - Running main action method: install 06:24:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:24:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:24:03 INFO - Reading from file tmpfile_stdout 06:24:03 INFO - Detecting whether we're running mozinstall >=1.0... 06:24:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:24:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:24:03 INFO - Reading from file tmpfile_stdout 06:24:03 INFO - Output received: 06:24:03 INFO - Usage: mozinstall [options] installer 06:24:03 INFO - Options: 06:24:03 INFO - -h, --help show this help message and exit 06:24:03 INFO - -d DEST, --destination=DEST 06:24:03 INFO - Directory to install application into. [default: 06:24:03 INFO - "/builds/slave/test"] 06:24:03 INFO - --app=APP Application being installed. [default: firefox] 06:24:03 INFO - mkdir: /builds/slave/test/build/application 06:24:03 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'] 06:24:03 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 06:24:20 INFO - Reading from file tmpfile_stdout 06:24:20 INFO - Output received: 06:24:20 INFO - /builds/slave/test/build/application/firefox/firefox 06:24:20 INFO - Running post-action listener: _resource_record_post_action 06:24:20 INFO - [mozharness: 2016-10-31 13:24:20.476773Z] Finished install step (success) 06:24:20 INFO - [mozharness: 2016-10-31 13:24:20.477048Z] Running run-tests step. 06:24:20 INFO - Running pre-action listener: _resource_record_pre_action 06:24:20 INFO - Running main action method: run_tests 06:24:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:24:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:24:20 INFO - Python 2.7.3 06:24:20 INFO - Return code: 0 06:24:20 INFO - grabbing minidump binary from tooltool 06:24:20 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')]} 06:24:20 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 0x2057790>, '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 0x2058690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2058b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:24:20 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 06:24:20 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 06:24:20 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 06:24:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:24:20 INFO - Return code: 0 06:24:20 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:24:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:24:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:24:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:24:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:24:20 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-008', '--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 06:24:20 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-008 --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 06:24:20 INFO - Using env: {'DISPLAY': ':0', 06:24:20 INFO - 'HOME': '/home/cltbld', 06:24:20 INFO - 'LANG': 'en_US.UTF-8', 06:24:20 INFO - 'LANGUAGE': 'en_US:en', 06:24:20 INFO - 'LOGNAME': 'cltbld', 06:24:20 INFO - 'MAIL': '/var/mail/cltbld', 06:24:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:24:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:24:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:24:20 INFO - 'MOZ_NO_REMOTE': '1', 06:24:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:24:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:24:20 INFO - 'NO_EM_RESTART': '1', 06:24:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:24:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:24:20 INFO - 'PWD': '/builds/slave/test', 06:24:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:24:20 INFO - 'SHELL': '/bin/bash', 06:24:20 INFO - 'SHLVL': '1', 06:24:20 INFO - 'TERM': 'linux', 06:24:20 INFO - 'TMOUT': '86400', 06:24:20 INFO - 'USER': 'cltbld', 06:24:20 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1477920206.148172-952636325', 06:24:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:24:20 INFO - '_': '/tools/buildbot/bin/python'} 06:24:20 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-008', '--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 06:24:20 INFO - mozversion application_buildid: 20161029063242 06:24:20 INFO - mozversion application_changeset: 1b170b39ed6bdbde366233ab84594bdaaa960a5a 06:24:20 INFO - mozversion application_display_name: Nightly 06:24:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:24:20 INFO - mozversion application_name: Firefox 06:24:20 INFO - mozversion application_remotingname: firefox 06:24:20 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 06:24:20 INFO - mozversion application_vendor: Mozilla 06:24:20 INFO - mozversion application_version: 52.0a1 06:24:20 INFO - mozversion platform_buildid: 20161029063242 06:24:20 INFO - mozversion platform_changeset: 1b170b39ed6bdbde366233ab84594bdaaa960a5a 06:24:20 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 06:24:20 INFO - mozversion platform_version: 52.0a1 06:24:20 INFO - using testdate: 1477920260 06:24:20 INFO - actual date: 1477920260 06:24:20 INFO - starting webserver on 'localhost:54427' 06:24:20 INFO - SUITE-START | Running 2 tests 06:24:20 INFO - TEST-START | dromaeo_css 06:24:20 INFO - operating with platform_type : linux_ 06:24:20 INFO - Initialising browser for dromaeo_css test... 06:24:20 INFO - TEST-INFO | started process 6581 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSXfgd5/profile http://localhost:54427/getInfo.html) 06:24:25 INFO - PROCESS | 6581 | __metrics Screen width/height:1600/1200 06:24:25 INFO - PROCESS | 6581 | colorDepth:24 06:24:25 INFO - PROCESS | 6581 | Browser inner width/height: 1024/697 06:24:25 INFO - PROCESS | 6581 | __metrics 06:24:25 INFO - PROCESS | 6581 | 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" 06:24:25 INFO - PROCESS | 6581 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 205: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:24:26 INFO - PROCESS | 6581 | console.error: PushService: 06:24:26 INFO - PROCESS | 6581 | stateChangeProcessEnqueue: Error transitioning state 06:24:26 INFO - PROCESS | 6581 | UnknownError 06:24:27 INFO - TEST-INFO | 6581: exit 0 06:24:27 INFO - Browser initialized. 06:24:27 INFO - Running cycle 1/1 for dromaeo_css test... 06:24:27 INFO - TEST-INFO | started process 6662 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSXfgd5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:24:39 INFO - PROCESS | 6662 | RSS: Main: 174313472 06:24:39 INFO - PROCESS | 6662 | 06:25:30 INFO - PROCESS | 6662 | 1477920330494 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] 06:27:40 INFO - PROCESS | 6662 | Cycle 1(1): loaded http://localhost:54427/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54427/tests/dromaeo/cssquery-ext.html) 06:27:42 INFO - PROCESS | 6662 | RSS: Main: 318685184 06:27:42 INFO - PROCESS | 6662 | 06:30:44 INFO - PROCESS | 6662 | Cycle 1(1): loaded http://localhost:54427/tests/dromaeo/cssquery-ext.html (next: http://localhost:54427/tests/dromaeo/cssquery-jquery.html) 06:30:45 INFO - PROCESS | 6662 | RSS: Main: 273739776 06:30:45 INFO - PROCESS | 6662 | 06:33:47 INFO - PROCESS | 6662 | Cycle 1(1): loaded http://localhost:54427/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54427/tests/dromaeo/cssquery-mootools.html) 06:33:47 INFO - PROCESS | 6662 | RSS: Main: 262922240 06:33:47 INFO - PROCESS | 6662 | 06:36:50 INFO - PROCESS | 6662 | Cycle 1(1): loaded http://localhost:54427/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54427/tests/dromaeo/cssquery-prototype.html) 06:36:50 INFO - PROCESS | 6662 | RSS: Main: 228089856 06:36:50 INFO - PROCESS | 6662 | 06:39:53 INFO - PROCESS | 6662 | Cycle 1(1): loaded http://localhost:54427/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54427/tests/dromaeo/cssquery-yui.html) 06:39:54 INFO - PROCESS | 6662 | RSS: Main: 215547904 06:39:54 INFO - PROCESS | 6662 | 06:42:56 INFO - PROCESS | 6662 | Cycle 1(1): loaded http://localhost:54427/tests/dromaeo/cssquery-yui.html (next: http://localhost:54427/tests/dromaeo/cssquery-dojo.html) 06:42:56 INFO - PROCESS | 6662 | RSS: Main: 318558208 06:42:56 INFO - PROCESS | 6662 | 06:42:56 INFO - PROCESS | 6662 | __start_tp_report 06:42:56 INFO - PROCESS | 6662 | _x_x_mozilla_page_load 06:42:56 INFO - PROCESS | 6662 | _x_x_mozilla_page_load_details 06:42:56 INFO - PROCESS | 6662 | |i|pagename|runs| 06:42:56 INFO - PROCESS | 6662 | |0;dojo.html;2899.57956096366;2911.315840777418;2960.5707172459993;2965.822050676958;2971.643402791664;5018.297438358623;5099.923501147486;5139.25480805283;5226.660267082637;5297.178937264721;5135.460776618457;5207.297014902987;5296.920546191801;5301.5228629423345;5344.9198262026;4723.126221648989;4725.362076119732;4763.4998325175875;4770.332153498513;4820.325154478376;4759.690620109699;4807.927881081787;4894.926576101361;4897.975510122445;4953.083679519301;4655.674102812804;4816.614670826326;4831.082094402088;4844.297576851354;4934.0625281196635;4666.719996800203;4673.509281525425;4681.250999840044;4681.789319480631;4750.239961606127;4660;4661.09108723799;4663.836765713218;4694.835680751192;4723.834665786681;5069.417017043051;5107.361579802525;5113.079645663779;5119.436861945183;5171;5382.407935127133;5428.294321738188;5447.645903016291;5471.8084867029465;5566.860828479321;5612.494875461228;5631.718414079321;5644.435556444364;5693.7437815298;5706.71466426677;5237.816676416307;5238.711870847102;5238.790448382022;5241.344831896051;5307.991481618557;5455.618106732491;5489.807856725075;5590.580706447033;5644.125160600113;5708.257926469532;5425.37608175057;5425.782968681208;5439;5486.067368547357;5503.7798488060025;5460.481254280837;5509.779608815683;5510.9448905511235;5516.310461192351;5544.695041772741;5410.1343784995;5452.04589196889;5463.836084917459;5497.532709719639;5564.10974244119;5552.167174923713;5580.1629755537;5585.3297604287745;5637.802676906289;5646.520045796154;4329.761863097497;4331.5451877552405;4333.111712099012;4339.500957389941;4388.9122217556105;3776.773393596338;3781.621837816196;3853.056001279648;3882.5729169791302;3894.883153505399;5221.164613661796;5237.16205407133;5339;5359.169328754049;5434.972825135849;5601.887962240814;5615.073512870331;5622.803201887914;5624.521915637217;5626.240457538262;5305.230741542455;5338.813141540028;5341.919871201935;5355.169948657965;5407.107827208545;4667.416572928384;4685.344051832746;4809;4876.390451193601;4887.975560122248;5864.120381942743;5866.2373891393845;5871.266091738447;5886.264216972879;5929.258842644669;5641.323041234914;5642;5647.604667673388;5650.463205995424;5650.604457687922;5519.144532597454;5575.804846830504;5810.535157187331;5836.387179346108;5849.970750146222;5565.443455654402;5568.192612071308;5581.469760372758;5633.352164501135;5645;5623;5683;5689.032864413142;5692.886142277214;5693.886122277614;5278.4193738687945;5315.495027972336;5425.972870135624;5465.72671366438;5530.668159910419;5492.5331346835965;5500.7524661391135;5511.200875872896;5552.444755524577;5558.805441809517;5452.890942181055;5459;5465.344158700981;5466.644668096561;5472.726363681721;5223.660462069954;5251.186066159751;5491.423400543045;5512.862178445571;5569.220309156803;5371.462853714597;5400;5423.864403389947;5449.809256675997;5458.263134476795 06:42:56 INFO - PROCESS | 6662 | |1;ext.html;547.8051626778798;588.698975264665;609.2840911928486;618.8360084577588;632.1939527102946;31153.68846311539;40587.79706101469;41253.79373103131;41511.99999999996;41547.58452415482;42346;42693.78653106738;42807.35788963168;42923.78538107305;43027.78486107565;8082.71710490133;8174.427790054669;8837.248833849115;8994.86507702385;9001;10443.164546836235;10689;10696.572137114506;11072.169587280945;11076.723081922935;10861.619843305485;10930.617428390007;10930.726731831728;10934.179936504754;10935.671929842118;8095.6761729530745;8329.625166867505;10462.895371046268;10706.946465267663;10763.13894888411;10342.379457232515;10629.73425664357;10639.521221545048;10639.946800266027;10642.042216200502;40542.39186412206;40807.387889181686;40836.795816021026;40885.79557102225;40893.38659920103;3312.635610082889;3339.716124129452;3340.9331813363838;3355.9832200839082;3448.379291727488;30685;30977.845110774528;30982.380352392825;31720;32115.678843211736;4299.91400171998;4382.846600368972;4441.333799930037;4465.642748580106;4469.463664360298;291612;292887;295252;295693;296724;32432.189195270308;54134.45865541373;54327.72836135873;54335.45664543383;54344;33129;35247.29505409929;35371;35375.82312088423;35477.1130721734;12745.36273186337;12773.381456801333;12802.80795788064;12807.231566106064;12858.485660573659;9382.5308734563;9529.142377186086;10194.694159175237;10568.841467377995;10599.735006624896;7993.32056775169;8051.879221811678;8135.79660508492;8186.2632363087605;8191.303739182117;3165.9050228493184;3185.7451403887635;3195.201199700075;3208.9197770055466;3223.09753269085;902.9774255643662;932.7994481186578;973.5667627905514;978.3885071830106;980.8675828763169;29956.550651739806;31610.525842111925;31655.20861978469;32087.197820054684;32395.838020810217;1025.374521541859;1046.586598293685;1078.5200585739428;1105.3312745788842;1118.9384583847966;15975.840241597436;16607;16668.249928753234;16727.749083763752;16924.30294660685;151264;152310;152691;153012;154910;55705;55780.44219557834;56055.43944560502;56307.71846140743;56389.71805140948;1164.0920082335792;1227.5764861122898;1280.0911352939518;1320.39261939507;1339.1161833190047;28749;32026.19934501656;32288.83855580707;34208.486872697424;34348.31303373969;51684.741576291875;51904.74047629889;52305;52317.7384113077;52420.21369679534;417010;420511.61558343755;421485;424208;426315;23986.160484382963;24603.384915377257;26434;27356.863215683796;27808.304792380353;43532.56467435285;43568.56431435645;43682.126357472036;44284;44689;37124;37612.2477550453;38005.809970949966;38112.42831357476;38185.80907095447;37655;37873.431898522096;37885.431718523694;38011.42982855204;38034.42948355832;39238.607613924636;39685.60314396819;40324;42105.1578968425;42449.78775106105;33032.66967330296;35736.642633573334;36234.27531449303;36437;36594.26811463702;27882;27923.720762792113;28089.57865631976;28189.295267618472;28193.71806281911 06:42:56 INFO - PROCESS | 6662 | |2;jquery.html;370.2132967444181;374.5935659809107;376.39964257010075;396.4687318992549;401.36984933654156;17740.733888991675;18831.905840470812;19060.142293596786;19335.613287734253;19399.806001939978;15428;15429.845701542981;15730.37078516858;15736.213189340517;19219.519512012208;5408.242846001573;5652.915206271889;5655.943440565604;5660.688662123582;5663.461971112758;5462.863428414282;5497.120460726284;5555.250041244421;5580.888382232353;5587.916181257264;5550.77796888124;5551.333839939192;5555.611107222496;5558.221848941132;5560.916586251189;5345.385280692712;5488.7530061147345;5504.256925315111;5512;5518.420565840569;4853.223484242504;4854.68444551103;4860.319555262231;4873.561379475828;4873.829415970459;22212.11151553952;22266;22315.218967336226;22548.774512254833;22668.886655566617;2241.4396400899777;2362.267697013914;2374.5488357212075;2533.3793220660873;2973.3755911258663;14184.929075354557;14255.50105746294;15048.473303434328;15562.22188890551;16286.069910789174;1930.6474163832318;2027.908744106504;2036.2364113457454;2061.5155438471947;2093.6336141175234;88160.55919720425;88969.55515222382;89149.55425222832;90148.54925725395;93083;16583.253753581117;17257.56856078583;17301.307947682202;17377.304907803547;17838.643227135384;29713.405731885243;29793.40413191724;29826.85086574553;29879.10362689123;29894.701052989192;8266.214709602578;8538.146185381413;8644.740657780276;8671.349648776368;8823.514706691194;7106.680199391039;7116.537425067354;7165.390941769903;7293.854122917618;7386.667599958015;8467.66129354819;8591.883055202783;8824.647014119491;8829.867551986725;8854.203121718947;3240.8379581020854;3442.1566716154703;3453.689167974894;3505.631908649606;3541.557305336833;908.8545832666874;964.7781010367655;972.363102168081;1015.8019186258756;1056.4717641179411;18913.243470261037;19363.612727745367;19466.70799938002;19542.804571954097;19801.60396792056;925.2181906289175;929.1405449958761;931.5421365562872;947.545178314413;996.028871849955;8384.8742268866;10231.334963227366;10658.919557298601;10733.570657173626;10794.676159715222;397820;401073;407624;409478;414709;79950;81015;83917.58041209755;85152.57423712965;88309;1000.2698030437821;1002;1003.513296051429;1006.0693858181153;1038.1020417339098;16476.67046659084;16582.834171658127;17005.48983530496;17337.479875603753;17590.824091758917;38965;39161.804190978866;40695.59304407037;41397.927404155904;42042.369364460166;52076.47923520868;54358;54377.184342234104;55955;56602.7169864148;7532.096148462219;7699.730509432367;7778.611069446618;7992.800179995546;8141.959290203748;11044.282121662067;12640.74718505643;12723.427445765148;12729;13333;11269.323840569592;11491;11565.265210218535;11688.428545719928;11720.70698232551;11120.443977800916;11348;11382.260153090023;11401.315921044765;11755.118366122746;11425;11440.656780296604;11552.075833933097;11992.280463172237;12091.879081209076;7610.505317154367;7634.656440460081;7687.923120768721;7713.4600577959;8006.559639219899;8878.5116818573;11096.223264371416;11381.772364552828;11408.144389170679;11624.360660163773 06:42:56 INFO - PROCESS | 6662 | |3;mootools.html;1293.1400618588639;1449.3043339197181;1491.6121808329835;1616.6039320366513;1748.6065635232067;7451.701931922724;7862.528248305099;8069.959650201756;8145.14475980021;8157.306628936548;8225.218604232588;8371.58142092896;8372.372072094588;8536.530490823003;8576.0995095515;2291.518781055976;2316.4093156245135;2330.8951097200666;2333.4516388648653;2334.9533009339802;2263.343630347197;2339.122828939148;2357.3988632898586;2358.3750306168877;2364.7398786133513;2246.146464343555;2298.804601608857;2329.5573840970246;2337.614293641547;2338.847974881627;2248.5727711734717;2249.538844536882;2261.6494443361307;2268.1494439585153;2272.5682120397155;2285.462916214688;2305.3545007397956;2306.7577904319974;2317.501737126509;2330.149495434171;8434.325253979667;8495.660173593049;8527.147285271423;8530.146985301482;8532.530710810903;5097.821576244851;5238.345206849144;5247.239150323182;5312.1766126250495;5315.282436871012;3368.2589830237307;3389.7288216942584;3406.0463070340343;3453.188500702333;3461.7230621550216;1085.782843431309;1104.4036220440953;2151.3223334649692;2152.623290924082;2164.8159906407973;11756.177067605271;11838.408079595985;11962.102842286864;11963.88036119645;11965.820512692317;4411.404460397805;4538.773061346919;4641;4654.883627909329;4683.297505374221;10141.746456338504;10157.847632285522;10164.136048435817;10174.389536627827;10176.135028522658;5299.920501192485;5301.231321458444;5307.52232299095;5307.814226502054;5309.123994540934;4240.321548552217;4276.935845962313;4828.46886842447;4828.95171048285;4850.054239423349;3756.3426400379826;3863.9613603864163;3887.1642596841816;3944.3886197639413;3948.9605103948593;1241.2180326394314;1254.2850575172065;1271.7583659104741;1280.5454063807401;1300.4083142170289;837;872.8036191856781;886.9423487473293;898.6944438890808;914.2274777812737;5320.574354051744;5524.281843360337;5542.251796007487;5587.106063029895;5762.683052432073;884.5311984648147;893.1604291965532;933.2813733425224;933.6125507914276;959.5873774277128;3592.4072528033103;3778.4332350147147;3845.615438456188;3849.711271654637;3889.5138107736534;9898.80202395948;10260.281780275309;10267.640632577974;10278.537465814057;10280.485975701185;9963.202943764481;10116.393016419039;10235.48822558884;10237.48812559369;10287.43419111956;7799.571023593757;8110.63502142405;8124.065732440845;8136.796580085545;8137.308328792119;5291.100512912737;5308.708021058725;5347.812826551052;5559.16612508127;5593.545678123636;9452.43285402878;9457.810843782949;9486.098820612031;9524.285678574273;9596.424214547149;9337.673181438617;9475.47884866339;9702.126808586978;9810.509474526103;9824.789422379907;6878.931210687829;7072.752453664097;7349.412047036331;7597.848043038997;7760.417968652487;8025.9197408025175;8400.159984001795;8410.537420441935;8422.578871056545;8426.915730842858;7095.858082838211;7109.82225444368;7346.52247603904;7542.208068152984;7748;6674.699638516181;6777.423918966943;6821.2155602106395;6948.444124469929;7017.7192912282935;6237.781677641261;6256.186695729526;6308.52686048539;6311.779087731908;6312.242530896322;4709.552592503706;4787.904241915212;4795.592374648194;4805.783739731791;4839.056384005085;4634.490206077397;4771.73755443454;4823.5658790709;4826.0830442217275;5135.15269980449 06:42:56 INFO - PROCESS | 6662 | |4;prototype.html;321.52900480302606;322.67732267732265;330.7238455889332;334.76900938352543;342.9657034296572;5205.609579281555;5249.16279302244;5260.447652996438;5260.842174734764;5260.947390526103;4920.630952678554;5020.573251273637;5031.672941258816;5159.277701121846;5212;4113.506379234481;4114.917701645965;4116.588341165874;4126.814293356806;4130.401091841682;4125.566815484376;4126.401671757593;4137.379393091031;4151.771652559108;4175.66594672427;3827.655511004009;3902.2780785554764;4064.9187016259657;4078.89802754932;4112.958870411302;4077.429159917614;4089.407035979781;4091.2226676931587;4093.4269202311702;4093.9385909211387;3612.729045321585;3623.420252759572;3629.1290090378384;3630.3828349180703;3637.508936293593;4809.975950120262;5052.393712754493;5055.494450554952;5062.038212739568;5070.923936140961;4585.197590421662;4604.493505714368;4606.654500912445;4606.930896036562;4609.67732258742;5361.5978801589645;5371.516563509303;5385.5459026062745;5409.323109835964;5425.511703946624;3826.8086595670106;3915.941260881089;3915.9804200979097;3923.2545816295096;3925.489686340786;5385.892282154374;5518.310211223597;5520.006398848206;5552.666839989573;5552.833414997556;3934.3311637021775;3946.9210615787524;3949.4273330366937;3959.4360227709894;3960.762354258696;3979.85432826406;3997.84008639657;4018.216447792711;4025.3156963316305;4036.7577945322787;4537.4328208973875;4581.129585378767;4589.632829373642;4605.838795642204;4630.259158534618;5423.864403389868;5426.647267927572;5441.5102640762525;5448.155535891943;5486.890262194734;1392.1090502078678;1406.0579411794122;1406.226575383535;1408.7675533537056;1410.7796755806153;898.7887846356101;904.7187290574301;957.7653474898694;963.210167662524;971.9562619682131;5219.530242278213;5247.790088396421;5254.448282930313;5283.735813209324;5292.438730574489;5437.592180586393;5500.834974950758;5506.339239291311;5526.751296191681;5550.750216240279;5102.311187989648;5234.607404444606;5263.078961181778;5297.231901374279;5303.708296043677;2896.2904088498453;2925;2935.7211064948797;2944.955825662617;2954.630671166104;5660.46212132558;5724.198612194296;5770.971145144332;5779.739911703983;5801.216835727208;5578.972105139448;5583.637063590853;5593.776248950077;5606;5610.49505544503;5640.266765320482;5715.199872017921;5719.342275638355;5723.170140329629;5778.971105144531;5263.394709608444;5489.972550137224;5490.752916118864;5515;5544.556435485071;5485.341758988947;5491.478309560585;5498.5876059294915;5500.367457742251;5504.669719816824;5687.630304030225;5808.709564521672;5834.395541226197;5837.978353788155;5854.619449735754;3904.9414258785573;3946.2304850555015;3952.7035472339116;3956.70511103565;3972.960270397259;5441.755121019484;5504.4770746778995;5555.194496798023;5567.383329834971;5589.496945274945;5263.315738963495;5465.207544905887;5471.72641367922;5473.151661492475;5480.287562616834;5365.785368585213;5371.704556249444;5374.328208973879;5397.8920421590565;5404.891902162013;5151.974240128776;5294.23233631129;5334.839954801362;5388.73056347189;5404.43253458397;5285.471452854684;5422.62041657096;5464.508194262536;5466.34403871538;5471.835844924659;5332.30680011596;5336.226247194213;5341.359036915595;5343.2597181972;5360.973195133999 06:42:56 INFO - PROCESS | 6662 | |5;yui.html;726.989095163573;727.9636018199088;728.9976282611412;769.6228847864548;813.4346629092781;14339.928300358497;15086.170260635661;15086.54740357791;15106.924465377686;15214.54356369308;12638.431270592822;12809.295488748116;12814.871851281485;12816.102872798907;12829.679258018554;640.3852301790287;656.9211694596655;658.7266284491955;659.294554826336;659.508666043798;764.8011517005591;781.2968328504335;785.332467402706;788.3377962511489;791.4815795653856;834.2116699718769;835.3567752830317;837.0123254559617;837.3175861672747;837.417994493827;831.6673330667721;832.5004997001781;832.5837081459271;832.7709879783077;832.7834762961613;498.28187238613276;506.55170174395926;589.8908701890122;606.6693651959692;615.8244900203465;12691.175073620185;12721.982241420757;12722;12724.872751272462;12744.299063551502;13127.277999710011;13441.529546465827;13504.729905401935;13593.456261749518;13783.241921694304;12288.569900053455;12352.505899763999;12436.875631243662;12640.241585504898;12829.615111546575;4227.196832601796;4244.193603215379;4262.508122157251;4281.850135245282;4314.482262128533;58670;60179;60697;60863;60978.695106524625;10448.634297799541;10674.092702120251;10838;10915.945420273007;10987.175961802897;20059.197632094554;20233.595328093357;20437.89781051085;20467.28364507265;20525.692114618294;7441.404687624977;7566.432517561205;7852.332551733052;7916.129225785159;7946.721864734822;4577.0845830833305;4586.289125185602;4597.793099310539;4614.146382919103;4620.53794620542;3246.8538915748377;3319.6016478022793;3327.8336083195745;3328.467445208755;3331.217163966466;574.7269054579217;585.3297973819953;589.3163929841363;594.7888499582673;596.4095545410013;510.6170372220834;547.8329109621603;624.753222477119;658.664081318531;685.2604633430269;8714.346424018224;8717.259032982141;8838.116188381111;8937.157022480396;9120.771980700536;662.483263054818;663.2770280394393;678.9388954994074;691.2914262880588;692.0449779304528;4181.540030596632;4334.804933777988;4358.997430590982;4366.214081465367;4421.38100665907;53850;53936.73031634895;69991.3000869995;71858.28141718516;73457.26542734505;55690;69143.3085669147;70702;72499.83751381087;73433.26566734372;64294.678526607066;64388;66165.33834661591;66312;66493.667531663;9437.292203084933;9717;9872;9883;9939.204863611038;41112.58887411088;41877.37183942182;44436.77781611071;45690.543094569955;48202.75898620485;41641.37537936873;44503.10993780171;57618.7119064402;65366.67316663386;70861.1946326806;13330.600081997556;13635.931820340835;13652.112612680145;13976;14226;14015.159090454197;14213.715725685635;14318.57044288673;14549.054311469721;15311.846881531043;13304.46782128704;13607.455701771818;13643.317834108453;13723.656908577366;13812.378442970292;12842.935785321013;13020.609381718563;13244.735105298032;13563.254021028939;13646.249456279602;13442.46230150783;13592.252426116658;13605.319734013457;13734.038617296694;13966.231857247949;10571.841422378517;10695.839562406414;10955.287906286067;11125.221234513507;11302.378369189773;10971.396573188551;11316.304136870602;11472.770544588895;11493.023093037185;11588.304701717923 06:42:56 INFO - PROCESS | 6662 | __end_tp_report 06:42:56 INFO - PROCESS | 6662 | __start_cc_report 06:42:56 INFO - PROCESS | 6662 | _x_x_mozilla_cycle_collect,1360 06:42:56 INFO - PROCESS | 6662 | __end_cc_report 06:42:56 INFO - PROCESS | 6662 | __startTimestamp1477921376920__endTimestamp 06:42:56 INFO - PROCESS | 6662 | 06:42:56 INFO - PROCESS | 6662 | ------- Summary: start ------- 06:42:56 INFO - PROCESS | 6662 | Number of tests: 6 06:42:56 INFO - PROCESS | 6662 | 06:42:56 INFO - PROCESS | 6662 | [#0] dojo.html Cycles:165 Average:5189.98 Median:5423.86 stddev:595.65 (11.0%) stddev-sans-first:569.73 06:42:56 INFO - PROCESS | 6662 | Values: 2899.6 2911.3 2960.6 2965.8 2971.6 5018.3 5099.9 5139.3 5226.7 5297.2 5135.5 5207.3 5296.9 5301.5 5344.9 4723.1 4725.4 4763.5 4770.3 4820.3 4759.7 4807.9 4894.9 4898.0 4953.1 4655.7 4816.6 4831.1 4844.3 4934.1 4666.7 4673.5 4681.3 4681.8 4750.2 4660.0 4661.1 4663.8 4694.8 4723.8 5069.4 5107.4 5113.1 5119.4 5171.0 5382.4 5428.3 5447.6 5471.8 5566.9 5612.5 5631.7 5644.4 5693.7 5706.7 5237.8 5238.7 5238.8 5241.3 5308.0 5455.6 5489.8 5590.6 5644.1 5708.3 5425.4 5425.8 5439.0 5486.1 5503.8 5460.5 5509.8 5510.9 5516.3 5544.7 5410.1 5452.0 5463.8 5497.5 5564.1 5552.2 5580.2 5585.3 5637.8 5646.5 4329.8 4331.5 4333.1 4339.5 4388.9 3776.8 3781.6 3853.1 3882.6 3894.9 5221.2 5237.2 5339.0 5359.2 5435.0 5601.9 5615.1 5622.8 5624.5 5626.2 5305.2 5338.8 5341.9 5355.2 5407.1 4667.4 4685.3 4809.0 4876.4 4888.0 5864.1 5866.2 5871.3 5886.3 5929.3 5641.3 5642.0 5647.6 5650.5 5650.6 5519.1 5575.8 5810.5 5836.4 5850.0 5565.4 5568.2 5581.5 5633.4 5645.0 5623.0 5683.0 5689.0 5692.9 5693.9 5278.4 5315.5 5426.0 5465.7 5530.7 5492.5 5500.8 5511.2 5552.4 5558.8 5452.9 5459.0 5465.3 5466.6 5472.7 5223.7 5251.2 5491.4 5512.9 5569.2 5371.5 5400.0 5423.9 5449.8 5458.3 06:42:56 INFO - PROCESS | 6662 | 06:42:56 INFO - PROCESS | 6662 | [#1] ext.html Cycles:180 Average:45644.78 Median:35309.15 stddev:82073.18 (232.4%) stddev-sans-first:82233.57 06:42:56 INFO - PROCESS | 6662 | Values: 547.8 588.7 609.3 618.8 632.2 31153.7 40587.8 41253.8 41512.0 41547.6 42346.0 42693.8 42807.4 42923.8 43027.8 8082.7 8174.4 8837.2 8994.9 9001.0 10443.2 10689.0 10696.6 11072.2 11076.7 10861.6 10930.6 10930.7 10934.2 10935.7 8095.7 8329.6 10462.9 10706.9 10763.1 10342.4 10629.7 10639.5 10639.9 10642.0 40542.4 40807.4 40836.8 40885.8 40893.4 3312.6 3339.7 3340.9 3356.0 3448.4 30685.0 30977.8 30982.4 31720.0 32115.7 4299.9 4382.8 4441.3 4465.6 4469.5 291612.0 292887.0 295252.0 295693.0 296724.0 32432.2 54134.5 54327.7 54335.5 54344.0 33129.0 35247.3 35371.0 35375.8 35477.1 12745.4 12773.4 12802.8 12807.2 12858.5 9382.5 9529.1 10194.7 10568.8 10599.7 7993.3 8051.9 8135.8 8186.3 8191.3 3165.9 3185.7 3195.2 3208.9 3223.1 903.0 932.8 973.6 978.4 980.9 29956.6 31610.5 31655.2 32087.2 32395.8 1025.4 1046.6 1078.5 1105.3 1118.9 15975.8 16607.0 16668.2 16727.7 16924.3 151264.0 152310.0 152691.0 153012.0 154910.0 55705.0 55780.4 56055.4 56307.7 56389.7 1164.1 1227.6 1280.1 1320.4 1339.1 28749.0 32026.2 32288.8 34208.5 34348.3 51684.7 51904.7 52305.0 52317.7 52420.2 417010.0 420511.6 421485.0 424208.0 426315.0 23986.2 24603.4 26434.0 27356.9 27808.3 43532.6 43568.6 43682.1 44284.0 44689.0 37124.0 37612.2 38005.8 38112.4 38185.8 37655.0 37873.4 37885.4 38011.4 38034.4 39238.6 39685.6 40324.0 42105.2 42449.8 33032.7 35736.6 36234.3 36437.0 36594.3 27882.0 27923.7 28089.6 28189.3 28193.7 06:42:56 INFO - PROCESS | 6662 | 06:42:56 INFO - PROCESS | 6662 | [#2] jquery.html Cycles:180 Average:27155.04 Median:372.40 stddev:67403.63 (18099.6%) stddev-sans-first:67562.71 06:42:56 INFO - PROCESS | 6662 | Values: 370.2 374.6 376.4 396.5 401.4 17740.7 18831.9 19060.1 19335.6 19399.8 15428.0 15429.8 15730.4 15736.2 19219.5 5408.2 5652.9 5655.9 5660.7 5663.5 5462.9 5497.1 5555.3 5580.9 5587.9 5550.8 5551.3 5555.6 5558.2 5560.9 5345.4 5488.8 5504.3 5512.0 5518.4 4853.2 4854.7 4860.3 4873.6 4873.8 22212.1 22266.0 22315.2 22548.8 22668.9 2241.4 2362.3 2374.5 2533.4 2973.4 14184.9 14255.5 15048.5 15562.2 16286.1 1930.6 2027.9 2036.2 2061.5 2093.6 88160.6 88969.6 89149.6 90148.5 93083.0 16583.3 17257.6 17301.3 17377.3 17838.6 29713.4 29793.4 29826.9 29879.1 29894.7 8266.2 8538.1 8644.7 8671.3 8823.5 7106.7 7116.5 7165.4 7293.9 7386.7 8467.7 8591.9 8824.6 8829.9 8854.2 3240.8 3442.2 3453.7 3505.6 3541.6 908.9 964.8 972.4 1015.8 1056.5 18913.2 19363.6 19466.7 19542.8 19801.6 925.2 929.1 931.5 947.5 996.0 8384.9 10231.3 10658.9 10733.6 10794.7 397820.0 401073.0 407624.0 409478.0 414709.0 79950.0 81015.0 83917.6 85152.6 88309.0 1000.3 1002.0 1003.5 1006.1 1038.1 16476.7 16582.8 17005.5 17337.5 17590.8 38965.0 39161.8 40695.6 41397.9 42042.4 52076.5 54358.0 54377.2 55955.0 56602.7 7532.1 7699.7 7778.6 7992.8 8142.0 11044.3 12640.7 12723.4 12729.0 13333.0 11269.3 11491.0 11565.3 11688.4 11720.7 11120.4 11348.0 11382.3 11401.3 11755.1 11425.0 11440.7 11552.1 11992.3 12091.9 7610.5 7634.7 7687.9 7713.5 8006.6 8878.5 11096.2 11381.8 11408.1 11624.4 06:42:56 INFO - PROCESS | 6662 | 06:42:56 INFO - PROCESS | 6662 | [#3] mootools.html Cycles:180 Average:5553.58 Median:4844.56 stddev:3088.63 (63.8%) stddev-sans-first:3080.70 06:42:56 INFO - PROCESS | 6662 | Values: 1293.1 1449.3 1491.6 1616.6 1748.6 7451.7 7862.5 8070.0 8145.1 8157.3 8225.2 8371.6 8372.4 8536.5 8576.1 2291.5 2316.4 2330.9 2333.5 2335.0 2263.3 2339.1 2357.4 2358.4 2364.7 2246.1 2298.8 2329.6 2337.6 2338.8 2248.6 2249.5 2261.6 2268.1 2272.6 2285.5 2305.4 2306.8 2317.5 2330.1 8434.3 8495.7 8527.1 8530.1 8532.5 5097.8 5238.3 5247.2 5312.2 5315.3 3368.3 3389.7 3406.0 3453.2 3461.7 1085.8 1104.4 2151.3 2152.6 2164.8 11756.2 11838.4 11962.1 11963.9 11965.8 4411.4 4538.8 4641.0 4654.9 4683.3 10141.7 10157.8 10164.1 10174.4 10176.1 5299.9 5301.2 5307.5 5307.8 5309.1 4240.3 4276.9 4828.5 4829.0 4850.1 3756.3 3864.0 3887.2 3944.4 3949.0 1241.2 1254.3 1271.8 1280.5 1300.4 837.0 872.8 886.9 898.7 914.2 5320.6 5524.3 5542.3 5587.1 5762.7 884.5 893.2 933.3 933.6 959.6 3592.4 3778.4 3845.6 3849.7 3889.5 9898.8 10260.3 10267.6 10278.5 10280.5 9963.2 10116.4 10235.5 10237.5 10287.4 7799.6 8110.6 8124.1 8136.8 8137.3 5291.1 5308.7 5347.8 5559.2 5593.5 9452.4 9457.8 9486.1 9524.3 9596.4 9337.7 9475.5 9702.1 9810.5 9824.8 6878.9 7072.8 7349.4 7597.8 7760.4 8025.9 8400.2 8410.5 8422.6 8426.9 7095.9 7109.8 7346.5 7542.2 7748.0 6674.7 6777.4 6821.2 6948.4 7017.7 6237.8 6256.2 6308.5 6311.8 6312.2 4709.6 4787.9 4795.6 4805.8 4839.1 4634.5 4771.7 4823.6 4826.1 5135.2 06:42:56 INFO - PROCESS | 6662 | 06:42:56 INFO - PROCESS | 6662 | [#4] prototype.html Cycles:180 Average:4569.47 Median:5262.01 stddev:1331.42 (25.3%) stddev-sans-first:1296.41 06:42:56 INFO - PROCESS | 6662 | Values: 321.5 322.7 330.7 334.8 343.0 5205.6 5249.2 5260.4 5260.8 5260.9 4920.6 5020.6 5031.7 5159.3 5212.0 4113.5 4114.9 4116.6 4126.8 4130.4 4125.6 4126.4 4137.4 4151.8 4175.7 3827.7 3902.3 4064.9 4078.9 4113.0 4077.4 4089.4 4091.2 4093.4 4093.9 3612.7 3623.4 3629.1 3630.4 3637.5 4810.0 5052.4 5055.5 5062.0 5070.9 4585.2 4604.5 4606.7 4606.9 4609.7 5361.6 5371.5 5385.5 5409.3 5425.5 3826.8 3915.9 3916.0 3923.3 3925.5 5385.9 5518.3 5520.0 5552.7 5552.8 3934.3 3946.9 3949.4 3959.4 3960.8 3979.9 3997.8 4018.2 4025.3 4036.8 4537.4 4581.1 4589.6 4605.8 4630.3 5423.9 5426.6 5441.5 5448.2 5486.9 1392.1 1406.1 1406.2 1408.8 1410.8 898.8 904.7 957.8 963.2 972.0 5219.5 5247.8 5254.4 5283.7 5292.4 5437.6 5500.8 5506.3 5526.8 5550.8 5102.3 5234.6 5263.1 5297.2 5303.7 2896.3 2925.0 2935.7 2945.0 2954.6 5660.5 5724.2 5771.0 5779.7 5801.2 5579.0 5583.6 5593.8 5606.0 5610.5 5640.3 5715.2 5719.3 5723.2 5779.0 5263.4 5490.0 5490.8 5515.0 5544.6 5485.3 5491.5 5498.6 5500.4 5504.7 5687.6 5808.7 5834.4 5838.0 5854.6 3904.9 3946.2 3952.7 3956.7 3973.0 5441.8 5504.5 5555.2 5567.4 5589.5 5263.3 5465.2 5471.7 5473.2 5480.3 5365.8 5371.7 5374.3 5397.9 5404.9 5152.0 5294.2 5334.8 5388.7 5404.4 5285.5 5422.6 5464.5 5466.3 5471.8 5332.3 5336.2 5341.4 5343.3 5361.0 06:42:56 INFO - PROCESS | 6662 | 06:42:56 INFO - PROCESS | 6662 | [#5] yui.html Cycles:180 Average:16579.05 Median:25133.81 stddev:20569.74 (81.8%) stddev-sans-first:20593.00 06:42:56 INFO - PROCESS | 6662 | Values: 727.0 728.0 729.0 769.6 813.4 14339.9 15086.2 15086.5 15106.9 15214.5 12638.4 12809.3 12814.9 12816.1 12829.7 640.4 656.9 658.7 659.3 659.5 764.8 781.3 785.3 788.3 791.5 834.2 835.4 837.0 837.3 837.4 831.7 832.5 832.6 832.8 832.8 498.3 506.6 589.9 606.7 615.8 12691.2 12722.0 12722.0 12724.9 12744.3 13127.3 13441.5 13504.7 13593.5 13783.2 12288.6 12352.5 12436.9 12640.2 12829.6 4227.2 4244.2 4262.5 4281.9 4314.5 58670.0 60179.0 60697.0 60863.0 60978.7 10448.6 10674.1 10838.0 10915.9 10987.2 20059.2 20233.6 20437.9 20467.3 20525.7 7441.4 7566.4 7852.3 7916.1 7946.7 4577.1 4586.3 4597.8 4614.1 4620.5 3246.9 3319.6 3327.8 3328.5 3331.2 574.7 585.3 589.3 594.8 596.4 510.6 547.8 624.8 658.7 685.3 8714.3 8717.3 8838.1 8937.2 9120.8 662.5 663.3 678.9 691.3 692.0 4181.5 4334.8 4359.0 4366.2 4421.4 53850.0 53936.7 69991.3 71858.3 73457.3 55690.0 69143.3 70702.0 72499.8 73433.3 64294.7 64388.0 66165.3 66312.0 66493.7 9437.3 9717.0 9872.0 9883.0 9939.2 41112.6 41877.4 44436.8 45690.5 48202.8 41641.4 44503.1 57618.7 65366.7 70861.2 13330.6 13635.9 13652.1 13976.0 14226.0 14015.2 14213.7 14318.6 14549.1 15311.8 13304.5 13607.5 13643.3 13723.7 13812.4 12842.9 13020.6 13244.7 13563.3 13646.2 13442.5 13592.3 13605.3 13734.0 13966.2 10571.8 10695.8 10955.3 11125.2 11302.4 10971.4 11316.3 11472.8 11493.0 11588.3 06:42:56 INFO - PROCESS | 6662 | -------- Summary: end -------- 06:42:56 INFO - PROCESS | 6662 | 06:42:57 INFO - TEST-INFO | 6662: exit 0 06:42:57 INFO - TEST-OK | dromaeo_css | took 1117085ms 06:42:57 INFO - TEST-START | kraken 06:42:57 INFO - operating with platform_type : linux_ 06:42:57 INFO - Initialising browser for kraken test... 06:42:57 INFO - TEST-INFO | started process 6974 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2TwdaR/profile http://localhost:54427/getInfo.html) 06:43:01 INFO - PROCESS | 6974 | __metrics Screen width/height:1600/1200 06:43:01 INFO - PROCESS | 6974 | colorDepth:24 06:43:01 INFO - PROCESS | 6974 | Browser inner width/height: 1024/697 06:43:01 INFO - PROCESS | 6974 | __metrics 06:43:02 INFO - PROCESS | 6974 | 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" 06:43:02 INFO - PROCESS | 6974 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 205: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:43:02 INFO - PROCESS | 6974 | console.error: PushService: 06:43:02 INFO - PROCESS | 6974 | stateChangeProcessEnqueue: Error transitioning state 06:43:02 INFO - PROCESS | 6974 | UnknownError 06:43:03 INFO - TEST-INFO | 6974: exit 0 06:43:03 INFO - Browser initialized. 06:43:03 INFO - Running cycle 1/1 for kraken test... 06:43:03 INFO - TEST-INFO | started process 7058 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2TwdaR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:43:15 INFO - PROCESS | 7058 | RSS: Main: 174182400 06:43:15 INFO - PROCESS | 7058 | 06:43:18 INFO - PROCESS | 7058 | Cycle 1(1): loaded http://localhost:54427/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54427/tests/kraken/driver.html?testName=audio-beat-detection) 06:43:19 INFO - PROCESS | 7058 | RSS: Main: 230834176 06:43:19 INFO - PROCESS | 7058 | 06:43:21 INFO - PROCESS | 7058 | Cycle 1(1): loaded http://localhost:54427/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54427/tests/kraken/driver.html?testName=audio-dft) 06:43:22 INFO - PROCESS | 7058 | RSS: Main: 218337280 06:43:22 INFO - PROCESS | 7058 | 06:43:25 INFO - PROCESS | 7058 | Cycle 1(1): loaded http://localhost:54427/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54427/tests/kraken/driver.html?testName=audio-fft) 06:43:26 INFO - PROCESS | 7058 | RSS: Main: 298946560 06:43:26 INFO - PROCESS | 7058 | 06:43:28 INFO - PROCESS | 7058 | Cycle 1(1): loaded http://localhost:54427/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54427/tests/kraken/driver.html?testName=audio-oscillator) 06:43:28 INFO - PROCESS | 7058 | RSS: Main: 210558976 06:43:28 INFO - PROCESS | 7058 | 06:43:30 INFO - PROCESS | 7058 | Cycle 1(1): loaded http://localhost:54427/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54427/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:43:31 INFO - PROCESS | 7058 | RSS: Main: 213094400 06:43:31 INFO - PROCESS | 7058 | 06:43:34 INFO - PROCESS | 7058 | Cycle 1(1): loaded http://localhost:54427/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54427/tests/kraken/driver.html?testName=imaging-darkroom) 06:43:35 INFO - PROCESS | 7058 | RSS: Main: 250392576 06:43:35 INFO - PROCESS | 7058 | 06:43:38 INFO - PROCESS | 7058 | Cycle 1(1): loaded http://localhost:54427/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54427/tests/kraken/driver.html?testName=imaging-desaturate) 06:43:38 INFO - PROCESS | 7058 | RSS: Main: 248741888 06:43:38 INFO - PROCESS | 7058 | 06:43:41 INFO - PROCESS | 7058 | Cycle 1(1): loaded http://localhost:54427/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54427/tests/kraken/driver.html?testName=json-parse-financial) 06:43:42 INFO - PROCESS | 7058 | RSS: Main: 248418304 06:43:42 INFO - PROCESS | 7058 | 06:43:43 INFO - PROCESS | 7058 | Cycle 1(1): loaded http://localhost:54427/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54427/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:43:44 INFO - PROCESS | 7058 | RSS: Main: 210948096 06:43:44 INFO - PROCESS | 7058 | 06:43:46 INFO - PROCESS | 7058 | Cycle 1(1): loaded http://localhost:54427/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54427/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:43:46 INFO - PROCESS | 7058 | RSS: Main: 219303936 06:43:46 INFO - PROCESS | 7058 | 06:43:48 INFO - PROCESS | 7058 | Cycle 1(1): loaded http://localhost:54427/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54427/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:43:49 INFO - PROCESS | 7058 | RSS: Main: 227291136 06:43:49 INFO - PROCESS | 7058 | 06:43:51 INFO - PROCESS | 7058 | Cycle 1(1): loaded http://localhost:54427/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54427/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:43:52 INFO - PROCESS | 7058 | RSS: Main: 235646976 06:43:52 INFO - PROCESS | 7058 | 06:43:55 INFO - PROCESS | 7058 | Cycle 1(1): loaded http://localhost:54427/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54427/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:43:56 INFO - PROCESS | 7058 | RSS: Main: 233213952 06:43:56 INFO - PROCESS | 7058 | 06:43:57 INFO - PROCESS | 7058 | Cycle 1(1): loaded http://localhost:54427/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54427/tests/kraken/driver.html?testName=ai-astar) 06:43:58 INFO - PROCESS | 7058 | RSS: Main: 283762688 06:43:58 INFO - PROCESS | 7058 | 06:43:58 INFO - PROCESS | 7058 | __start_tp_report 06:43:58 INFO - PROCESS | 7058 | _x_x_mozilla_page_load 06:43:58 INFO - PROCESS | 7058 | _x_x_mozilla_page_load_details 06:43:58 INFO - PROCESS | 7058 | |i|pagename|runs| 06:43:58 INFO - PROCESS | 7058 | |0;ai-astar;105;112;111;112;112;111;111;111;110;110 06:43:58 INFO - PROCESS | 7058 | |1;audio-beat-detection;149;128;122;171;122;125;120;125;153;122 06:43:58 INFO - PROCESS | 7058 | |2;audio-dft;162;163;163;161;163;162;163;163;161;161 06:43:58 INFO - PROCESS | 7058 | |3;audio-fft;75;76;75;107;75;75;76;74;108;76 06:43:58 INFO - PROCESS | 7058 | |4;audio-oscillator;83;82;116;81;82;82;105;83;82;115 06:43:58 INFO - PROCESS | 7058 | |5;imaging-gaussian-blur;116;116;117;116;116;116;117;117;117;117 06:43:58 INFO - PROCESS | 7058 | |6;imaging-darkroom;146;147;148;149;146;146;146;148;146;146 06:43:58 INFO - PROCESS | 7058 | |7;imaging-desaturate;84;84;86;85;85;84;84;85;84;84 06:43:58 INFO - PROCESS | 7058 | |8;json-parse-financial;53;51;51;55;51;54;53;53;54;53 06:43:58 INFO - PROCESS | 7058 | |9;json-stringify-tinderbox;63;63;62;61;63;62;63;62;62;62 06:43:58 INFO - PROCESS | 7058 | |10;stanford-crypto-aes;81;80;80;80;79;80;80;79;80;79 06:43:58 INFO - PROCESS | 7058 | |11;stanford-crypto-ccm;139;136;130;139;128;134;135;130;172;140 06:43:58 INFO - PROCESS | 7058 | |12;stanford-crypto-pbkdf2;165;167;166;163;164;167;167;163;165;178 06:43:58 INFO - PROCESS | 7058 | |13;stanford-crypto-sha256-iterative;67;65;64;65;64;64;68;64;65;65 06:43:58 INFO - PROCESS | 7058 | __end_tp_report 06:43:58 INFO - PROCESS | 7058 | __start_cc_report 06:43:58 INFO - PROCESS | 7058 | _x_x_mozilla_cycle_collect,1702 06:43:58 INFO - PROCESS | 7058 | __end_cc_report 06:43:58 INFO - PROCESS | 7058 | __startTimestamp1477921438069__endTimestamp 06:43:58 INFO - PROCESS | 7058 | 06:43:58 INFO - PROCESS | 7058 | ------- Summary: start ------- 06:43:58 INFO - PROCESS | 7058 | Number of tests: 14 06:43:58 INFO - PROCESS | 7058 | 06:43:58 INFO - PROCESS | 7058 | [#0] ai-astar Cycles:10 Average:110.50 Median:111.00 stddev:2.07 (1.9%) stddev-sans-first:0.78 06:43:58 INFO - PROCESS | 7058 | Values: 105.0 112.0 111.0 112.0 112.0 111.0 111.0 111.0 110.0 110.0 06:43:58 INFO - PROCESS | 7058 | 06:43:58 INFO - PROCESS | 7058 | [#1] audio-beat-detection Cycles:10 Average:133.70 Median:126.50 stddev:17.58 (13.9%) stddev-sans-first:17.75 06:43:58 INFO - PROCESS | 7058 | Values: 149.0 128.0 122.0 171.0 122.0 125.0 120.0 125.0 153.0 122.0 06:43:58 INFO - PROCESS | 7058 | 06:43:58 INFO - PROCESS | 7058 | [#2] audio-dft Cycles:10 Average:162.20 Median:163.00 stddev:0.92 (0.6%) stddev-sans-first:0.97 06:43:58 INFO - PROCESS | 7058 | Values: 162.0 163.0 163.0 161.0 163.0 162.0 163.0 163.0 161.0 161.0 06:43:58 INFO - PROCESS | 7058 | 06:43:58 INFO - PROCESS | 7058 | [#3] audio-fft Cycles:10 Average:81.70 Median:75.00 stddev:13.61 (18.2%) stddev-sans-first:14.22 06:43:58 INFO - PROCESS | 7058 | Values: 75.0 76.0 75.0 107.0 75.0 75.0 76.0 74.0 108.0 76.0 06:43:58 INFO - PROCESS | 7058 | 06:43:58 INFO - PROCESS | 7058 | [#4] audio-oscillator Cycles:10 Average:91.10 Median:82.00 stddev:14.72 (17.9%) stddev-sans-first:15.31 06:43:58 INFO - PROCESS | 7058 | Values: 83.0 82.0 116.0 81.0 82.0 82.0 105.0 83.0 82.0 115.0 06:43:58 INFO - PROCESS | 7058 | 06:43:58 INFO - PROCESS | 7058 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 06:43:58 INFO - PROCESS | 7058 | Values: 116.0 116.0 117.0 116.0 116.0 116.0 117.0 117.0 117.0 117.0 06:43:58 INFO - PROCESS | 7058 | 06:43:58 INFO - PROCESS | 7058 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:146.50 stddev:1.14 (0.8%) stddev-sans-first:1.17 06:43:58 INFO - PROCESS | 7058 | Values: 146.0 147.0 148.0 149.0 146.0 146.0 146.0 148.0 146.0 146.0 06:43:58 INFO - PROCESS | 7058 | 06:43:58 INFO - PROCESS | 7058 | [#7] imaging-desaturate Cycles:10 Average:84.50 Median:84.50 stddev:0.71 (0.8%) stddev-sans-first:0.73 06:43:58 INFO - PROCESS | 7058 | Values: 84.0 84.0 86.0 85.0 85.0 84.0 84.0 85.0 84.0 84.0 06:43:58 INFO - PROCESS | 7058 | 06:43:58 INFO - PROCESS | 7058 | [#8] json-parse-financial Cycles:10 Average:52.80 Median:53.00 stddev:1.40 (2.6%) stddev-sans-first:1.48 06:43:58 INFO - PROCESS | 7058 | Values: 53.0 51.0 51.0 55.0 51.0 54.0 53.0 53.0 54.0 53.0 06:43:58 INFO - PROCESS | 7058 | 06:43:58 INFO - PROCESS | 7058 | [#9] json-stringify-tinderbox Cycles:10 Average:62.30 Median:62.50 stddev:0.67 (1.1%) stddev-sans-first:0.67 06:43:58 INFO - PROCESS | 7058 | Values: 63.0 63.0 62.0 61.0 63.0 62.0 63.0 62.0 62.0 62.0 06:43:58 INFO - PROCESS | 7058 | 06:43:58 INFO - PROCESS | 7058 | [#10] stanford-crypto-aes Cycles:10 Average:79.80 Median:80.00 stddev:0.63 (0.8%) stddev-sans-first:0.50 06:43:58 INFO - PROCESS | 7058 | Values: 81.0 80.0 80.0 80.0 79.0 80.0 80.0 79.0 80.0 79.0 06:43:58 INFO - PROCESS | 7058 | 06:43:58 INFO - PROCESS | 7058 | [#11] stanford-crypto-ccm Cycles:10 Average:138.30 Median:137.50 stddev:12.55 (9.1%) stddev-sans-first:13.31 06:43:58 INFO - PROCESS | 7058 | Values: 139.0 136.0 130.0 139.0 128.0 134.0 135.0 130.0 172.0 140.0 06:43:58 INFO - PROCESS | 7058 | 06:43:58 INFO - PROCESS | 7058 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.50 Median:166.50 stddev:4.33 (2.6%) stddev-sans-first:4.56 06:43:58 INFO - PROCESS | 7058 | Values: 165.0 167.0 166.0 163.0 164.0 167.0 167.0 163.0 165.0 178.0 06:43:58 INFO - PROCESS | 7058 | 06:43:58 INFO - PROCESS | 7058 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.10 Median:65.00 stddev:1.37 (2.1%) stddev-sans-first:1.27 06:43:58 INFO - PROCESS | 7058 | Values: 67.0 65.0 64.0 65.0 64.0 64.0 68.0 64.0 65.0 65.0 06:43:58 INFO - PROCESS | 7058 | -------- Summary: end -------- 06:43:58 INFO - PROCESS | 7058 | 06:43:59 INFO - TEST-INFO | 7058: exit 0 06:43:59 INFO - TEST-OK | kraken | took 61533ms 06:43:59 INFO - SUITE-END | took 1178s 06:43:59 INFO - Completed test suite (00:19:38) 06:43:59 INFO - javascript benchmark 06:43:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2899.57956096366, 2911.315840777418, 2960.5707172459993, 2965.822050676958, 2971.643402791664, 5018.297438358623, 5099.923501147486, 5139.25480805283, 5226.660267082637, 5297.178937264721, 5135.460776618457, 5207.297014902987, 5296.920546191801, 5301.5228629423345, 5344.9198262026, 4723.126221648989, 4725.362076119732, 4763.4998325175875, 4770.332153498513, 4820.325154478376, 4759.690620109699, 4807.927881081787, 4894.926576101361, 4897.975510122445, 4953.083679519301, 4655.674102812804, 4816.614670826326, 4831.082094402088, 4844.297576851354, 4934.0625281196635, 4666.719996800203, 4673.509281525425, 4681.250999840044, 4681.789319480631, 4750.239961606127, 4660.0, 4661.09108723799, 4663.836765713218, 4694.835680751192, 4723.834665786681, 5069.417017043051, 5107.361579802525, 5113.079645663779, 5119.436861945183, 5171.0, 5382.407935127133, 5428.294321738188, 5447.645903016291, 5471.8084867029465, 5566.860828479321, 5612.494875461228, 5631.718414079321, 5644.435556444364, 5693.7437815298, 5706.71466426677, 5237.816676416307, 5238.711870847102, 5238.790448382022, 5241.344831896051, 5307.991481618557, 5455.618106732491, 5489.807856725075, 5590.580706447033, 5644.125160600113, 5708.257926469532, 5425.37608175057, 5425.782968681208, 5439.0, 5486.067368547357, 5503.7798488060025, 5460.481254280837, 5509.779608815683, 5510.9448905511235, 5516.310461192351, 5544.695041772741, 5410.1343784995, 5452.04589196889, 5463.836084917459, 5497.532709719639, 5564.10974244119, 5552.167174923713, 5580.1629755537, 5585.3297604287745, 5637.802676906289, 5646.520045796154, 4329.761863097497, 4331.5451877552405, 4333.111712099012, 4339.500957389941, 4388.9122217556105, 3776.773393596338, 3781.621837816196, 3853.056001279648, 3882.5729169791302, 3894.883153505399, 5221.164613661796, 5237.16205407133, 5339.0, 5359.169328754049, 5434.972825135849, 5601.887962240814, 5615.073512870331, 5622.803201887914, 5624.521915637217, 5626.240457538262, 5305.230741542455, 5338.813141540028, 5341.919871201935, 5355.169948657965, 5407.107827208545, 4667.416572928384, 4685.344051832746, 4809.0, 4876.390451193601, 4887.975560122248, 5864.120381942743, 5866.2373891393845, 5871.266091738447, 5886.264216972879, 5929.258842644669, 5641.323041234914, 5642.0, 5647.604667673388, 5650.463205995424, 5650.604457687922, 5519.144532597454, 5575.804846830504, 5810.535157187331, 5836.387179346108, 5849.970750146222, 5565.443455654402, 5568.192612071308, 5581.469760372758, 5633.352164501135, 5645.0, 5623.0, 5683.0, 5689.032864413142, 5692.886142277214, 5693.886122277614, 5278.4193738687945, 5315.495027972336, 5425.972870135624, 5465.72671366438, 5530.668159910419, 5492.5331346835965, 5500.7524661391135, 5511.200875872896, 5552.444755524577, 5558.805441809517, 5452.890942181055, 5459.0, 5465.344158700981, 5466.644668096561, 5472.726363681721, 5223.660462069954, 5251.186066159751, 5491.423400543045, 5512.862178445571, 5569.220309156803, 5371.462853714597, 5400.0, 5423.864403389947, 5449.809256675997, 5458.263134476795], "value": 5148.9786926107445, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [547.8051626778798, 588.698975264665, 609.2840911928486, 618.8360084577588, 632.1939527102946, 31153.68846311539, 40587.79706101469, 41253.79373103131, 41511.99999999996, 41547.58452415482, 42346.0, 42693.78653106738, 42807.35788963168, 42923.78538107305, 43027.78486107565, 8082.71710490133, 8174.427790054669, 8837.248833849115, 8994.86507702385, 9001.0, 10443.164546836235, 10689.0, 10696.572137114506, 11072.169587280945, 11076.723081922935, 10861.619843305485, 10930.617428390007, 10930.726731831728, 10934.179936504754, 10935.671929842118, 8095.6761729530745, 8329.625166867505, 10462.895371046268, 10706.946465267663, 10763.13894888411, 10342.379457232515, 10629.73425664357, 10639.521221545048, 10639.946800266027, 10642.042216200502, 40542.39186412206, 40807.387889181686, 40836.795816021026, 40885.79557102225, 40893.38659920103, 3312.635610082889, 3339.716124129452, 3340.9331813363838, 3355.9832200839082, 3448.379291727488, 30685.0, 30977.845110774528, 30982.380352392825, 31720.0, 32115.678843211736, 4299.91400171998, 4382.846600368972, 4441.333799930037, 4465.642748580106, 4469.463664360298, 291612.0, 292887.0, 295252.0, 295693.0, 296724.0, 32432.189195270308, 54134.45865541373, 54327.72836135873, 54335.45664543383, 54344.0, 33129.0, 35247.29505409929, 35371.0, 35375.82312088423, 35477.1130721734, 12745.36273186337, 12773.381456801333, 12802.80795788064, 12807.231566106064, 12858.485660573659, 9382.5308734563, 9529.142377186086, 10194.694159175237, 10568.841467377995, 10599.735006624896, 7993.32056775169, 8051.879221811678, 8135.79660508492, 8186.2632363087605, 8191.303739182117, 3165.9050228493184, 3185.7451403887635, 3195.201199700075, 3208.9197770055466, 3223.09753269085, 902.9774255643662, 932.7994481186578, 973.5667627905514, 978.3885071830106, 980.8675828763169, 29956.550651739806, 31610.525842111925, 31655.20861978469, 32087.197820054684, 32395.838020810217, 1025.374521541859, 1046.586598293685, 1078.5200585739428, 1105.3312745788842, 1118.9384583847966, 15975.840241597436, 16607.0, 16668.249928753234, 16727.749083763752, 16924.30294660685, 151264.0, 152310.0, 152691.0, 153012.0, 154910.0, 55705.0, 55780.44219557834, 56055.43944560502, 56307.71846140743, 56389.71805140948, 1164.0920082335792, 1227.5764861122898, 1280.0911352939518, 1320.39261939507, 1339.1161833190047, 28749.0, 32026.19934501656, 32288.83855580707, 34208.486872697424, 34348.31303373969, 51684.741576291875, 51904.74047629889, 52305.0, 52317.7384113077, 52420.21369679534, 417010.0, 420511.61558343755, 421485.0, 424208.0, 426315.0, 23986.160484382963, 24603.384915377257, 26434.0, 27356.863215683796, 27808.304792380353, 43532.56467435285, 43568.56431435645, 43682.126357472036, 44284.0, 44689.0, 37124.0, 37612.2477550453, 38005.809970949966, 38112.42831357476, 38185.80907095447, 37655.0, 37873.431898522096, 37885.431718523694, 38011.42982855204, 38034.42948355832, 39238.607613924636, 39685.60314396819, 40324.0, 42105.1578968425, 42449.78775106105, 33032.66967330296, 35736.642633573334, 36234.27531449303, 36437.0, 36594.26811463702, 27882.0, 27923.720762792113, 28089.57865631976, 28189.295267618472, 28193.71806281911], "value": 17751.23742026849, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [370.2132967444181, 374.5935659809107, 376.39964257010075, 396.4687318992549, 401.36984933654156, 17740.733888991675, 18831.905840470812, 19060.142293596786, 19335.613287734253, 19399.806001939978, 15428.0, 15429.845701542981, 15730.37078516858, 15736.213189340517, 19219.519512012208, 5408.242846001573, 5652.915206271889, 5655.943440565604, 5660.688662123582, 5663.461971112758, 5462.863428414282, 5497.120460726284, 5555.250041244421, 5580.888382232353, 5587.916181257264, 5550.77796888124, 5551.333839939192, 5555.611107222496, 5558.221848941132, 5560.916586251189, 5345.385280692712, 5488.7530061147345, 5504.256925315111, 5512.0, 5518.420565840569, 4853.223484242504, 4854.68444551103, 4860.319555262231, 4873.561379475828, 4873.829415970459, 22212.11151553952, 22266.0, 22315.218967336226, 22548.774512254833, 22668.886655566617, 2241.4396400899777, 2362.267697013914, 2374.5488357212075, 2533.3793220660873, 2973.3755911258663, 14184.929075354557, 14255.50105746294, 15048.473303434328, 15562.22188890551, 16286.069910789174, 1930.6474163832318, 2027.908744106504, 2036.2364113457454, 2061.5155438471947, 2093.6336141175234, 88160.55919720425, 88969.55515222382, 89149.55425222832, 90148.54925725395, 93083.0, 16583.253753581117, 17257.56856078583, 17301.307947682202, 17377.304907803547, 17838.643227135384, 29713.405731885243, 29793.40413191724, 29826.85086574553, 29879.10362689123, 29894.701052989192, 8266.214709602578, 8538.146185381413, 8644.740657780276, 8671.349648776368, 8823.514706691194, 7106.680199391039, 7116.537425067354, 7165.390941769903, 7293.854122917618, 7386.667599958015, 8467.66129354819, 8591.883055202783, 8824.647014119491, 8829.867551986725, 8854.203121718947, 3240.8379581020854, 3442.1566716154703, 3453.689167974894, 3505.631908649606, 3541.557305336833, 908.8545832666874, 964.7781010367655, 972.363102168081, 1015.8019186258756, 1056.4717641179411, 18913.243470261037, 19363.612727745367, 19466.70799938002, 19542.804571954097, 19801.60396792056, 925.2181906289175, 929.1405449958761, 931.5421365562872, 947.545178314413, 996.028871849955, 8384.8742268866, 10231.334963227366, 10658.919557298601, 10733.570657173626, 10794.676159715222, 397820.0, 401073.0, 407624.0, 409478.0, 414709.0, 79950.0, 81015.0, 83917.58041209755, 85152.57423712965, 88309.0, 1000.2698030437821, 1002.0, 1003.513296051429, 1006.0693858181153, 1038.1020417339098, 16476.67046659084, 16582.834171658127, 17005.48983530496, 17337.479875603753, 17590.824091758917, 38965.0, 39161.804190978866, 40695.59304407037, 41397.927404155904, 42042.369364460166, 52076.47923520868, 54358.0, 54377.184342234104, 55955.0, 56602.7169864148, 7532.096148462219, 7699.730509432367, 7778.611069446618, 7992.800179995546, 8141.959290203748, 11044.282121662067, 12640.74718505643, 12723.427445765148, 12729.0, 13333.0, 11269.323840569592, 11491.0, 11565.265210218535, 11688.428545719928, 11720.70698232551, 11120.443977800916, 11348.0, 11382.260153090023, 11401.315921044765, 11755.118366122746, 11425.0, 11440.656780296604, 11552.075833933097, 11992.280463172237, 12091.879081209076, 7610.505317154367, 7634.656440460081, 7687.923120768721, 7713.4600577959, 8006.559639219899, 8878.5116818573, 11096.223264371416, 11381.772364552828, 11408.144389170679, 11624.360660163773], "value": 9612.115179665552, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1293.1400618588639, 1449.3043339197181, 1491.6121808329835, 1616.6039320366513, 1748.6065635232067, 7451.701931922724, 7862.528248305099, 8069.959650201756, 8145.14475980021, 8157.306628936548, 8225.218604232588, 8371.58142092896, 8372.372072094588, 8536.530490823003, 8576.0995095515, 2291.518781055976, 2316.4093156245135, 2330.8951097200666, 2333.4516388648653, 2334.9533009339802, 2263.343630347197, 2339.122828939148, 2357.3988632898586, 2358.3750306168877, 2364.7398786133513, 2246.146464343555, 2298.804601608857, 2329.5573840970246, 2337.614293641547, 2338.847974881627, 2248.5727711734717, 2249.538844536882, 2261.6494443361307, 2268.1494439585153, 2272.5682120397155, 2285.462916214688, 2305.3545007397956, 2306.7577904319974, 2317.501737126509, 2330.149495434171, 8434.325253979667, 8495.660173593049, 8527.147285271423, 8530.146985301482, 8532.530710810903, 5097.821576244851, 5238.345206849144, 5247.239150323182, 5312.1766126250495, 5315.282436871012, 3368.2589830237307, 3389.7288216942584, 3406.0463070340343, 3453.188500702333, 3461.7230621550216, 1085.782843431309, 1104.4036220440953, 2151.3223334649692, 2152.623290924082, 2164.8159906407973, 11756.177067605271, 11838.408079595985, 11962.102842286864, 11963.88036119645, 11965.820512692317, 4411.404460397805, 4538.773061346919, 4641.0, 4654.883627909329, 4683.297505374221, 10141.746456338504, 10157.847632285522, 10164.136048435817, 10174.389536627827, 10176.135028522658, 5299.920501192485, 5301.231321458444, 5307.52232299095, 5307.814226502054, 5309.123994540934, 4240.321548552217, 4276.935845962313, 4828.46886842447, 4828.95171048285, 4850.054239423349, 3756.3426400379826, 3863.9613603864163, 3887.1642596841816, 3944.3886197639413, 3948.9605103948593, 1241.2180326394314, 1254.2850575172065, 1271.7583659104741, 1280.5454063807401, 1300.4083142170289, 837.0, 872.8036191856781, 886.9423487473293, 898.6944438890808, 914.2274777812737, 5320.574354051744, 5524.281843360337, 5542.251796007487, 5587.106063029895, 5762.683052432073, 884.5311984648147, 893.1604291965532, 933.2813733425224, 933.6125507914276, 959.5873774277128, 3592.4072528033103, 3778.4332350147147, 3845.615438456188, 3849.711271654637, 3889.5138107736534, 9898.80202395948, 10260.281780275309, 10267.640632577974, 10278.537465814057, 10280.485975701185, 9963.202943764481, 10116.393016419039, 10235.48822558884, 10237.48812559369, 10287.43419111956, 7799.571023593757, 8110.63502142405, 8124.065732440845, 8136.796580085545, 8137.308328792119, 5291.100512912737, 5308.708021058725, 5347.812826551052, 5559.16612508127, 5593.545678123636, 9452.43285402878, 9457.810843782949, 9486.098820612031, 9524.285678574273, 9596.424214547149, 9337.673181438617, 9475.47884866339, 9702.126808586978, 9810.509474526103, 9824.789422379907, 6878.931210687829, 7072.752453664097, 7349.412047036331, 7597.848043038997, 7760.417968652487, 8025.9197408025175, 8400.159984001795, 8410.537420441935, 8422.578871056545, 8426.915730842858, 7095.858082838211, 7109.82225444368, 7346.52247603904, 7542.208068152984, 7748.0, 6674.699638516181, 6777.423918966943, 6821.2155602106395, 6948.444124469929, 7017.7192912282935, 6237.781677641261, 6256.186695729526, 6308.52686048539, 6311.779087731908, 6312.242530896322, 4709.552592503706, 4787.904241915212, 4795.592374648194, 4805.783739731791, 4839.056384005085, 4634.490206077397, 4771.73755443454, 4823.5658790709, 4826.0830442217275, 5135.15269980449], "value": 4516.008404264691, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [321.52900480302606, 322.67732267732265, 330.7238455889332, 334.76900938352543, 342.9657034296572, 5205.609579281555, 5249.16279302244, 5260.447652996438, 5260.842174734764, 5260.947390526103, 4920.630952678554, 5020.573251273637, 5031.672941258816, 5159.277701121846, 5212.0, 4113.506379234481, 4114.917701645965, 4116.588341165874, 4126.814293356806, 4130.401091841682, 4125.566815484376, 4126.401671757593, 4137.379393091031, 4151.771652559108, 4175.66594672427, 3827.655511004009, 3902.2780785554764, 4064.9187016259657, 4078.89802754932, 4112.958870411302, 4077.429159917614, 4089.407035979781, 4091.2226676931587, 4093.4269202311702, 4093.9385909211387, 3612.729045321585, 3623.420252759572, 3629.1290090378384, 3630.3828349180703, 3637.508936293593, 4809.975950120262, 5052.393712754493, 5055.494450554952, 5062.038212739568, 5070.923936140961, 4585.197590421662, 4604.493505714368, 4606.654500912445, 4606.930896036562, 4609.67732258742, 5361.5978801589645, 5371.516563509303, 5385.5459026062745, 5409.323109835964, 5425.511703946624, 3826.8086595670106, 3915.941260881089, 3915.9804200979097, 3923.2545816295096, 3925.489686340786, 5385.892282154374, 5518.310211223597, 5520.006398848206, 5552.666839989573, 5552.833414997556, 3934.3311637021775, 3946.9210615787524, 3949.4273330366937, 3959.4360227709894, 3960.762354258696, 3979.85432826406, 3997.84008639657, 4018.216447792711, 4025.3156963316305, 4036.7577945322787, 4537.4328208973875, 4581.129585378767, 4589.632829373642, 4605.838795642204, 4630.259158534618, 5423.864403389868, 5426.647267927572, 5441.5102640762525, 5448.155535891943, 5486.890262194734, 1392.1090502078678, 1406.0579411794122, 1406.226575383535, 1408.7675533537056, 1410.7796755806153, 898.7887846356101, 904.7187290574301, 957.7653474898694, 963.210167662524, 971.9562619682131, 5219.530242278213, 5247.790088396421, 5254.448282930313, 5283.735813209324, 5292.438730574489, 5437.592180586393, 5500.834974950758, 5506.339239291311, 5526.751296191681, 5550.750216240279, 5102.311187989648, 5234.607404444606, 5263.078961181778, 5297.231901374279, 5303.708296043677, 2896.2904088498453, 2925.0, 2935.7211064948797, 2944.955825662617, 2954.630671166104, 5660.46212132558, 5724.198612194296, 5770.971145144332, 5779.739911703983, 5801.216835727208, 5578.972105139448, 5583.637063590853, 5593.776248950077, 5606.0, 5610.49505544503, 5640.266765320482, 5715.199872017921, 5719.342275638355, 5723.170140329629, 5778.971105144531, 5263.394709608444, 5489.972550137224, 5490.752916118864, 5515.0, 5544.556435485071, 5485.341758988947, 5491.478309560585, 5498.5876059294915, 5500.367457742251, 5504.669719816824, 5687.630304030225, 5808.709564521672, 5834.395541226197, 5837.978353788155, 5854.619449735754, 3904.9414258785573, 3946.2304850555015, 3952.7035472339116, 3956.70511103565, 3972.960270397259, 5441.755121019484, 5504.4770746778995, 5555.194496798023, 5567.383329834971, 5589.496945274945, 5263.315738963495, 5465.207544905887, 5471.72641367922, 5473.151661492475, 5480.287562616834, 5365.785368585213, 5371.704556249444, 5374.328208973879, 5397.8920421590565, 5404.891902162013, 5151.974240128776, 5294.23233631129, 5334.839954801362, 5388.73056347189, 5404.43253458397, 5285.471452854684, 5422.62041657096, 5464.508194262536, 5466.34403871538, 5471.835844924659, 5332.30680011596, 5336.226247194213, 5341.359036915595, 5343.2597181972, 5360.973195133999], "value": 4147.69929657128, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [726.989095163573, 727.9636018199088, 728.9976282611412, 769.6228847864548, 813.4346629092781, 14339.928300358497, 15086.170260635661, 15086.54740357791, 15106.924465377686, 15214.54356369308, 12638.431270592822, 12809.295488748116, 12814.871851281485, 12816.102872798907, 12829.679258018554, 640.3852301790287, 656.9211694596655, 658.7266284491955, 659.294554826336, 659.508666043798, 764.8011517005591, 781.2968328504335, 785.332467402706, 788.3377962511489, 791.4815795653856, 834.2116699718769, 835.3567752830317, 837.0123254559617, 837.3175861672747, 837.417994493827, 831.6673330667721, 832.5004997001781, 832.5837081459271, 832.7709879783077, 832.7834762961613, 498.28187238613276, 506.55170174395926, 589.8908701890122, 606.6693651959692, 615.8244900203465, 12691.175073620185, 12721.982241420757, 12722.0, 12724.872751272462, 12744.299063551502, 13127.277999710011, 13441.529546465827, 13504.729905401935, 13593.456261749518, 13783.241921694304, 12288.569900053455, 12352.505899763999, 12436.875631243662, 12640.241585504898, 12829.615111546575, 4227.196832601796, 4244.193603215379, 4262.508122157251, 4281.850135245282, 4314.482262128533, 58670.0, 60179.0, 60697.0, 60863.0, 60978.695106524625, 10448.634297799541, 10674.092702120251, 10838.0, 10915.945420273007, 10987.175961802897, 20059.197632094554, 20233.595328093357, 20437.89781051085, 20467.28364507265, 20525.692114618294, 7441.404687624977, 7566.432517561205, 7852.332551733052, 7916.129225785159, 7946.721864734822, 4577.0845830833305, 4586.289125185602, 4597.793099310539, 4614.146382919103, 4620.53794620542, 3246.8538915748377, 3319.6016478022793, 3327.8336083195745, 3328.467445208755, 3331.217163966466, 574.7269054579217, 585.3297973819953, 589.3163929841363, 594.7888499582673, 596.4095545410013, 510.6170372220834, 547.8329109621603, 624.753222477119, 658.664081318531, 685.2604633430269, 8714.346424018224, 8717.259032982141, 8838.116188381111, 8937.157022480396, 9120.771980700536, 662.483263054818, 663.2770280394393, 678.9388954994074, 691.2914262880588, 692.0449779304528, 4181.540030596632, 4334.804933777988, 4358.997430590982, 4366.214081465367, 4421.38100665907, 53850.0, 53936.73031634895, 69991.3000869995, 71858.28141718516, 73457.26542734505, 55690.0, 69143.3085669147, 70702.0, 72499.83751381087, 73433.26566734372, 64294.678526607066, 64388.0, 66165.33834661591, 66312.0, 66493.667531663, 9437.292203084933, 9717.0, 9872.0, 9883.0, 9939.204863611038, 41112.58887411088, 41877.37183942182, 44436.77781611071, 45690.543094569955, 48202.75898620485, 41641.37537936873, 44503.10993780171, 57618.7119064402, 65366.67316663386, 70861.1946326806, 13330.600081997556, 13635.931820340835, 13652.112612680145, 13976.0, 14226.0, 14015.159090454197, 14213.715725685635, 14318.57044288673, 14549.054311469721, 15311.846881531043, 13304.46782128704, 13607.455701771818, 13643.317834108453, 13723.656908577366, 13812.378442970292, 12842.935785321013, 13020.609381718563, 13244.735105298032, 13563.254021028939, 13646.249456279602, 13442.46230150783, 13592.252426116658, 13605.319734013457, 13734.038617296694, 13966.231857247949, 10571.841422378517, 10695.839562406414, 10955.287906286067, 11125.221234513507, 11302.378369189773, 10971.396573188551, 11316.304136870602, 11472.770544588895, 11493.023093037185, 11588.304701717923], "value": 6909.178301301613, "unit": "score"}], "name": "dromaeo_css", "value": 6960.387315432434, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 112.0, 111.0, 112.0, 112.0, 111.0, 111.0, 111.0, 110.0, 110.0], "value": 110.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 128.0, 122.0, 171.0, 122.0, 125.0, 120.0, 125.0, 153.0, 122.0], "value": 133.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 163.0, 161.0, 163.0, 162.0, 163.0, 163.0, 161.0, 161.0], "value": 162.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 107.0, 75.0, 75.0, 76.0, 74.0, 108.0, 76.0], "value": 81.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 116.0, 81.0, 82.0, 82.0, 105.0, 83.0, 82.0, 115.0], "value": 91.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 117.0, 116.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 148.0, 149.0, 146.0, 146.0, 146.0, 148.0, 146.0, 146.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 86.0, 85.0, 85.0, 84.0, 84.0, 85.0, 84.0, 84.0], "value": 84.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 51.0, 51.0, 55.0, 51.0, 54.0, 53.0, 53.0, 54.0, 53.0], "value": 52.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 62.0, 61.0, 63.0, 62.0, 63.0, 62.0, 62.0, 62.0], "value": 62.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 80.0, 80.0, 80.0, 79.0, 80.0, 80.0, 79.0, 80.0, 79.0], "value": 79.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 136.0, 130.0, 139.0, 128.0, 134.0, 135.0, 130.0, 172.0, 140.0], "value": 138.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 167.0, 166.0, 163.0, 164.0, 167.0, 167.0, 163.0, 165.0, 178.0], "value": 166.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 65.0, 64.0, 65.0, 64.0, 64.0, 68.0, 64.0, 65.0, 65.0], "value": 65.1, "unit": "score"}], "name": "kraken", "value": 1491.7999999999997, "alertThreshold": 2.0}]} 06:43:59 INFO - Return code: 0 06:43:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:43:59 INFO - # TBPL SUCCESS # 06:43:59 INFO - Running post-action listener: _resource_record_post_action 06:43:59 INFO - [mozharness: 2016-10-31 13:43:59.864247Z] Finished run-tests step (success) 06:43:59 INFO - Running post-run listener: _resource_record_post_run 06:43:59 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 8192; Write bytes: 399515648; Read time: 20; Write time: 375088 06:43:59 INFO - TinderboxPrint: CPU usage
13.0% 06:43:59 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 20 06:43:59 INFO - TinderboxPrint: I/O write bytes / time
399,515,648 / 375,088 06:43:59 INFO - TinderboxPrint: CPU idle
8,296.7 (86.9%) 06:43:59 INFO - TinderboxPrint: CPU user
1,195.9 (12.5%) 06:43:59 INFO - TinderboxPrint: Swap in / out
0 / 0 06:43:59 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 110379008; Read time: 0; Write time: 131836 06:43:59 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 0; Write bytes: 289136640; Read time: 0; Write time: 243252 06:44:00 INFO - Running post-run listener: _upload_blobber_files 06:44:00 INFO - Blob upload gear active. 06:44:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:44:00 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 06:44:00 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'] 06:44:00 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 06:44:00 INFO - (blobuploader) - INFO - Open directory for files ... 06:44:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:44:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:44:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:44:04 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:44:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:44:04 INFO - (blobuploader) - INFO - Done attempting. 06:44:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:44:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:44:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:44:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:44:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:44:05 INFO - (blobuploader) - INFO - Done attempting. 06:44:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:44:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:44:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:44:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:44:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:44:06 INFO - (blobuploader) - INFO - Done attempting. 06:44:06 INFO - (blobuploader) - INFO - Iteration through files over. 06:44:06 INFO - Return code: 0 06:44:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:44:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:44:06 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2dbca88cd904337a268d807b65dfb38eb5dfcd3e03327394adf59eab84d2d474053e34c8c57c2d667dd17025137601a3d9f24ac779dcb7353ebb0015c4135689", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9de733568deabf13388941f389503b05165cdb02083804c6927028374a0ddb821b6793318fcc3ea8ed38ebdd62d1f6b5f088385c0777b6acf26446bb1b747947", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6190bbcf44a978f38d14829fdfd471a6fee03f37d19dbed799b0f9f3ed7eebfd5921b002dcf2aaea78cb0a2d4c44ca7769562bb9a14425f3874038cccf427047"} 06:44:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:44:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:44:06 INFO - Contents: 06:44:06 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2dbca88cd904337a268d807b65dfb38eb5dfcd3e03327394adf59eab84d2d474053e34c8c57c2d667dd17025137601a3d9f24ac779dcb7353ebb0015c4135689", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9de733568deabf13388941f389503b05165cdb02083804c6927028374a0ddb821b6793318fcc3ea8ed38ebdd62d1f6b5f088385c0777b6acf26446bb1b747947", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6190bbcf44a978f38d14829fdfd471a6fee03f37d19dbed799b0f9f3ed7eebfd5921b002dcf2aaea78cb0a2d4c44ca7769562bb9a14425f3874038cccf427047"} 06:44:06 INFO - Running post-run listener: copy_logs_to_upload_dir 06:44:06 INFO - Copying logs to upload dir... 06:44:06 INFO - mkdir: /builds/slave/test/build/upload/logs 06:44:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.088898 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-10-31 06:44:06.508400) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-31 06:44:06.511712) ========= 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=32c5991c409366f7fec8a718000001d2-1477920206.148172-952636325 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/2dbca88cd904337a268d807b65dfb38eb5dfcd3e03327394adf59eab84d2d474053e34c8c57c2d667dd17025137601a3d9f24ac779dcb7353ebb0015c4135689", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9de733568deabf13388941f389503b05165cdb02083804c6927028374a0ddb821b6793318fcc3ea8ed38ebdd62d1f6b5f088385c0777b6acf26446bb1b747947", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6190bbcf44a978f38d14829fdfd471a6fee03f37d19dbed799b0f9f3ed7eebfd5921b002dcf2aaea78cb0a2d4c44ca7769562bb9a14425f3874038cccf427047"} 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.011201 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/2dbca88cd904337a268d807b65dfb38eb5dfcd3e03327394adf59eab84d2d474053e34c8c57c2d667dd17025137601a3d9f24ac779dcb7353ebb0015c4135689", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9de733568deabf13388941f389503b05165cdb02083804c6927028374a0ddb821b6793318fcc3ea8ed38ebdd62d1f6b5f088385c0777b6acf26446bb1b747947", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6190bbcf44a978f38d14829fdfd471a6fee03f37d19dbed799b0f9f3ed7eebfd5921b002dcf2aaea78cb0a2d4c44ca7769562bb9a14425f3874038cccf427047"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-31 06:44:06.537128) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 06:44:06.537461) ========= 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=32c5991c409366f7fec8a718000001d2-1477920206.148172-952636325 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004433 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 06:44:06.620116) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-31 06:44:06.620436) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-31 06:44:06.620719) ========= ========= Total master_lag: 0.16 =========