builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-054 starttime: 1476486874.37 results: success (0) buildid: 20161014154508 builduid: f879b5b95c464386ad400448f15495d1 revision: e412b386433b8c8ba83a28a1df310d9ad0b20285 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-14 16:14:34.367570) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-14 16:14:34.368032) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-14 16:14:34.368298) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-14 16:14:34.382785) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 16:14:34.383115) ========= 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=cbe409c6de289db6ac707de3000001d4-1476486873.881300-2135266699 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-14 16:14:34-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.7M=0s 2016-10-14 16:14:34 (46.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.116948 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 16:14:34.513647) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 16:14:34.513955) ========= 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=cbe409c6de289db6ac707de3000001d4-1476486873.881300-2135266699 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016608 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 16:14:34.563524) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 16:14:34.563876) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev e412b386433b8c8ba83a28a1df310d9ad0b20285 --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 e412b386433b8c8ba83a28a1df310d9ad0b20285 --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=cbe409c6de289db6ac707de3000001d4-1476486873.881300-2135266699 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-14 16:14:34,795 truncating revision to first 12 chars 2016-10-14 16:14:34,795 Setting DEBUG logging. 2016-10-14 16:14:34,795 attempt 1/10 2016-10-14 16:14:34,795 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/e412b386433b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-14 16:14:35,386 unpacking tar archive at: fx-team-e412b386433b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.877700 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 16:14:35.454667) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-14 16:14:35.455021) ========= script_repo_revision: e412b386433b8c8ba83a28a1df310d9ad0b20285 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-14 16:14:35.455455) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-14 16:14:35.455729) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-14 16:14:35.463931) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-10-14 16:14:35.464229) ========= /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=cbe409c6de289db6ac707de3000001d4-1476486873.881300-2135266699 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:14:35 INFO - MultiFileLogger online at 20161014 16:14:35 in /builds/slave/test 16:14:35 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 16:14:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:14:35 INFO - {'append_to_log': False, 16:14:35 INFO - 'base_work_dir': '/builds/slave/test', 16:14:35 INFO - 'blob_upload_branch': 'Fx-Team', 16:14:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:14:35 INFO - 'branch': 'Fx-Team', 16:14:35 INFO - 'buildbot_json_path': 'buildprops.json', 16:14:35 INFO - 'config_files': ('talos/linux_config.py',), 16:14:35 INFO - 'default_actions': ('clobber', 16:14:35 INFO - 'read-buildbot-config', 16:14:35 INFO - 'download-and-extract', 16:14:35 INFO - 'populate-webroot', 16:14:35 INFO - 'create-virtualenv', 16:14:35 INFO - 'install', 16:14:35 INFO - 'run-tests'), 16:14:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:14:35 INFO - 'download_minidump_stackwalk': True, 16:14:35 INFO - 'download_symbols': 'ondemand', 16:14:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:14:35 INFO - 'tooltool.py': '/tools/tooltool.py', 16:14:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:14:35 INFO - '/tools/misc-python/virtualenv.py')}, 16:14:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:14:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:14:35 INFO - 'installer_path': 'installer.exe', 16:14:35 INFO - 'log_level': 'info', 16:14:35 INFO - 'log_name': 'talos', 16:14:35 INFO - 'log_to_console': True, 16:14:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:14:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:14:35 INFO - 'opt_config_files': (), 16:14:35 INFO - 'pip_index': False, 16:14:35 INFO - 'sps_profile': False, 16:14:35 INFO - 'sps_profile_interval': 0, 16:14:35 INFO - 'suite': 'dromaeojs', 16:14:35 INFO - 'system_bits': '32', 16:14:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:14:35 INFO - 'title': 'talos-linux64-ix-054', 16:14:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:14:35 INFO - 'use_talos_json': True, 16:14:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:14:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:14:35 INFO - 'work_dir': 'build'} 16:14:35 INFO - [mozharness: 2016-10-14 23:14:35.794200Z] Running clobber step. 16:14:35 INFO - Running pre-action listener: _resource_record_pre_action 16:14:35 INFO - Running main action method: clobber 16:14:35 INFO - rmtree: /builds/slave/test/build 16:14:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:14:36 INFO - Running post-action listener: _resource_record_post_action 16:14:36 INFO - [mozharness: 2016-10-14 23:14:36.775524Z] Finished clobber step (success) 16:14:36 INFO - [mozharness: 2016-10-14 23:14:36.775621Z] Running read-buildbot-config step. 16:14:36 INFO - Running pre-action listener: _resource_record_pre_action 16:14:36 INFO - Running main action method: read_buildbot_config 16:14:36 INFO - Using buildbot properties: 16:14:36 INFO - { 16:14:36 INFO - "project": "", 16:14:36 INFO - "product": "firefox", 16:14:36 INFO - "script_repo_revision": "production", 16:14:36 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 16:14:36 INFO - "repository": "", 16:14:36 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 16:14:36 INFO - "buildid": "20161014154508", 16:14:36 INFO - "stage_platform": "linux64-pgo", 16:14:36 INFO - "basedir": "/builds/slave/test", 16:14:36 INFO - "buildnumber": 1631, 16:14:36 INFO - "platform": "ubuntu64_hw", 16:14:36 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 16:14:36 INFO - "slavebuilddir": "test", 16:14:36 INFO - "branch": "fx-team", 16:14:36 INFO - "revision": "e412b386433b8c8ba83a28a1df310d9ad0b20285", 16:14:36 INFO - "slavename": "talos-linux64-ix-054", 16:14:36 INFO - "builduid": "f879b5b95c464386ad400448f15495d1", 16:14:36 INFO - "repo_path": "integration/fx-team" 16:14:36 INFO - } 16:14:36 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476473404/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 16:14:36 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476473404/firefox-52.0a1.en-US.linux-x86_64.test_packages.json. 16:14:36 INFO - Running post-action listener: _resource_record_post_action 16:14:36 INFO - [mozharness: 2016-10-14 23:14:36.777930Z] Finished read-buildbot-config step (success) 16:14:36 INFO - [mozharness: 2016-10-14 23:14:36.778029Z] Running download-and-extract step. 16:14:36 INFO - Running pre-action listener: _resource_record_pre_action 16:14:36 INFO - Running main action method: download_and_extract 16:14:36 INFO - mkdir: /builds/slave/test/build/tests 16:14:36 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')]} 16:14:36 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476473404/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 16:14:36 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476473404/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 16:14:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476473404/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 16:14:36 INFO - Downloaded 1361 bytes. 16:14:36 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 16:14:36 INFO - Using the following test package requirements: 16:14:36 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 16:14:36 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:14:36 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:14:36 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:14:36 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:14:36 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:14:36 INFO - u'jsshell-linux-x86_64.zip'], 16:14:36 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:14:36 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:14:36 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 16:14:36 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:14:36 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:14:36 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:14:36 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:14:36 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:14:36 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:14:36 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:14:36 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:14:36 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:14:36 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/1476473404/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 16:14:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476473404/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:14:36 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476473404/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 16:14:36 INFO - Http code: 200 16:14:36 INFO - via: 1.1 1b52a5dd431f9e3c81753e61dfdf467a.cloudfront.net (CloudFront) 16:14:36 INFO - x-amz-cf-id: JbpPtMZLJJlZEDW7nQwQzQyGWJmCmHNzXaYJUm7nq13cmbvWGzTlOg== 16:14:36 INFO - x-amz-replication-status: COMPLETED 16:14:36 INFO - x-amz-version-id: lRH5Y7emid8HixTiJq6FMSqDkYCg6.Md 16:14:37 INFO - Expected file size: 22123341 16:14:37 INFO - Obtained file size: 22123341 16:14:41 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 16:14:41 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/1476473404/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 16:14:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476473404/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:14:41 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476473404/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 16:14:41 INFO - Http code: 200 16:14:41 INFO - via: 1.1 41b2ee7cbe95749816a7586d9ab4629d.cloudfront.net (CloudFront) 16:14:41 INFO - x-amz-cf-id: BP8AKM3tYOE9x2jihc-hRMy-DoiTQ5wAxX3wSGqCt-GBNFR3G1wtqg== 16:14:41 INFO - x-amz-replication-status: COMPLETED 16:14:41 INFO - x-amz-version-id: lRH5Y7emid8HixTiJq6FMSqDkYCg6.Md 16:14:41 INFO - Expected file size: 22123341 16:14:41 INFO - Obtained file size: 22123341 16:14:46 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/1476473404/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 16:14:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476473404/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 16:14:46 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476473404/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 16:14:46 INFO - Http code: 200 16:14:46 INFO - via: 1.1 5c2ff4ca1e447265402af29264e83497.cloudfront.net (CloudFront) 16:14:46 INFO - x-amz-cf-id: Uexp-eXtsGlrmZDsMh0116YALouKkUc9QKQbiMQDXzrlBzxNufeUyw== 16:14:46 INFO - x-amz-replication-status: COMPLETED 16:14:46 INFO - x-amz-version-id: 7xjlszH6OzKMhfuaKJy7fayKWOZuhjCj 16:14:46 INFO - Expected file size: 14409006 16:14:46 INFO - Obtained file size: 14409006 16:14: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')]} 16:14:46 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476473404/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 16:14:46 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476473404/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 16:14:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476473404/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 16:14:47 INFO - Downloaded 59614277 bytes. 16:14:47 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476473404/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 16:14:47 INFO - mkdir: /builds/slave/test/properties 16:14:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:14:47 INFO - Writing to file /builds/slave/test/properties/build_url 16:14:47 INFO - Contents: 16:14:47 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476473404/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 16:14:47 INFO - Running post-action listener: _resource_record_post_action 16:14:47 INFO - Running post-action listener: set_extra_try_arguments 16:14:47 INFO - [mozharness: 2016-10-14 23:14:47.639849Z] Finished download-and-extract step (success) 16:14:47 INFO - [mozharness: 2016-10-14 23:14:47.640073Z] Running populate-webroot step. 16:14:47 INFO - Running pre-action listener: _resource_record_pre_action 16:14:47 INFO - Running main action method: populate_webroot 16:14:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:14:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:14:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:14:47 INFO - '--tppagecycles', 16:14:47 INFO - '7'], 16:14:47 INFO - 'tests': ['tsvgm']}}, 16:14:47 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:14:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:14:47 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:14:47 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:14:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:14:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:14:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:14:47 INFO - 'talos_options': ['--disable-e10s'], 16:14:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:14:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:14:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:14:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:14:47 INFO - 'talos_options': ['--disable-e10s'], 16:14:47 INFO - 'tests': ['damp', 'tps']}, 16:14:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:14:47 INFO - 'tests': ['damp', 'tps']}, 16:14:47 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:14:47 INFO - 'tests': ['dromaeo_dom']}, 16:14:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:14:47 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:14:47 INFO - 'tests': ['basic_compositor_video']}, 16:14:47 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:14:47 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:14:47 INFO - 'tests': ['a11yr', 16:14:47 INFO - 'ts_paint', 16:14:47 INFO - 'tpaint', 16:14:47 INFO - 'sessionrestore', 16:14:47 INFO - 'sessionrestore_no_auto_restore', 16:14:47 INFO - 'tabpaint']}, 16:14:47 INFO - 'other-e10s': {'tests': ['a11yr', 16:14:47 INFO - 'ts_paint', 16:14:47 INFO - 'tpaint', 16:14:47 INFO - 'sessionrestore', 16:14:47 INFO - 'sessionrestore_no_auto_restore', 16:14:47 INFO - 'tabpaint']}, 16:14:47 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:14:47 INFO - 'ts_paint', 16:14:47 INFO - 'tpaint', 16:14:47 INFO - 'sessionrestore', 16:14:47 INFO - 'sessionrestore_no_auto_restore', 16:14:47 INFO - 'tabpaint']}, 16:14:47 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:14:47 INFO - 'ts_paint', 16:14:47 INFO - 'tpaint', 16:14:47 INFO - 'sessionrestore', 16:14:47 INFO - 'sessionrestore_no_auto_restore', 16:14:47 INFO - 'tabpaint']}, 16:14:47 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:14:47 INFO - 'tests': ['a11yr', 16:14:47 INFO - 'ts_paint', 16:14:47 INFO - 'tpaint', 16:14:47 INFO - 'sessionrestore', 16:14:47 INFO - 'sessionrestore_no_auto_restore', 16:14:47 INFO - 'tabpaint']}, 16:14:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:14:47 INFO - 'tests': ['a11yr', 16:14:47 INFO - 'ts_paint', 16:14:47 INFO - 'tpaint', 16:14:47 INFO - 'sessionrestore', 16:14:47 INFO - 'sessionrestore_no_auto_restore', 16:14:47 INFO - 'tabpaint']}, 16:14:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:14:47 INFO - 'tests': ['tsvgx', 16:14:47 INFO - 'tsvgr_opacity', 16:14:47 INFO - 'tart', 16:14:47 INFO - 'tscrollx', 16:14:47 INFO - 'cart']}, 16:14:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:14:47 INFO - 'tsvgr_opacity', 16:14:47 INFO - 'tart', 16:14:47 INFO - 'tscrollx', 16:14:47 INFO - 'cart']}, 16:14:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:14:47 INFO - 'talos_options': ['--disable-e10s'], 16:14:47 INFO - 'tests': ['tp5o']}, 16:14:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:14:47 INFO - 'tests': ['tp5o']}, 16:14:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:14:47 INFO - 'talos_options': ['--disable-e10s', 16:14:47 INFO - '--xperf_path', 16:14:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:14:47 INFO - 'tests': ['tp5n']}, 16:14:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:14:47 INFO - 'talos_options': ['--xperf_path', 16:14:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:14:47 INFO - 'tests': ['tp5n']}}, 16:14:47 INFO - 'talos.zip': {'path': '', 16:14:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:14:47 INFO - Running post-action listener: _resource_record_post_action 16:14:47 INFO - [mozharness: 2016-10-14 23:14:47.656927Z] Finished populate-webroot step (success) 16:14:47 INFO - [mozharness: 2016-10-14 23:14:47.657013Z] Running create-virtualenv step. 16:14:47 INFO - Running pre-action listener: _resource_record_pre_action 16:14:47 INFO - Running main action method: create_virtualenv 16:14:47 INFO - Creating virtualenv /builds/slave/test/build/venv 16:14:47 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 16:14:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:14:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:14:47 INFO - Using real prefix '/usr' 16:14:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:14:48 INFO - Installing distribute.............................................................................................................................................................................................done. 16:14:50 INFO - Installing pip.................done. 16:14:50 INFO - Return code: 0 16:14:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:14:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:14:50 INFO - Reading from file tmpfile_stdout 16:14:50 INFO - Output received: 16:14:50 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) 16:14:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:14:50 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')]} 16:14:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:14:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:50 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')]} 16:14:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:14:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:50 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 0x7f4b3f143f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c6f7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cfe790>, '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 0x2cff690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cffb20>, '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': 'cbe409c6de289db6ac707de3000001d4-1476486873.881300-2135266699', '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 16:14:50 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 16:14:50 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 16:14:50 INFO - Using env: {'DISPLAY': ':0', 16:14:50 INFO - 'HOME': '/home/cltbld', 16:14:50 INFO - 'LANG': 'en_US.UTF-8', 16:14:50 INFO - 'LANGUAGE': 'en_US:en', 16:14:50 INFO - 'LOGNAME': 'cltbld', 16:14:50 INFO - 'MAIL': '/var/mail/cltbld', 16:14:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:14:50 INFO - 'MOZ_NO_REMOTE': '1', 16:14:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:14:50 INFO - 'NO_EM_RESTART': '1', 16:14:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:14:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:14:50 INFO - 'PWD': '/builds/slave/test', 16:14:50 INFO - 'SHELL': '/bin/bash', 16:14:50 INFO - 'SHLVL': '1', 16:14:50 INFO - 'TERM': 'linux', 16:14:50 INFO - 'TMOUT': '86400', 16:14:50 INFO - 'USER': 'cltbld', 16:14:50 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1476486873.881300-2135266699', 16:14:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:14:50 INFO - '_': '/tools/buildbot/bin/python'} 16:14:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:14:50 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 16:14:50 INFO - Cleaning up... 16:14:50 INFO - Return code: 0 16:14:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:14:50 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')]} 16:14:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:14:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:50 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')]} 16:14:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:14:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:50 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 0x7f4b3f143f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c6f7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cfe790>, '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 0x2cff690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cffb20>, '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': 'cbe409c6de289db6ac707de3000001d4-1476486873.881300-2135266699', '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 16:14:50 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 16:14:50 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 16:14:50 INFO - Using env: {'DISPLAY': ':0', 16:14:50 INFO - 'HOME': '/home/cltbld', 16:14:50 INFO - 'LANG': 'en_US.UTF-8', 16:14:50 INFO - 'LANGUAGE': 'en_US:en', 16:14:50 INFO - 'LOGNAME': 'cltbld', 16:14:50 INFO - 'MAIL': '/var/mail/cltbld', 16:14:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:14:50 INFO - 'MOZ_NO_REMOTE': '1', 16:14:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:14:50 INFO - 'NO_EM_RESTART': '1', 16:14:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:14:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:14:50 INFO - 'PWD': '/builds/slave/test', 16:14:50 INFO - 'SHELL': '/bin/bash', 16:14:50 INFO - 'SHLVL': '1', 16:14:50 INFO - 'TERM': 'linux', 16:14:50 INFO - 'TMOUT': '86400', 16:14:50 INFO - 'USER': 'cltbld', 16:14:50 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1476486873.881300-2135266699', 16:14:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:14:50 INFO - '_': '/tools/buildbot/bin/python'} 16:14:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:14:50 INFO - Downloading/unpacking psutil>=3.1.1 16:14:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:14:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:14:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:14:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:14:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:14:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:14:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:14:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:14:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:14:53 INFO - Installing collected packages: psutil 16:14:53 INFO - Running setup.py install for psutil 16:14:53 INFO - building 'psutil._psutil_linux' extension 16:14:53 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 16:14:53 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 16:14:53 INFO - building 'psutil._psutil_posix' extension 16:14:53 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 16:14:53 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 16:14:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:14:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:14:53 INFO - Successfully installed psutil 16:14:53 INFO - Cleaning up... 16:14:53 INFO - Return code: 0 16:14:53 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:14:53 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')]} 16:14:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:14:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:53 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')]} 16:14:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:14:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:53 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 0x7f4b3f143f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c6f7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cfe790>, '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 0x2cff690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cffb20>, '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': 'cbe409c6de289db6ac707de3000001d4-1476486873.881300-2135266699', '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 16:14:53 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 16:14:53 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 16:14:53 INFO - Using env: {'DISPLAY': ':0', 16:14:53 INFO - 'HOME': '/home/cltbld', 16:14:53 INFO - 'LANG': 'en_US.UTF-8', 16:14:53 INFO - 'LANGUAGE': 'en_US:en', 16:14:53 INFO - 'LOGNAME': 'cltbld', 16:14:53 INFO - 'MAIL': '/var/mail/cltbld', 16:14:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:14:53 INFO - 'MOZ_NO_REMOTE': '1', 16:14:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:14:53 INFO - 'NO_EM_RESTART': '1', 16:14:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:14:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:14:53 INFO - 'PWD': '/builds/slave/test', 16:14:53 INFO - 'SHELL': '/bin/bash', 16:14:53 INFO - 'SHLVL': '1', 16:14:53 INFO - 'TERM': 'linux', 16:14:53 INFO - 'TMOUT': '86400', 16:14:53 INFO - 'USER': 'cltbld', 16:14:53 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1476486873.881300-2135266699', 16:14:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:14:53 INFO - '_': '/tools/buildbot/bin/python'} 16:14:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:14:53 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:14:53 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 16:14:53 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 16:14:53 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 16:14:53 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 16:14:53 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 16:14:53 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 16:14:55 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:14:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:14:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:14:55 INFO - Installing collected packages: mozsystemmonitor 16:14:55 INFO - Running setup.py install for mozsystemmonitor 16:14:55 INFO - Successfully installed mozsystemmonitor 16:14:55 INFO - Cleaning up... 16:14:55 INFO - Return code: 0 16:14:55 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:14: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')]} 16:14:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:14:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14: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')]} 16:14:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:14:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f4b3f143f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c6f7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cfe790>, '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 0x2cff690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cffb20>, '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': 'cbe409c6de289db6ac707de3000001d4-1476486873.881300-2135266699', '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 16:14:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 16:14:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 16:14:55 INFO - Using env: {'DISPLAY': ':0', 16:14:55 INFO - 'HOME': '/home/cltbld', 16:14:55 INFO - 'LANG': 'en_US.UTF-8', 16:14:55 INFO - 'LANGUAGE': 'en_US:en', 16:14:55 INFO - 'LOGNAME': 'cltbld', 16:14:55 INFO - 'MAIL': '/var/mail/cltbld', 16:14:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:14:55 INFO - 'MOZ_NO_REMOTE': '1', 16:14:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:14:55 INFO - 'NO_EM_RESTART': '1', 16:14:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:14:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:14:55 INFO - 'PWD': '/builds/slave/test', 16:14:55 INFO - 'SHELL': '/bin/bash', 16:14:55 INFO - 'SHLVL': '1', 16:14:55 INFO - 'TERM': 'linux', 16:14:55 INFO - 'TMOUT': '86400', 16:14:55 INFO - 'USER': 'cltbld', 16:14:55 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1476486873.881300-2135266699', 16:14:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:14:55 INFO - '_': '/tools/buildbot/bin/python'} 16:14:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:14:56 INFO - Downloading/unpacking jsonschema==2.5.1 16:14:56 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 16:14:56 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 16:14:56 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 16:14:56 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 16:14:56 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 16:14:56 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 16:14:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:14:58 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:14:58 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 16:14:58 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 16:14:58 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 16:14:58 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 16:14:58 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 16:14:58 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 16:14:58 INFO - Downloading functools32-3.2.3-2.tar.gz 16:14:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:14:58 INFO - warning: no files found matching '*.txt' 16:14:58 INFO - no previously-included directories found matching 'build' 16:14:58 INFO - no previously-included directories found matching 'dist' 16:14:58 INFO - no previously-included directories found matching '.git*' 16:14:58 INFO - Installing collected packages: jsonschema, functools32 16:14:58 INFO - Running setup.py install for functools32 16:14:58 INFO - warning: no files found matching '*.txt' 16:14:58 INFO - no previously-included directories found matching 'build' 16:14:58 INFO - no previously-included directories found matching 'dist' 16:14:58 INFO - no previously-included directories found matching '.git*' 16:14:58 INFO - Successfully installed jsonschema functools32 16:14:58 INFO - Cleaning up... 16:14:58 INFO - Return code: 0 16:14:58 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:14: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')]} 16:14:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:14:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14: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')]} 16:14:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:14:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:58 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 0x7f4b3f143f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c6f7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cfe790>, '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 0x2cff690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cffb20>, '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': 'cbe409c6de289db6ac707de3000001d4-1476486873.881300-2135266699', '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 16:14:58 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 16:14:58 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 16:14:58 INFO - Using env: {'DISPLAY': ':0', 16:14:58 INFO - 'HOME': '/home/cltbld', 16:14:58 INFO - 'LANG': 'en_US.UTF-8', 16:14:58 INFO - 'LANGUAGE': 'en_US:en', 16:14:58 INFO - 'LOGNAME': 'cltbld', 16:14:58 INFO - 'MAIL': '/var/mail/cltbld', 16:14:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:14:58 INFO - 'MOZ_NO_REMOTE': '1', 16:14:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:14:58 INFO - 'NO_EM_RESTART': '1', 16:14:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:14:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:14:58 INFO - 'PWD': '/builds/slave/test', 16:14:58 INFO - 'SHELL': '/bin/bash', 16:14:58 INFO - 'SHLVL': '1', 16:14:58 INFO - 'TERM': 'linux', 16:14:58 INFO - 'TMOUT': '86400', 16:14:58 INFO - 'USER': 'cltbld', 16:14:58 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1476486873.881300-2135266699', 16:14:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:14:58 INFO - '_': '/tools/buildbot/bin/python'} 16:14:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:14:58 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:14:58 INFO - Cleaning up... 16:14:58 INFO - Return code: 0 16:14:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:14: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')]} 16:14:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:14:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14: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')]} 16:14:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:14:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:58 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 0x7f4b3f143f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c6f7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cfe790>, '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 0x2cff690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cffb20>, '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': 'cbe409c6de289db6ac707de3000001d4-1476486873.881300-2135266699', '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 16:14:58 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 16:14:58 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 16:14:58 INFO - Using env: {'DISPLAY': ':0', 16:14:58 INFO - 'HOME': '/home/cltbld', 16:14:58 INFO - 'LANG': 'en_US.UTF-8', 16:14:58 INFO - 'LANGUAGE': 'en_US:en', 16:14:58 INFO - 'LOGNAME': 'cltbld', 16:14:58 INFO - 'MAIL': '/var/mail/cltbld', 16:14:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:14:58 INFO - 'MOZ_NO_REMOTE': '1', 16:14:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:14:58 INFO - 'NO_EM_RESTART': '1', 16:14:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:14:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:14:58 INFO - 'PWD': '/builds/slave/test', 16:14:58 INFO - 'SHELL': '/bin/bash', 16:14:58 INFO - 'SHLVL': '1', 16:14:58 INFO - 'TERM': 'linux', 16:14:58 INFO - 'TMOUT': '86400', 16:14:58 INFO - 'USER': 'cltbld', 16:14:58 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1476486873.881300-2135266699', 16:14:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:14:58 INFO - '_': '/tools/buildbot/bin/python'} 16:14:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:14:59 INFO - Downloading/unpacking blobuploader==1.2.4 16:14:59 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 16:14:59 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 16:14:59 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 16:14:59 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 16:14:59 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 16:14:59 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 16:15:00 INFO - Downloading blobuploader-1.2.4.tar.gz 16:15:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:15:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:15: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 16:15: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 16:15: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 16:15: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 16:15: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 16:15: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 16:15:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:15:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:15:01 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 16:15:01 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 16:15:01 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 16:15:01 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 16:15:01 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 16:15:01 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 16:15:01 INFO - Downloading docopt-0.6.1.tar.gz 16:15:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:15:01 INFO - Installing collected packages: blobuploader, requests, docopt 16:15:01 INFO - Running setup.py install for blobuploader 16:15:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:15:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:15:01 INFO - Running setup.py install for requests 16:15:02 INFO - Running setup.py install for docopt 16:15:02 INFO - Successfully installed blobuploader requests docopt 16:15:02 INFO - Cleaning up... 16:15:02 INFO - Return code: 0 16:15:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:15: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')]} 16:15:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:15:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:15: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')]} 16:15:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:15:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:15:02 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 0x7f4b3f143f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c6f7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cfe790>, '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 0x2cff690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cffb20>, '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': 'cbe409c6de289db6ac707de3000001d4-1476486873.881300-2135266699', '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 16:15:02 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 16:15:02 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 16:15:02 INFO - Using env: {'DISPLAY': ':0', 16:15:02 INFO - 'HOME': '/home/cltbld', 16:15:02 INFO - 'LANG': 'en_US.UTF-8', 16:15:02 INFO - 'LANGUAGE': 'en_US:en', 16:15:02 INFO - 'LOGNAME': 'cltbld', 16:15:02 INFO - 'MAIL': '/var/mail/cltbld', 16:15:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:15:02 INFO - 'MOZ_NO_REMOTE': '1', 16:15:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:15:02 INFO - 'NO_EM_RESTART': '1', 16:15:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:15:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:15:02 INFO - 'PWD': '/builds/slave/test', 16:15:02 INFO - 'SHELL': '/bin/bash', 16:15:02 INFO - 'SHLVL': '1', 16:15:02 INFO - 'TERM': 'linux', 16:15:02 INFO - 'TMOUT': '86400', 16:15:02 INFO - 'USER': 'cltbld', 16:15:02 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1476486873.881300-2135266699', 16:15:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:15:02 INFO - '_': '/tools/buildbot/bin/python'} 16:15:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:15:02 INFO - Running setup.py (path:/tmp/pip-Zowy4u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:15:02 INFO - Running setup.py (path:/tmp/pip-tecQ2r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:15:02 INFO - Running setup.py (path:/tmp/pip-w6_fnt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:15:02 INFO - Running setup.py (path:/tmp/pip-tpVEPC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:15:02 INFO - Running setup.py (path:/tmp/pip-lWa53b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:15:02 INFO - Running setup.py (path:/tmp/pip-llDzph-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:15:02 INFO - Running setup.py (path:/tmp/pip-kRHhB7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:15:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:15:03 INFO - Running setup.py (path:/tmp/pip-Hb7GBt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:15:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:15:03 INFO - Running setup.py (path:/tmp/pip-pkSic7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:15:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:15:03 INFO - Running setup.py (path:/tmp/pip-MZiDoH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:15:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:15:03 INFO - Running setup.py (path:/tmp/pip-UClG4k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:15:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:15:03 INFO - Running setup.py (path:/tmp/pip-h0X5lJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:15:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:15:03 INFO - Running setup.py (path:/tmp/pip-svzMmA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:15:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:15:03 INFO - Running setup.py (path:/tmp/pip-jJo3lf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:15:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:15:03 INFO - Running setup.py (path:/tmp/pip-YujHzg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:15:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:15:03 INFO - Running setup.py (path:/tmp/pip-QoFARY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:15:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:15:03 INFO - Running setup.py (path:/tmp/pip-aPKD9O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:15:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:15:03 INFO - Running setup.py install for manifestparser 16:15:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:15:03 INFO - Running setup.py install for mozcrash 16:15:03 INFO - Running setup.py install for mozdebug 16:15:04 INFO - Running setup.py install for mozdevice 16:15:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:15:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:15:04 INFO - Running setup.py install for mozfile 16:15:04 INFO - Running setup.py install for mozhttpd 16:15:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:15:04 INFO - Running setup.py install for mozinfo 16:15:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:15:04 INFO - Running setup.py install for mozInstall 16:15:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:15:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:15:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:15:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:15:04 INFO - Running setup.py install for mozleak 16:15:04 INFO - Running setup.py install for mozlog 16:15:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:15:04 INFO - Running setup.py install for moznetwork 16:15:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:15:04 INFO - Running setup.py install for mozprocess 16:15:04 INFO - Running setup.py install for mozprofile 16:15:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:15:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:15:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:15:05 INFO - Running setup.py install for mozrunner 16:15:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:15:05 INFO - Running setup.py install for mozscreenshot 16:15:05 INFO - Running setup.py install for moztest 16:15:05 INFO - Running setup.py install for mozversion 16:15:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:15:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:15:05 INFO - Cleaning up... 16:15:05 INFO - Return code: 0 16:15:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:15:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:15:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:15:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:15:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:15:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:15:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:15:05 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 0x7f4b3f143f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c6f7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cfe790>, '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 0x2cff690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cffb20>, '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': 'cbe409c6de289db6ac707de3000001d4-1476486873.881300-2135266699', '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 16:15:05 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 16:15:05 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 16:15:05 INFO - Using env: {'DISPLAY': ':0', 16:15:05 INFO - 'HOME': '/home/cltbld', 16:15:05 INFO - 'LANG': 'en_US.UTF-8', 16:15:05 INFO - 'LANGUAGE': 'en_US:en', 16:15:05 INFO - 'LOGNAME': 'cltbld', 16:15:05 INFO - 'MAIL': '/var/mail/cltbld', 16:15:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:15:05 INFO - 'MOZ_NO_REMOTE': '1', 16:15:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:15:05 INFO - 'NO_EM_RESTART': '1', 16:15:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:15:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:15:05 INFO - 'PWD': '/builds/slave/test', 16:15:05 INFO - 'SHELL': '/bin/bash', 16:15:05 INFO - 'SHLVL': '1', 16:15:05 INFO - 'TERM': 'linux', 16:15:05 INFO - 'TMOUT': '86400', 16:15:05 INFO - 'USER': 'cltbld', 16:15:05 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1476486873.881300-2135266699', 16:15:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:15:05 INFO - '_': '/tools/buildbot/bin/python'} 16:15:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:15:05 INFO - Running setup.py (path:/tmp/pip-wN6rxL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:15:05 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)) 16:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:15:05 INFO - Running setup.py (path:/tmp/pip-SuJ11z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:15:05 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)) 16:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:15:05 INFO - Running setup.py (path:/tmp/pip-DDaNXs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:15:05 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)) 16:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:15:05 INFO - Running setup.py (path:/tmp/pip-rZbw1O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:15:06 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)) 16:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:15:06 INFO - Running setup.py (path:/tmp/pip-kmjgOq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:15:06 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)) 16:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:15:06 INFO - Running setup.py (path:/tmp/pip-Y9ZLFB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:15:06 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)) 16:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:15:06 INFO - Running setup.py (path:/tmp/pip-dTsqhh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:15:06 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)) 16:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:15:06 INFO - Running setup.py (path:/tmp/pip-X0kPjg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:15:06 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)) 16:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:15:06 INFO - Running setup.py (path:/tmp/pip-DmEu3w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:15:06 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)) 16:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:15:06 INFO - Running setup.py (path:/tmp/pip-898Oho-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:15:06 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)) 16:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:15:06 INFO - Running setup.py (path:/tmp/pip-mB02_w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:15:06 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)) 16:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:15:06 INFO - Running setup.py (path:/tmp/pip-5Y289R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:15:06 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)) 16:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:15:06 INFO - Running setup.py (path:/tmp/pip-1_1EV_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:15:06 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)) 16:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:15:06 INFO - Running setup.py (path:/tmp/pip-76cdVu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:15:06 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)) 16:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:15:06 INFO - Running setup.py (path:/tmp/pip-fQaiW1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:15:06 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)) 16:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:15:06 INFO - Running setup.py (path:/tmp/pip-OiJN6w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:15:06 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)) 16:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:15:06 INFO - Running setup.py (path:/tmp/pip-kWbX88-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:15:06 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)) 16:15:06 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)) 16:15:06 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)) 16:15:06 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)) 16:15:06 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)) 16:15:06 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)) 16:15:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:15:06 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 16:15:06 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 16:15:06 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 16:15:06 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 16:15:06 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 16:15:06 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 16:15:08 INFO - Downloading blessings-1.6.tar.gz 16:15:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:15:08 INFO - Installing collected packages: blessings 16:15:08 INFO - Running setup.py install for blessings 16:15:09 INFO - Successfully installed blessings 16:15:09 INFO - Cleaning up... 16:15:09 INFO - Return code: 0 16:15:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:15:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:15:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:15:09 INFO - Reading from file tmpfile_stdout 16:15:09 INFO - Current package versions: 16:15:09 INFO - argparse == 1.2.1 16:15:09 INFO - blessings == 1.6 16:15:09 INFO - blobuploader == 1.2.4 16:15:09 INFO - docopt == 0.6.1 16:15:09 INFO - functools32 == 3.2.3-2 16:15:09 INFO - jsonschema == 2.5.1 16:15:09 INFO - manifestparser == 1.1 16:15:09 INFO - mozInstall == 1.12 16:15:09 INFO - mozcrash == 0.17 16:15:09 INFO - mozdebug == 0.1 16:15:09 INFO - mozdevice == 0.48 16:15:09 INFO - mozfile == 1.2 16:15:09 INFO - mozhttpd == 0.7 16:15:09 INFO - mozinfo == 0.9 16:15:09 INFO - mozleak == 0.1 16:15:09 INFO - mozlog == 3.4 16:15:09 INFO - moznetwork == 0.27 16:15:09 INFO - mozprocess == 0.23 16:15:09 INFO - mozprofile == 0.28 16:15:09 INFO - mozrunner == 6.12 16:15:09 INFO - mozscreenshot == 0.1 16:15:09 INFO - mozsystemmonitor == 0.3 16:15:09 INFO - moztest == 0.7 16:15:09 INFO - mozversion == 1.4 16:15:09 INFO - psutil == 3.1.1 16:15:09 INFO - requests == 1.2.3 16:15:09 INFO - wsgiref == 0.1.2 16:15:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:15:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:15:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:15:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:15:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:15:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:15:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:15:09 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 0x7f4b3f143f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c6f7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cfe790>, '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 0x2cff690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cffb20>, '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': 'cbe409c6de289db6ac707de3000001d4-1476486873.881300-2135266699', '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 16:15:09 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 16:15:09 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 16:15:09 INFO - Using env: {'DISPLAY': ':0', 16:15:09 INFO - 'HOME': '/home/cltbld', 16:15:09 INFO - 'LANG': 'en_US.UTF-8', 16:15:09 INFO - 'LANGUAGE': 'en_US:en', 16:15:09 INFO - 'LOGNAME': 'cltbld', 16:15:09 INFO - 'MAIL': '/var/mail/cltbld', 16:15:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:15:09 INFO - 'MOZ_NO_REMOTE': '1', 16:15:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:15:09 INFO - 'NO_EM_RESTART': '1', 16:15:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:15:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:15:09 INFO - 'PWD': '/builds/slave/test', 16:15:09 INFO - 'SHELL': '/bin/bash', 16:15:09 INFO - 'SHLVL': '1', 16:15:09 INFO - 'TERM': 'linux', 16:15:09 INFO - 'TMOUT': '86400', 16:15:09 INFO - 'USER': 'cltbld', 16:15:09 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1476486873.881300-2135266699', 16:15:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:15:09 INFO - '_': '/tools/buildbot/bin/python'} 16:15:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:15:09 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)) 16:15:09 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)) 16:15:09 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)) 16:15:09 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)) 16:15:09 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)) 16:15:09 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)) 16:15:09 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)) 16:15:09 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)) 16:15:09 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)) 16:15:09 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)) 16:15:09 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)) 16:15:09 INFO - Cleaning up... 16:15:09 INFO - Return code: 0 16:15:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:15:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:15:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:15:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:15:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:15:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:15:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:15:09 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 0x7f4b3f143f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c6f7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cfe790>, '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 0x2cff690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cffb20>, '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': 'cbe409c6de289db6ac707de3000001d4-1476486873.881300-2135266699', '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 16:15:09 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 16:15:09 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 16:15:09 INFO - Using env: {'DISPLAY': ':0', 16:15:09 INFO - 'HOME': '/home/cltbld', 16:15:09 INFO - 'LANG': 'en_US.UTF-8', 16:15:09 INFO - 'LANGUAGE': 'en_US:en', 16:15:09 INFO - 'LOGNAME': 'cltbld', 16:15:09 INFO - 'MAIL': '/var/mail/cltbld', 16:15:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:15:09 INFO - 'MOZ_NO_REMOTE': '1', 16:15:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:15:09 INFO - 'NO_EM_RESTART': '1', 16:15:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:15:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:15:09 INFO - 'PWD': '/builds/slave/test', 16:15:09 INFO - 'SHELL': '/bin/bash', 16:15:09 INFO - 'SHLVL': '1', 16:15:09 INFO - 'TERM': 'linux', 16:15:09 INFO - 'TMOUT': '86400', 16:15:09 INFO - 'USER': 'cltbld', 16:15:09 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1476486873.881300-2135266699', 16:15:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:15:09 INFO - '_': '/tools/buildbot/bin/python'} 16:15:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:15:09 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:15:09 INFO - Cleaning up... 16:15:09 INFO - Return code: 0 16:15:09 INFO - Running post-action listener: _resource_record_post_action 16:15:09 INFO - Running post-action listener: _start_resource_monitoring 16:15:09 INFO - Starting resource monitoring. 16:15:09 INFO - [mozharness: 2016-10-14 23:15:09.854476Z] Finished create-virtualenv step (success) 16:15:09 INFO - [mozharness: 2016-10-14 23:15:09.854977Z] Running install step. 16:15:09 INFO - Running pre-action listener: _resource_record_pre_action 16:15:09 INFO - Running main action method: install 16:15:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:15:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:15:10 INFO - Reading from file tmpfile_stdout 16:15:10 INFO - Detecting whether we're running mozinstall >=1.0... 16:15:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:15:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:15:10 INFO - Reading from file tmpfile_stdout 16:15:10 INFO - Output received: 16:15:10 INFO - Usage: mozinstall [options] installer 16:15:10 INFO - Options: 16:15:10 INFO - -h, --help show this help message and exit 16:15:10 INFO - -d DEST, --destination=DEST 16:15:10 INFO - Directory to install application into. [default: 16:15:10 INFO - "/builds/slave/test"] 16:15:10 INFO - --app=APP Application being installed. [default: firefox] 16:15:10 INFO - mkdir: /builds/slave/test/build/application 16:15:10 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'] 16:15:10 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 16:15:27 INFO - Reading from file tmpfile_stdout 16:15:27 INFO - Output received: 16:15:27 INFO - /builds/slave/test/build/application/firefox/firefox 16:15:27 INFO - Running post-action listener: _resource_record_post_action 16:15:27 INFO - [mozharness: 2016-10-14 23:15:27.147848Z] Finished install step (success) 16:15:27 INFO - [mozharness: 2016-10-14 23:15:27.148121Z] Running run-tests step. 16:15:27 INFO - Running pre-action listener: _resource_record_pre_action 16:15:27 INFO - Running main action method: run_tests 16:15:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:15:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:15:27 INFO - Python 2.7.3 16:15:27 INFO - Return code: 0 16:15:27 INFO - grabbing minidump binary from tooltool 16:15:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:15:27 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 0x2cfe790>, '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 0x2cff690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cffb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:15:27 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 16:15:27 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 16:15:27 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 16:15:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:15:27 INFO - Return code: 0 16:15:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:15:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:15:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:15:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:15:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:15:27 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/1476473404/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--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 16:15:27 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/1476473404/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-054 --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 16:15:27 INFO - Using env: {'DISPLAY': ':0', 16:15:27 INFO - 'HOME': '/home/cltbld', 16:15:27 INFO - 'LANG': 'en_US.UTF-8', 16:15:27 INFO - 'LANGUAGE': 'en_US:en', 16:15:27 INFO - 'LOGNAME': 'cltbld', 16:15:27 INFO - 'MAIL': '/var/mail/cltbld', 16:15:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:15:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:15:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:15:27 INFO - 'MOZ_NO_REMOTE': '1', 16:15:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:15:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:15:27 INFO - 'NO_EM_RESTART': '1', 16:15:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:15:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:15:27 INFO - 'PWD': '/builds/slave/test', 16:15:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:15:27 INFO - 'SHELL': '/bin/bash', 16:15:27 INFO - 'SHLVL': '1', 16:15:27 INFO - 'TERM': 'linux', 16:15:27 INFO - 'TMOUT': '86400', 16:15:27 INFO - 'USER': 'cltbld', 16:15:27 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1476486873.881300-2135266699', 16:15:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:15:27 INFO - '_': '/tools/buildbot/bin/python'} 16:15:27 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/1476473404/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--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 16:15:27 INFO - mozversion application_buildid: 20161014123004 16:15:27 INFO - mozversion application_changeset: e412b386433b8c8ba83a28a1df310d9ad0b20285 16:15:27 INFO - mozversion application_display_name: Nightly 16:15:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:15:27 INFO - mozversion application_name: Firefox 16:15:27 INFO - mozversion application_remotingname: firefox 16:15:27 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 16:15:27 INFO - mozversion application_vendor: Mozilla 16:15:27 INFO - mozversion application_version: 52.0a1 16:15:27 INFO - mozversion platform_buildid: 20161014123004 16:15:27 INFO - mozversion platform_changeset: e412b386433b8c8ba83a28a1df310d9ad0b20285 16:15:27 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 16:15:27 INFO - mozversion platform_version: 52.0a1 16:15:27 INFO - using testdate: 1476486927 16:15:27 INFO - actual date: 1476486927 16:15:27 INFO - starting webserver on 'localhost:34652' 16:15:27 INFO - SUITE-START | Running 2 tests 16:15:27 INFO - TEST-START | dromaeo_css 16:15:27 INFO - operating with platform_type : linux_ 16:15:27 INFO - Initialising browser for dromaeo_css test... 16:15:27 INFO - TEST-INFO | started process 5151 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpq2lHoe/profile http://localhost:34652/getInfo.html) 16:15:31 INFO - PROCESS | 5151 | __metrics Screen width/height:1600/1200 16:15:31 INFO - PROCESS | 5151 | colorDepth:24 16:15:31 INFO - PROCESS | 5151 | Browser inner width/height: 1024/697 16:15:31 INFO - PROCESS | 5151 | __metrics 16:15:32 INFO - PROCESS | 5151 | 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" 16:15:32 INFO - PROCESS | 5151 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:15:33 INFO - TEST-INFO | 5151: exit 0 16:15:33 INFO - Browser initialized. 16:15:33 INFO - Running cycle 1/1 for dromaeo_css test... 16:15:33 INFO - TEST-INFO | started process 5233 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpq2lHoe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:15:45 INFO - PROCESS | 5233 | RSS: Main: 172417024 16:15:45 INFO - PROCESS | 5233 | 16:16:37 INFO - PROCESS | 5233 | 1476486997168 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] 16:18:46 INFO - PROCESS | 5233 | Cycle 1(1): loaded http://localhost:34652/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34652/tests/dromaeo/cssquery-ext.html) 16:18:49 INFO - PROCESS | 5233 | RSS: Main: 433713152 16:18:49 INFO - PROCESS | 5233 | 16:21:52 INFO - PROCESS | 5233 | Cycle 1(1): loaded http://localhost:34652/tests/dromaeo/cssquery-ext.html (next: http://localhost:34652/tests/dromaeo/cssquery-jquery.html) 16:21:52 INFO - PROCESS | 5233 | RSS: Main: 287485952 16:21:52 INFO - PROCESS | 5233 | 16:24:54 INFO - PROCESS | 5233 | Cycle 1(1): loaded http://localhost:34652/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34652/tests/dromaeo/cssquery-mootools.html) 16:24:55 INFO - PROCESS | 5233 | RSS: Main: 217800704 16:24:55 INFO - PROCESS | 5233 | 16:27:57 INFO - PROCESS | 5233 | Cycle 1(1): loaded http://localhost:34652/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34652/tests/dromaeo/cssquery-prototype.html) 16:27:58 INFO - PROCESS | 5233 | RSS: Main: 277303296 16:27:58 INFO - PROCESS | 5233 | 16:31:00 INFO - PROCESS | 5233 | Cycle 1(1): loaded http://localhost:34652/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34652/tests/dromaeo/cssquery-yui.html) 16:31:01 INFO - PROCESS | 5233 | RSS: Main: 219316224 16:31:01 INFO - PROCESS | 5233 | 16:34:04 INFO - PROCESS | 5233 | Cycle 1(1): loaded http://localhost:34652/tests/dromaeo/cssquery-yui.html (next: http://localhost:34652/tests/dromaeo/cssquery-dojo.html) 16:34:05 INFO - PROCESS | 5233 | RSS: Main: 309190656 16:34:05 INFO - PROCESS | 5233 | 16:34:05 INFO - PROCESS | 5233 | __start_tp_report 16:34:05 INFO - PROCESS | 5233 | _x_x_mozilla_page_load 16:34:05 INFO - PROCESS | 5233 | _x_x_mozilla_page_load_details 16:34:05 INFO - PROCESS | 5233 | |i|pagename|runs| 16:34:05 INFO - PROCESS | 5233 | |0;dojo.html;2950.7491863191626;2978.9702102978963;2998.610180676512;3016.381641763439;3024.0625406124104;5143.81996630118;5178.171492561191;5269.314989051428;5289.841304760854;5375.89248215035;5269.525742683158;5281.023010743005;5345.572354211664;5354.5716342692585;5377.542908852753;4704.341392205094;4779.976100119512;4820.228763397857;4831.758412079382;4842.927356089662;4832.830850920219;4832.951670483285;4894.902101957959;4897.559219670229;4951.777170027357;4718.504557021498;4829.348038014893;4842.273658951185;4877.146499362615;4946.356973593428;4734.573888350065;4811.398575178103;4820.156472617278;4831.782569784333;4857.1742803723455;4784.067106914154;4785.928211076836;4790.496997815214;4848.539388758062;4854.975725121351;5255.553277971377;5283.947160528384;5286.497782710675;5292.126799078147;5292.417834038252;5473.2063850741815;5534.584906132056;5558.527525160366;5612.943870561283;5649.435056494359;5646.604737668365;5648.4633959773755;5651.547876169897;5699.629524080963;5718.685472299022;5292.126799078147;5293.7617807198385;5295.4969277918535;5296.655717378358;5299.470052994747;5624.3250809903075;5688.77244910199;5722.685252311079;5752.741126649227;5812.38969908162;5568.777248910079;5569.053260945649;5570.832875013756;5620.775168993195;5626.521745651584;5603.299587551556;5604.327480702342;5639.859003524863;5653.575981801381;5655.773769049274;5483.917741233885;5506.504414602705;5660.915086273709;5667.064934285879;5669.092945128759;5565.1374037024325;5586.1062230043;5609.411011843779;5627.803026894039;5701.173329867146;4306.440162778881;4318.201132790444;4326.610605045561;4358.3244597087505;4372.1692878353015;3893.9610603894166;3896.9610303897166;3914.451976723261;3948.3879998600264;3968.3650615901315;5148.073346797612;5153.072446959508;5198.584113270929;5309.177077552986;5345.572354211654;5550.333959924754;5560.610757247035;5598.076317407664;5647.774089036392;5652.293463317085;5307.469253074739;5332.973335133377;5333.893322133613;5342.252084708144;5342.6260161788305;4805.639577031737;4807;4808.735519546459;4814.061258054716;4869.561739443467;5696.060150075191;5760.8271751847515;5764.308283005982;5829.038208695518;5846.503047241032;5569.888602228014;5649.12438572022;5656.490915817596;5657.43425657431;5659.688717120598;5808.419158084158;5813.3605303417435;5815.854603634943;5821.592488525932;5824.650520968756;5474.178873169057;5554.861128471821;5556.611037227355;5556.805511807067;5559.63862348946;5556.083246264483;5558.666480011212;5562.5549956002615;5563.888722225452;5565.332160140809;5449;5453.61824672285;5495.422980587141;5510.256115424367;5581.944180558305;5484.149956756709;5494.395616482104;5495.450454954473;5496.148097044965;5505.944940550543;5470.507654311131;5473.233747275305;5476.507114359727;5478.753456094406;5538.363088244903;5403.918941215807;5501.3948465667945;5514.944850551443;5583.246261754611;5589.664620122806;5291.3121294231505;5312.415634280149;5313.548348390275;5316.574674025991;5317.335333083364 16:34:05 INFO - PROCESS | 5233 | |1;ext.html;585.6632436349099;622.0451606783587;622.9876450767506;633.8478765096376;637.7959053103009;31708.52437213441;35019.29961400774;35031.4745278821;35045.64954350456;35060.29879402411;36054;45101.77449112758;46369.30446043312;46417;49706.254406183936;8725.912740872605;8852.247558957464;8852.645894164225;8859.335549833757;8860.20258176764;8742.694005709802;8833.60248788806;8837.248833849131;8842.381033327669;8845.469271843678;7893.289603935645;8035.919640803576;8040.155783642721;8257.83484330313;8270.255676989069;10372.481375931211;10610.469476526143;10632.681019569425;11070.557177712883;11071.446427678664;10512.211584131144;10600.575976960912;10605.575776968912;10606.628767993161;10606.628767993161;42627.36058959118;42953.57046429558;42980.355294670604;43038.78480607577;43082.35376469355;3457.4468085106264;3743.756655817363;4034.798260087013;4058.3506638937924;4208.179405016023;31977.52033719496;32612;32870.178245543815;33166.502502462485;34308.82845585781;3988.122613025159;4029.435878976946;4052.736572122832;4076.490438695163;4103.056297051665;344429;344857;345577;345933;346890;55335.44664553383;55551.72224138853;55600.32796064498;55623.44376556264;55645;35561.28877422437;36547.63452365495;36552.81723591365;38477;63690.36309636937;15296.770548441782;15583.454579089905;15598;15608.843911560965;15609.921950390175;11709.76580468403;11785.292882426911;11805.704857378634;11813.40932953366;11820.054395648327;18911.338103166323;18924.71612925807;19405.479615591372;19485.415437536896;19520.38417088429;6042.577019608585;6771.830704232433;6912.585244885323;7067.646617669096;7072.3634872861685;911.8449863523084;920.3419555018194;1087.374759513283;1110.161827820007;1121.7644294698205;28727.712722872922;31873.840630796698;31977;32475.18812029671;32569.837150814095;1046.884842667306;1050.2753100360726;1072.2922870905165;1135.0238794636605;1156.7628636129573;15464.381424742884;16755.2460139294;16845.747313790303;16870.409535666193;16882.577935551708;476925;478717;479185;479874;482932;59788.40211597915;60600.39399606036;60608.09087863685;60660.393396065476;60668.39331606716;1170.6897672116895;1205.2647884790447;1220.9023278137727;1270.371166272701;1291.6060601516629;22614.886925565268;30373.392532149675;31596.684033160294;31677.366452670358;31988.20029499188;57983.710081449324;59148.70425648017;59184;59207.703961479914;59341;438991;439535;441028;441306;441948;40631.39052914268;41057.38413923853;42392;42880.78559607182;43700;47271;47874.281885771044;48090;48696.2695559574;49171.508284916694;39316;39537.80231098826;41846.58153418427;42469.57530424656;42800.57199427966;40723.38914916338;41186.9703257409;41234.175316494104;41281.380779287734;42808.14383712246;41274.79362603168;42162.57837421587;42442.15115697731;42466.78766606147;42586.78706606447;34575.73909479038;35682.28635427329;37263.62736372602;37890.537115087434;39879.20241595094;28010.71989280081;28380.858095710217;28595.428091438473;28769.85615071911;28780.71219287864 16:34:05 INFO - PROCESS | 5233 | |2;jquery.html;381.94270859371073;391.92357490289385;404.80367021994334;405.15120821878156;419.36466253625764;13025.413856376463;15007.474738384159;16387.344506219753;19067.904660476714;19294.131764070615;18447.631047379044;18762.155702993365;19193;19396.03019849009;19405.41783746486;5590.580706447013;5688.914666280009;5936.376680448556;5936.792212272571;5939;5458.235846981426;5831.067029275317;5837.737301821407;5868.354481007107;5872.5889187756875;5704.629199102066;5709.571782116337;5797.072468405056;5834.649921004732;5837.50381217597;5729.197912292282;5807.738651760638;5816.185733997244;5822.941770582303;5826.912596311059;5003.524665156804;5127.435982041972;5184.7407629618365;5190.091733946582;5214.400343960455;18460.81539184618;18757.531061723428;18850.811491885044;22880.31359059214;22997.88501057484;2417.093589903786;2512.786413154866;2672.5189465896133;2765.7925655575914;2786.038816608267;13956.720865582733;14175.716485670331;14594.124352538882;14693.412263509446;15082;1869.392447454569;1899.3352326685688;1974.1905818614443;2013.2148462099792;2017.8284845788125;76461.23538764597;78929.60535197287;79180;79646.60176699137;79964;10687.625933092304;10710.571577136983;10839.945800270949;10938.33565755465;11029.44852757375;15359.846401535842;15360.078395296317;15364.462243821412;15366.385344586091;15367.538973830802;7491.288327608869;7753.79816128501;7828.882566761503;7867.921320786719;7900.288973992253;7212;7284.380827629605;7286.453515986323;7458.254174582498;7535.434842386843;4537.274036154199;4608.124456353282;4634.119517291704;4745.430548334153;4818.397700287464;1901.9239230430906;1906.8093190681097;1923.5960448305732;1956.4032969944303;1963.244151001846;749.9887501687479;800.2437696376868;888.2760550151735;1024.1294899335653;1046.1264843855313;18984.240630374905;19376;19399;19490.415287541113;19634.607307853763;990.0841721407669;991.8462638291077;999.0658734083655;1017.9694609161737;1024.3802499487851;10518.368897866152;10866.348019118721;10937.179711521509;10993.835092473619;11050.723731906766;420423;424128;433325;433666;436194.11379463365;86384.56807715922;89160;90143;90394;91391;970.69908328417;993.1310103659298;1013.2856336282903;1015.8831734350497;1019.4800651667555;16366.345346186019;16851;17117.486475405756;17161.656766864842;17371.730884407763;37211.81394093012;40640;40722.59277407188;41031.58968410278;41397;51072.489275106775;53572.464275356746;56396.154057689986;58435.70782146232;58466.70766646139;8007;8370.832583348421;8379.832403351777;8669.133086691532;8814.33892458081;12327.69180770488;13194.736105278032;13328.200307981551;13403.262820544964;13405.597832065054;11519.654410367702;11789.528418863149;11848.407579620813;11924.582639607572;12209.145359824726;11519.94240028828;11725.83816586635;11756;11761.294322340687;12129.090318225992;11300.265482743594;11591.18861679708;11948.163628545919;12175.75648487043;12273.202241854251;8420.62107205165;8471;8713.825723485368;8752.168543988566;8823.867641985504;11102.666919992413;11264.436778160894;11370.658880233606;11441.885581144083;11453.484593193492 16:34:05 INFO - PROCESS | 5233 | |3;mootools.html;1482.0737039350406;1505.3000354835003;1654.7435147552126;1794.2733193056818;1806.2052696813394;7959.48263362881;8200.753977380688;8760.211580957712;9473.100055494735;9486.00396958319;8745.91254087459;9068.365214434993;9106.271498280139;9298.721038368843;9312.8603070954;2327.848689835164;2328.2433209206993;2340.625499920013;2357.174988753931;2359.7994170495444;2032.552838375555;2072.274703853654;2311.861288322706;2332.2070496031347;2374.6675465434855;2069.8240649544805;2121.448423409917;2250.324902529243;2298.7011688480557;2311.6185829338137;2261.6155253606844;2266.1275408967504;2271.7728227177317;2272.6591011348264;2272.9204477843364;2223.655333423322;2227.231605096239;2236.731592208929;2241.3724157236;2242.798148166673;8957.238634716057;9117.133872282122;9126.77183070422;9129.680461183827;9137.223336016446;5097.337346144977;5237;5241.318628578299;5242.895142097175;5243.947560524422;3350.430426827421;3374.4769560718128;3483.425234836249;3507.7719948203285;3519.8416071276856;1131.519104380643;1141.5547936304847;1161.7444162284285;1168.3398879633064;1189.2032338333338;12670.556530521388;12698.238105713686;12735.617931462071;12744.553940612126;12769.297688627123;4703.318018887242;4746.38297021385;4845.63657725672;4847.497529067593;4894.951050489521;10747.677569672922;10794.244402891722;10862.34825910448;10881.183911206692;10884.183686223565;5336.386315573759;5339.492748188994;5350.9732451337495;5351.57187425005;5352.705601191894;4903.95096049035;4925.532074452921;4926.211806111005;4935.851924442272;5038.470960549163;3767.9058023549082;3810.8094595270127;3843.0776613612534;3888.844446222176;3893.3186692328727;1147.17976646698;1158.3918442817587;1161.4715304536417;1166.859976802772;1168.8831116888414;739.2755100002028;800.3237264511479;923;943.7440829139496;970.5001924009141;5816.534677225812;5835.328937172195;5906.616069955439;6125.816225513242;6127.96936015326;483.19065565178187;492.6083763408099;495.9404871415453;499.5529001543598;638.9042791612314;3961.8811435656976;4094.4472496213225;4121.793910304473;4128.876133715993;4140.3375459926265;11193.552257909756;11670.358130302915;11723.179377443668;11731.706707332385;11736.530538778525;11588.36264005471;11605.071594272438;11627.476763545661;11645.417729113511;11652.76694466106;8094.757157285291;8381.41330106899;8391.8321633567;8470.449420787629;8591.05498395176;6038.396160383926;6187.226596675416;6232.75068997235;6249.531285153541;6333.683315834098;10203.13273371742;10596.8940310599;10627.628033018807;10705.625303114664;10714.357138571711;10892.40091794959;10916;10933.125349971824;10940.124790016938;10947.397893115955;8165.510069395856;8247.298979586802;8262.091169971178;8276.668933242603;8286.46138001028;8548.273396761097;8569.871451928102;8921.15249051339;8975.102489750972;8976.237019853124;7695.57674327895;7848.686052557834;7899.368050556057;8006.359491240571;8121.309688676529;7708.537487750753;7775.339096176888;7805;7869.803254918673;7931.5637639930355;7112.822179445348;7233.9638301810255;7241.710331586678;7250.456215783943;7251.057362542836;5094.541491265803;5104.69371837691;5122.334096567422;5178.0679477694375;5385.515303622536;5161.380634323905;5330.067238233371;5398.568114550905;5399.78400863961;5420 16:34:05 INFO - PROCESS | 5233 | |4;prototype.html;289.3619568850686;307.6492798210041;312.3456358928045;313.86503803364553;314.2097624474447;5048.980407836867;5050.520200580939;5179.896402071956;5229.60777941654;5251.763670634821;5134.794608215676;5162.612804039693;5181.171012637969;5183.2743415921805;5200.193969934657;4106.445629839964;4107.958920410802;4116.526599441057;4125.484314460692;4127.752334859903;3935.77628639819;4071.735337203087;4103.569125241851;4117.135401565675;4119.752814831105;4070.409790580364;4080.469538959931;4081.7346872453345;4084.2035803018275;4107.055377263231;4066.9593304066875;4076.2866498362964;4076.612721791425;4086.6309786221354;4090.1819636072905;3606.8737594184076;3614.150674591469;3628.5282913221376;3635.0367152704553;3641.8725344612812;5010.473900240495;5050.166722490784;5056.544910958031;5076.720780357079;5078.873028174288;4579.138038725796;4579.22153233951;4590.059037897223;4601.5735122112255;4615.423072115986;5432.375276843174;5446.754896029688;5455.372632147314;5462.126059830408;5493.313335833021;3812.093953023488;3940.468036815022;3964.108075682977;3969.2458432897656;3970.861019864291;5525.502704756551;5579.609427340048;5640.548756099543;5672.808710170869;5693.77224911003;3986.3422535281934;3987.960120398817;3989.84040638377;4019.4975628046495;4060.1879624075304;3976.383660532622;4025.2150830587752;4069.2268468990796;4070.3773641459125;4132.772697501667;4604.194266003436;4626.542639068683;4631.930521042187;4639.584926597353;4647.581717645428;5468.7539060742365;5473.397926228112;5474.835754927359;5496.477834605706;5553.805616803393;1333.926634035118;1357.2806412601337;1375.6492094516034;1381.866869167273;1401.6215621782062;959.8128364968903;960.2558017536466;984.2126298960802;984.7981163861391;988.5353883674661;5278.788848446096;5281.867953301198;5283.52448279649;5285.070949103627;5293.391260005072;5554.750181209196;5558.916011377823;5568.693721845338;5581.358143813432;5596.2165296858475;5105.3407642515585;5269.762860671202;5273.209018647233;5292.2326262691695;5337.733113344318;2971.7176868197485;2993.533168747298;3000;3003.234175285288;3011.4278287125812;5859.542869706894;5868.794592189338;5876.794312199053;5881.176635271066;5908.379620139824;5518.227448157261;5633.845061762328;5657.660540367591;5674.886502269931;5711.6858572778065;5779;5785.479306862402;5796.304443466811;5806.332271788799;5812.302523697268;5370.812021579226;5551.833444996657;5616.5787565931905;5639.436056394327;5656.37779844225;5534.086875665631;5535.114381698909;5542.528885044816;5547.722613869371;5550.222968784454;5774.354309021908;5804.287735118235;5806.76772929095;5823.621464604787;5844.415558444121;3842.423636454554;3886.5530463997;3907.374820028782;3932.9606703932595;3938.9955561331676;5331.613780417042;5563.248961390161;5580.190872323572;5596.817241275824;5603.3836278008575;5327.706976116196;5361.35663720356;5395.919061214006;5468;5469.808556700496;5409.7024663642305;5430.5384042356845;5442.374126975448;5451.182322651634;5458.454154584669;5200.375954885438;5381.165919282517;5408.161734931092;5431.646942948696;5439.0753571893665;5480.72596370172;5481;5486.91769623448;5495.005222154015;5495.945040549704;5327.600429967691;5353.571714262927;5359.142537194186;5364.517193452608;5382.246485491956 16:34:05 INFO - PROCESS | 5233 | |5;yui.html;641.9967900160501;671.7010930136088;725.7169703815512;745.1058729524572;745.9780101261273;14381.2809359532;15169;15459.613509662237;15484.69030619387;15487.845121548795;14509.854901450983;14656.633584160401;14665.780013299809;14747.262636868167;15136.924315378435;658.2791842932006;800.3397197312227;813.8657121574932;816.1185919207242;817.6770175780563;677.3023785500917;789.6091434739811;811.1320886651285;817.6565842346199;819.2585709932491;869.1829680100717;871.5772850167664;871.8430682477151;871.9912800871973;872.9301655867547;692.3595674001529;859.2138193552954;860.724568138196;861.0485413617956;861.2421069458867;517.7902949305537;599.9340072592012;614.3181069013392;617.200725061047;619.9256089269271;13237.602871913858;13280.601581952556;13284.800727989088;13717.862821371858;13742.587722368346;13988;14509.70980580393;14614.488492902698;14641.48754793577;15095;13430.664233394145;13476.39356228972;13613.727725445535;13828.654283642889;14372;4504;4527.3661687363465;4548.2495388260895;4655.324977878223;4774.092922344744;77770.22229777744;77861.61069194617;77997;78163;78234;11319.547218111347;11476.19666623345;11493.806508145151;12198.14612977083;12219.26684398939;22402.327930162122;22413.66379504309;22417.10331586718;22440;22450.32649020532;8202.17978202175;8294.626741796634;8389.244967952913;8391.16088391156;8410.201030902055;4466.441694788152;4718.598919091915;4781.474037855903;4817.325574419514;4824.228123500223;3415.1462134466383;3499.8775042873376;3539.7168226541817;3546.414841551167;3566.892993210208;587.2336600735995;589.8201048680194;591.6982339007051;593.2791658135386;594.5956749410442;605.8333958161453;613.5643692977947;671.1677519875319;676.9864206817368;709.8048036789924;8804.207621314112;9051.456912585267;9112.225460835904;9232.95383523078;9391.389559678599;559.3958524793213;638.5211091681239;666.4068978609042;676.4284179868004;710.8329542557495;4506.662000349987;4728.905421891543;4750.881227969328;4816.8795780105775;4844.975775121173;61334.38665613287;103438.48280758547;103595;103617.48191259147;104555;73576.63211683907;83783.16216837753;83970.16029839624;84918;87901;82578.02618620386;83005;83858;84462;85137;9232.353735238468;9336.159745622926;9455.14903658674;9464.242860571276;9471.10024547667;35081.94754157379;46361.76819115883;47626;48219;49678.28056334642;66423;68272.6586367065;68383.65808170928;68890;69759.30240697529;13185.53850615224;13191.076624636184;13202.273874936971;13296.268705221306;13578.93210533941;14047.297635118408;14141.858581414053;14217.004809663224;15219.695606088038;15285.694286114438;13016.934915325362;13183.274919879499;13324.40040198174;13350.866491335351;14776.261186940825;13609.79585306241;14086.436542538184;14234.715305694035;14670.853291466949;14807.92689023516;13335.533256335983;13450.663733406744;13753.79369309441;13907.374168162254;14137.505187318395;10530;10803.081738052353;10813.62152324665;11213.766768330417;11312.547498099984;11040.74656286629;11640.301581905112;11921.403929803648;11992.920637142699;12055.457504412147 16:34:05 INFO - PROCESS | 5233 | __end_tp_report 16:34:05 INFO - PROCESS | 5233 | __start_cc_report 16:34:05 INFO - PROCESS | 5233 | _x_x_mozilla_cycle_collect,2853 16:34:05 INFO - PROCESS | 5233 | __end_cc_report 16:34:05 INFO - PROCESS | 5233 | __startTimestamp1476488045207__endTimestamp 16:34:05 INFO - PROCESS | 5233 | 16:34:05 INFO - PROCESS | 5233 | ------- Summary: start ------- 16:34:05 INFO - PROCESS | 5233 | Number of tests: 6 16:34:05 INFO - PROCESS | 5233 | 16:34:05 INFO - PROCESS | 5233 | [#0] dojo.html Cycles:165 Average:5229.76 Median:5453.62 stddev:583.15 (10.7%) stddev-sans-first:556.86 16:34:05 INFO - PROCESS | 5233 | Values: 2950.7 2979.0 2998.6 3016.4 3024.1 5143.8 5178.2 5269.3 5289.8 5375.9 5269.5 5281.0 5345.6 5354.6 5377.5 4704.3 4780.0 4820.2 4831.8 4842.9 4832.8 4833.0 4894.9 4897.6 4951.8 4718.5 4829.3 4842.3 4877.1 4946.4 4734.6 4811.4 4820.2 4831.8 4857.2 4784.1 4785.9 4790.5 4848.5 4855.0 5255.6 5283.9 5286.5 5292.1 5292.4 5473.2 5534.6 5558.5 5612.9 5649.4 5646.6 5648.5 5651.5 5699.6 5718.7 5292.1 5293.8 5295.5 5296.7 5299.5 5624.3 5688.8 5722.7 5752.7 5812.4 5568.8 5569.1 5570.8 5620.8 5626.5 5603.3 5604.3 5639.9 5653.6 5655.8 5483.9 5506.5 5660.9 5667.1 5669.1 5565.1 5586.1 5609.4 5627.8 5701.2 4306.4 4318.2 4326.6 4358.3 4372.2 3894.0 3897.0 3914.5 3948.4 3968.4 5148.1 5153.1 5198.6 5309.2 5345.6 5550.3 5560.6 5598.1 5647.8 5652.3 5307.5 5333.0 5333.9 5342.3 5342.6 4805.6 4807.0 4808.7 4814.1 4869.6 5696.1 5760.8 5764.3 5829.0 5846.5 5569.9 5649.1 5656.5 5657.4 5659.7 5808.4 5813.4 5815.9 5821.6 5824.7 5474.2 5554.9 5556.6 5556.8 5559.6 5556.1 5558.7 5562.6 5563.9 5565.3 5449.0 5453.6 5495.4 5510.3 5581.9 5484.1 5494.4 5495.5 5496.1 5505.9 5470.5 5473.2 5476.5 5478.8 5538.4 5403.9 5501.4 5514.9 5583.2 5589.7 5291.3 5312.4 5313.5 5316.6 5317.3 16:34:05 INFO - PROCESS | 5233 | 16:34:05 INFO - PROCESS | 5233 | [#1] ext.html Cycles:180 Average:58573.71 Median:4055.54 stddev:112502.76 (2774.0%) stddev-sans-first:112734.12 16:34:05 INFO - PROCESS | 5233 | Values: 585.7 622.0 623.0 633.8 637.8 31708.5 35019.3 35031.5 35045.6 35060.3 36054.0 45101.8 46369.3 46417.0 49706.3 8725.9 8852.2 8852.6 8859.3 8860.2 8742.7 8833.6 8837.2 8842.4 8845.5 7893.3 8035.9 8040.2 8257.8 8270.3 10372.5 10610.5 10632.7 11070.6 11071.4 10512.2 10600.6 10605.6 10606.6 10606.6 42627.4 42953.6 42980.4 43038.8 43082.4 3457.4 3743.8 4034.8 4058.4 4208.2 31977.5 32612.0 32870.2 33166.5 34308.8 3988.1 4029.4 4052.7 4076.5 4103.1 344429.0 344857.0 345577.0 345933.0 346890.0 55335.4 55551.7 55600.3 55623.4 55645.0 35561.3 36547.6 36552.8 38477.0 63690.4 15296.8 15583.5 15598.0 15608.8 15609.9 11709.8 11785.3 11805.7 11813.4 11820.1 18911.3 18924.7 19405.5 19485.4 19520.4 6042.6 6771.8 6912.6 7067.6 7072.4 911.8 920.3 1087.4 1110.2 1121.8 28727.7 31873.8 31977.0 32475.2 32569.8 1046.9 1050.3 1072.3 1135.0 1156.8 15464.4 16755.2 16845.7 16870.4 16882.6 476925.0 478717.0 479185.0 479874.0 482932.0 59788.4 60600.4 60608.1 60660.4 60668.4 1170.7 1205.3 1220.9 1270.4 1291.6 22614.9 30373.4 31596.7 31677.4 31988.2 57983.7 59148.7 59184.0 59207.7 59341.0 438991.0 439535.0 441028.0 441306.0 441948.0 40631.4 41057.4 42392.0 42880.8 43700.0 47271.0 47874.3 48090.0 48696.3 49171.5 39316.0 39537.8 41846.6 42469.6 42800.6 40723.4 41187.0 41234.2 41281.4 42808.1 41274.8 42162.6 42442.2 42466.8 42586.8 34575.7 35682.3 37263.6 37890.5 39879.2 28010.7 28380.9 28595.4 28769.9 28780.7 16:34:05 INFO - PROCESS | 5233 | 16:34:05 INFO - PROCESS | 5233 | [#2] jquery.html Cycles:180 Average:27015.33 Median:2775.92 stddev:71067.40 (2560.1%) stddev-sans-first:71238.63 16:34:05 INFO - PROCESS | 5233 | Values: 381.9 391.9 404.8 405.2 419.4 13025.4 15007.5 16387.3 19067.9 19294.1 18447.6 18762.2 19193.0 19396.0 19405.4 5590.6 5688.9 5936.4 5936.8 5939.0 5458.2 5831.1 5837.7 5868.4 5872.6 5704.6 5709.6 5797.1 5834.6 5837.5 5729.2 5807.7 5816.2 5822.9 5826.9 5003.5 5127.4 5184.7 5190.1 5214.4 18460.8 18757.5 18850.8 22880.3 22997.9 2417.1 2512.8 2672.5 2765.8 2786.0 13956.7 14175.7 14594.1 14693.4 15082.0 1869.4 1899.3 1974.2 2013.2 2017.8 76461.2 78929.6 79180.0 79646.6 79964.0 10687.6 10710.6 10839.9 10938.3 11029.4 15359.8 15360.1 15364.5 15366.4 15367.5 7491.3 7753.8 7828.9 7867.9 7900.3 7212.0 7284.4 7286.5 7458.3 7535.4 4537.3 4608.1 4634.1 4745.4 4818.4 1901.9 1906.8 1923.6 1956.4 1963.2 750.0 800.2 888.3 1024.1 1046.1 18984.2 19376.0 19399.0 19490.4 19634.6 990.1 991.8 999.1 1018.0 1024.4 10518.4 10866.3 10937.2 10993.8 11050.7 420423.0 424128.0 433325.0 433666.0 436194.1 86384.6 89160.0 90143.0 90394.0 91391.0 970.7 993.1 1013.3 1015.9 1019.5 16366.3 16851.0 17117.5 17161.7 17371.7 37211.8 40640.0 40722.6 41031.6 41397.0 51072.5 53572.5 56396.2 58435.7 58466.7 8007.0 8370.8 8379.8 8669.1 8814.3 12327.7 13194.7 13328.2 13403.3 13405.6 11519.7 11789.5 11848.4 11924.6 12209.1 11519.9 11725.8 11756.0 11761.3 12129.1 11300.3 11591.2 11948.2 12175.8 12273.2 8420.6 8471.0 8713.8 8752.2 8823.9 11102.7 11264.4 11370.7 11441.9 11453.5 16:34:05 INFO - PROCESS | 5233 | 16:34:05 INFO - PROCESS | 5233 | [#3] mootools.html Cycles:180 Average:5963.09 Median:4899.45 stddev:3518.56 (71.8%) stddev-sans-first:3512.31 16:34:05 INFO - PROCESS | 5233 | Values: 1482.1 1505.3 1654.7 1794.3 1806.2 7959.5 8200.8 8760.2 9473.1 9486.0 8745.9 9068.4 9106.3 9298.7 9312.9 2327.8 2328.2 2340.6 2357.2 2359.8 2032.6 2072.3 2311.9 2332.2 2374.7 2069.8 2121.4 2250.3 2298.7 2311.6 2261.6 2266.1 2271.8 2272.7 2272.9 2223.7 2227.2 2236.7 2241.4 2242.8 8957.2 9117.1 9126.8 9129.7 9137.2 5097.3 5237.0 5241.3 5242.9 5243.9 3350.4 3374.5 3483.4 3507.8 3519.8 1131.5 1141.6 1161.7 1168.3 1189.2 12670.6 12698.2 12735.6 12744.6 12769.3 4703.3 4746.4 4845.6 4847.5 4895.0 10747.7 10794.2 10862.3 10881.2 10884.2 5336.4 5339.5 5351.0 5351.6 5352.7 4904.0 4925.5 4926.2 4935.9 5038.5 3767.9 3810.8 3843.1 3888.8 3893.3 1147.2 1158.4 1161.5 1166.9 1168.9 739.3 800.3 923.0 943.7 970.5 5816.5 5835.3 5906.6 6125.8 6128.0 483.2 492.6 495.9 499.6 638.9 3961.9 4094.4 4121.8 4128.9 4140.3 11193.6 11670.4 11723.2 11731.7 11736.5 11588.4 11605.1 11627.5 11645.4 11652.8 8094.8 8381.4 8391.8 8470.4 8591.1 6038.4 6187.2 6232.8 6249.5 6333.7 10203.1 10596.9 10627.6 10705.6 10714.4 10892.4 10916.0 10933.1 10940.1 10947.4 8165.5 8247.3 8262.1 8276.7 8286.5 8548.3 8569.9 8921.2 8975.1 8976.2 7695.6 7848.7 7899.4 8006.4 8121.3 7708.5 7775.3 7805.0 7869.8 7931.6 7112.8 7234.0 7241.7 7250.5 7251.1 5094.5 5104.7 5122.3 5178.1 5385.5 5161.4 5330.1 5398.6 5399.8 5420.0 16:34:05 INFO - PROCESS | 5233 | 16:34:05 INFO - PROCESS | 5233 | [#4] prototype.html Cycles:180 Average:4601.08 Median:5282.70 stddev:1348.54 (25.5%) stddev-sans-first:1312.92 16:34:05 INFO - PROCESS | 5233 | Values: 289.4 307.6 312.3 313.9 314.2 5049.0 5050.5 5179.9 5229.6 5251.8 5134.8 5162.6 5181.2 5183.3 5200.2 4106.4 4108.0 4116.5 4125.5 4127.8 3935.8 4071.7 4103.6 4117.1 4119.8 4070.4 4080.5 4081.7 4084.2 4107.1 4067.0 4076.3 4076.6 4086.6 4090.2 3606.9 3614.2 3628.5 3635.0 3641.9 5010.5 5050.2 5056.5 5076.7 5078.9 4579.1 4579.2 4590.1 4601.6 4615.4 5432.4 5446.8 5455.4 5462.1 5493.3 3812.1 3940.5 3964.1 3969.2 3970.9 5525.5 5579.6 5640.5 5672.8 5693.8 3986.3 3988.0 3989.8 4019.5 4060.2 3976.4 4025.2 4069.2 4070.4 4132.8 4604.2 4626.5 4631.9 4639.6 4647.6 5468.8 5473.4 5474.8 5496.5 5553.8 1333.9 1357.3 1375.6 1381.9 1401.6 959.8 960.3 984.2 984.8 988.5 5278.8 5281.9 5283.5 5285.1 5293.4 5554.8 5558.9 5568.7 5581.4 5596.2 5105.3 5269.8 5273.2 5292.2 5337.7 2971.7 2993.5 3000.0 3003.2 3011.4 5859.5 5868.8 5876.8 5881.2 5908.4 5518.2 5633.8 5657.7 5674.9 5711.7 5779.0 5785.5 5796.3 5806.3 5812.3 5370.8 5551.8 5616.6 5639.4 5656.4 5534.1 5535.1 5542.5 5547.7 5550.2 5774.4 5804.3 5806.8 5823.6 5844.4 3842.4 3886.6 3907.4 3933.0 3939.0 5331.6 5563.2 5580.2 5596.8 5603.4 5327.7 5361.4 5395.9 5468.0 5469.8 5409.7 5430.5 5442.4 5451.2 5458.5 5200.4 5381.2 5408.2 5431.6 5439.1 5480.7 5481.0 5486.9 5495.0 5495.9 5327.6 5353.6 5359.1 5364.5 5382.2 16:34:05 INFO - PROCESS | 5233 | 16:34:05 INFO - PROCESS | 5233 | [#5] yui.html Cycles:180 Average:19514.00 Median:26200.05 stddev:26760.24 (102.1%) stddev-sans-first:26797.78 16:34:05 INFO - PROCESS | 5233 | Values: 642.0 671.7 725.7 745.1 746.0 14381.3 15169.0 15459.6 15484.7 15487.8 14509.9 14656.6 14665.8 14747.3 15136.9 658.3 800.3 813.9 816.1 817.7 677.3 789.6 811.1 817.7 819.3 869.2 871.6 871.8 872.0 872.9 692.4 859.2 860.7 861.0 861.2 517.8 599.9 614.3 617.2 619.9 13237.6 13280.6 13284.8 13717.9 13742.6 13988.0 14509.7 14614.5 14641.5 15095.0 13430.7 13476.4 13613.7 13828.7 14372.0 4504.0 4527.4 4548.2 4655.3 4774.1 77770.2 77861.6 77997.0 78163.0 78234.0 11319.5 11476.2 11493.8 12198.1 12219.3 22402.3 22413.7 22417.1 22440.0 22450.3 8202.2 8294.6 8389.2 8391.2 8410.2 4466.4 4718.6 4781.5 4817.3 4824.2 3415.1 3499.9 3539.7 3546.4 3566.9 587.2 589.8 591.7 593.3 594.6 605.8 613.6 671.2 677.0 709.8 8804.2 9051.5 9112.2 9233.0 9391.4 559.4 638.5 666.4 676.4 710.8 4506.7 4728.9 4750.9 4816.9 4845.0 61334.4 103438.5 103595.0 103617.5 104555.0 73576.6 83783.2 83970.2 84918.0 87901.0 82578.0 83005.0 83858.0 84462.0 85137.0 9232.4 9336.2 9455.1 9464.2 9471.1 35081.9 46361.8 47626.0 48219.0 49678.3 66423.0 68272.7 68383.7 68890.0 69759.3 13185.5 13191.1 13202.3 13296.3 13578.9 14047.3 14141.9 14217.0 15219.7 15285.7 13016.9 13183.3 13324.4 13350.9 14776.3 13609.8 14086.4 14234.7 14670.9 14807.9 13335.5 13450.7 13753.8 13907.4 14137.5 10530.0 10803.1 10813.6 11213.8 11312.5 11040.7 11640.3 11921.4 11992.9 12055.5 16:34:05 INFO - PROCESS | 5233 | -------- Summary: end -------- 16:34:05 INFO - PROCESS | 5233 | 16:34:06 INFO - TEST-INFO | 5233: exit 0 16:34:06 INFO - TEST-OK | dromaeo_css | took 1118789ms 16:34:06 INFO - TEST-START | kraken 16:34:06 INFO - operating with platform_type : linux_ 16:34:06 INFO - Initialising browser for kraken test... 16:34:06 INFO - TEST-INFO | started process 5544 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpv_ZcZC/profile http://localhost:34652/getInfo.html) 16:34:10 INFO - PROCESS | 5544 | __metrics Screen width/height:1600/1200 16:34:10 INFO - PROCESS | 5544 | colorDepth:24 16:34:10 INFO - PROCESS | 5544 | Browser inner width/height: 1024/697 16:34:10 INFO - PROCESS | 5544 | __metrics 16:34:11 INFO - PROCESS | 5544 | 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" 16:34:11 INFO - PROCESS | 5544 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:34:11 INFO - PROCESS | 5544 | console.error: PushService: 16:34:11 INFO - PROCESS | 5544 | stateChangeProcessEnqueue: Error transitioning state 16:34:11 INFO - PROCESS | 5544 | UnknownError 16:34:12 INFO - TEST-INFO | 5544: exit 0 16:34:12 INFO - Browser initialized. 16:34:12 INFO - Running cycle 1/1 for kraken test... 16:34:12 INFO - TEST-INFO | started process 5627 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpv_ZcZC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:34:24 INFO - PROCESS | 5627 | RSS: Main: 172236800 16:34:24 INFO - PROCESS | 5627 | 16:34:27 INFO - PROCESS | 5627 | Cycle 1(1): loaded http://localhost:34652/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34652/tests/kraken/driver.html?testName=audio-beat-detection) 16:34:27 INFO - PROCESS | 5627 | RSS: Main: 229572608 16:34:27 INFO - PROCESS | 5627 | 16:34:30 INFO - PROCESS | 5627 | Cycle 1(1): loaded http://localhost:34652/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34652/tests/kraken/driver.html?testName=audio-dft) 16:34:31 INFO - PROCESS | 5627 | RSS: Main: 216457216 16:34:31 INFO - PROCESS | 5627 | 16:34:34 INFO - PROCESS | 5627 | Cycle 1(1): loaded http://localhost:34652/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34652/tests/kraken/driver.html?testName=audio-fft) 16:34:34 INFO - PROCESS | 5627 | RSS: Main: 297746432 16:34:34 INFO - PROCESS | 5627 | 16:34:37 INFO - PROCESS | 5627 | Cycle 1(1): loaded http://localhost:34652/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34652/tests/kraken/driver.html?testName=audio-oscillator) 16:34:37 INFO - PROCESS | 5627 | RSS: Main: 209604608 16:34:37 INFO - PROCESS | 5627 | 16:34:39 INFO - PROCESS | 5627 | Cycle 1(1): loaded http://localhost:34652/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34652/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:34:40 INFO - PROCESS | 5627 | RSS: Main: 212242432 16:34:40 INFO - PROCESS | 5627 | 16:34:43 INFO - PROCESS | 5627 | Cycle 1(1): loaded http://localhost:34652/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34652/tests/kraken/driver.html?testName=imaging-darkroom) 16:34:43 INFO - PROCESS | 5627 | RSS: Main: 248057856 16:34:43 INFO - PROCESS | 5627 | 16:34:47 INFO - PROCESS | 5627 | Cycle 1(1): loaded http://localhost:34652/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34652/tests/kraken/driver.html?testName=imaging-desaturate) 16:34:47 INFO - PROCESS | 5627 | RSS: Main: 246980608 16:34:47 INFO - PROCESS | 5627 | 16:34:50 INFO - PROCESS | 5627 | Cycle 1(1): loaded http://localhost:34652/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34652/tests/kraken/driver.html?testName=json-parse-financial) 16:34:51 INFO - PROCESS | 5627 | RSS: Main: 246763520 16:34:51 INFO - PROCESS | 5627 | 16:34:52 INFO - PROCESS | 5627 | Cycle 1(1): loaded http://localhost:34652/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34652/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:34:53 INFO - PROCESS | 5627 | RSS: Main: 208928768 16:34:53 INFO - PROCESS | 5627 | 16:34:54 INFO - PROCESS | 5627 | Cycle 1(1): loaded http://localhost:34652/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34652/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:34:55 INFO - PROCESS | 5627 | RSS: Main: 216371200 16:34:55 INFO - PROCESS | 5627 | 16:34:57 INFO - PROCESS | 5627 | Cycle 1(1): loaded http://localhost:34652/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34652/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:34:58 INFO - PROCESS | 5627 | RSS: Main: 225689600 16:34:58 INFO - PROCESS | 5627 | 16:35:00 INFO - PROCESS | 5627 | Cycle 1(1): loaded http://localhost:34652/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34652/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:35:01 INFO - PROCESS | 5627 | RSS: Main: 233984000 16:35:01 INFO - PROCESS | 5627 | 16:35:04 INFO - PROCESS | 5627 | Cycle 1(1): loaded http://localhost:34652/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34652/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:35:04 INFO - PROCESS | 5627 | RSS: Main: 231342080 16:35:04 INFO - PROCESS | 5627 | 16:35:06 INFO - PROCESS | 5627 | Cycle 1(1): loaded http://localhost:34652/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34652/tests/kraken/driver.html?testName=ai-astar) 16:35:06 INFO - PROCESS | 5627 | RSS: Main: 281612288 16:35:06 INFO - PROCESS | 5627 | 16:35:06 INFO - PROCESS | 5627 | __start_tp_report 16:35:06 INFO - PROCESS | 5627 | _x_x_mozilla_page_load 16:35:06 INFO - PROCESS | 5627 | _x_x_mozilla_page_load_details 16:35:06 INFO - PROCESS | 5627 | |i|pagename|runs| 16:35:06 INFO - PROCESS | 5627 | |0;ai-astar;102;111;111;110;110;109;110;109;111;111 16:35:06 INFO - PROCESS | 5627 | |1;audio-beat-detection;146;123;121;173;133;124;124;123;154;128 16:35:06 INFO - PROCESS | 5627 | |2;audio-dft;161;163;161;161;163;163;161;162;162;161 16:35:06 INFO - PROCESS | 5627 | |3;audio-fft;74;75;74;108;76;77;76;76;100;76 16:35:06 INFO - PROCESS | 5627 | |4;audio-oscillator;83;83;118;83;83;82;103;83;83;120 16:35:06 INFO - PROCESS | 5627 | |5;imaging-gaussian-blur;117;118;118;118;117;118;117;117;118;118 16:35:06 INFO - PROCESS | 5627 | |6;imaging-darkroom;146;147;147;146;146;147;146;146;146;146 16:35:06 INFO - PROCESS | 5627 | |7;imaging-desaturate;84;84;85;84;84;85;85;84;84;84 16:35:06 INFO - PROCESS | 5627 | |8;json-parse-financial;54;51;51;51;52;52;52;51;53;53 16:35:06 INFO - PROCESS | 5627 | |9;json-stringify-tinderbox;59;60;59;59;60;59;59;59;59;60 16:35:06 INFO - PROCESS | 5627 | |10;stanford-crypto-aes;82;79;79;85;80;80;80;79;78;78 16:35:06 INFO - PROCESS | 5627 | |11;stanford-crypto-ccm;134;132;129;133;133;133;134;133;168;138 16:35:06 INFO - PROCESS | 5627 | |12;stanford-crypto-pbkdf2;165;170;163;163;164;164;172;165;165;164 16:35:06 INFO - PROCESS | 5627 | |13;stanford-crypto-sha256-iterative;66;65;67;66;65;65;64;67;63;68 16:35:06 INFO - PROCESS | 5627 | __end_tp_report 16:35:06 INFO - PROCESS | 5627 | __start_cc_report 16:35:06 INFO - PROCESS | 5627 | _x_x_mozilla_cycle_collect,1714 16:35:06 INFO - PROCESS | 5627 | __end_cc_report 16:35:06 INFO - PROCESS | 5627 | __startTimestamp1476488106925__endTimestamp 16:35:06 INFO - PROCESS | 5627 | 16:35:06 INFO - PROCESS | 5627 | ------- Summary: start ------- 16:35:06 INFO - PROCESS | 5627 | Number of tests: 14 16:35:06 INFO - PROCESS | 5627 | 16:35:06 INFO - PROCESS | 5627 | [#0] ai-astar Cycles:10 Average:109.40 Median:110.50 stddev:2.72 (2.5%) stddev-sans-first:0.83 16:35:06 INFO - PROCESS | 5627 | Values: 102.0 111.0 111.0 110.0 110.0 109.0 110.0 109.0 111.0 111.0 16:35:06 INFO - PROCESS | 5627 | 16:35:06 INFO - PROCESS | 5627 | [#1] audio-beat-detection Cycles:10 Average:134.90 Median:130.50 stddev:17.34 (13.3%) stddev-sans-first:17.92 16:35:06 INFO - PROCESS | 5627 | Values: 146.0 123.0 121.0 173.0 133.0 124.0 124.0 123.0 154.0 128.0 16:35:06 INFO - PROCESS | 5627 | 16:35:06 INFO - PROCESS | 5627 | [#2] audio-dft Cycles:10 Average:161.80 Median:162.00 stddev:0.92 (0.6%) stddev-sans-first:0.93 16:35:06 INFO - PROCESS | 5627 | Values: 161.0 163.0 161.0 161.0 163.0 163.0 161.0 162.0 162.0 161.0 16:35:06 INFO - PROCESS | 5627 | 16:35:06 INFO - PROCESS | 5627 | [#3] audio-fft Cycles:10 Average:81.20 Median:76.00 stddev:12.20 (16.1%) stddev-sans-first:12.66 16:35:06 INFO - PROCESS | 5627 | Values: 74.0 75.0 74.0 108.0 76.0 77.0 76.0 76.0 100.0 76.0 16:35:06 INFO - PROCESS | 5627 | 16:35:06 INFO - PROCESS | 5627 | [#4] audio-oscillator Cycles:10 Average:92.10 Median:83.00 stddev:15.52 (18.7%) stddev-sans-first:16.10 16:35:06 INFO - PROCESS | 5627 | Values: 83.0 83.0 118.0 83.0 83.0 82.0 103.0 83.0 83.0 120.0 16:35:06 INFO - PROCESS | 5627 | 16:35:06 INFO - PROCESS | 5627 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 16:35:06 INFO - PROCESS | 5627 | Values: 117.0 118.0 118.0 118.0 117.0 118.0 117.0 117.0 118.0 118.0 16:35:06 INFO - PROCESS | 5627 | 16:35:06 INFO - PROCESS | 5627 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 16:35:06 INFO - PROCESS | 5627 | Values: 146.0 147.0 147.0 146.0 146.0 147.0 146.0 146.0 146.0 146.0 16:35:06 INFO - PROCESS | 5627 | 16:35:06 INFO - PROCESS | 5627 | [#7] imaging-desaturate Cycles:10 Average:84.30 Median:84.00 stddev:0.48 (0.6%) stddev-sans-first:0.50 16:35:06 INFO - PROCESS | 5627 | Values: 84.0 84.0 85.0 84.0 84.0 85.0 85.0 84.0 84.0 84.0 16:35:06 INFO - PROCESS | 5627 | 16:35:06 INFO - PROCESS | 5627 | [#8] json-parse-financial Cycles:10 Average:52.00 Median:52.00 stddev:1.05 (2.0%) stddev-sans-first:0.83 16:35:06 INFO - PROCESS | 5627 | Values: 54.0 51.0 51.0 51.0 52.0 52.0 52.0 51.0 53.0 53.0 16:35:06 INFO - PROCESS | 5627 | 16:35:06 INFO - PROCESS | 5627 | [#9] json-stringify-tinderbox Cycles:10 Average:59.30 Median:59.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 16:35:06 INFO - PROCESS | 5627 | Values: 59.0 60.0 59.0 59.0 60.0 59.0 59.0 59.0 59.0 60.0 16:35:06 INFO - PROCESS | 5627 | 16:35:06 INFO - PROCESS | 5627 | [#10] stanford-crypto-aes Cycles:10 Average:80.00 Median:80.00 stddev:2.11 (2.6%) stddev-sans-first:2.11 16:35:06 INFO - PROCESS | 5627 | Values: 82.0 79.0 79.0 85.0 80.0 80.0 80.0 79.0 78.0 78.0 16:35:06 INFO - PROCESS | 5627 | 16:35:06 INFO - PROCESS | 5627 | [#11] stanford-crypto-ccm Cycles:10 Average:136.70 Median:133.50 stddev:11.22 (8.4%) stddev-sans-first:11.85 16:35:06 INFO - PROCESS | 5627 | Values: 134.0 132.0 129.0 133.0 133.0 133.0 134.0 133.0 168.0 138.0 16:35:06 INFO - PROCESS | 5627 | 16:35:06 INFO - PROCESS | 5627 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.50 Median:165.00 stddev:3.03 (1.8%) stddev-sans-first:3.21 16:35:06 INFO - PROCESS | 5627 | Values: 165.0 170.0 163.0 163.0 164.0 164.0 172.0 165.0 165.0 164.0 16:35:06 INFO - PROCESS | 5627 | 16:35:06 INFO - PROCESS | 5627 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.60 Median:66.00 stddev:1.51 (2.3%) stddev-sans-first:1.59 16:35:06 INFO - PROCESS | 5627 | Values: 66.0 65.0 67.0 66.0 65.0 65.0 64.0 67.0 63.0 68.0 16:35:06 INFO - PROCESS | 5627 | -------- Summary: end -------- 16:35:06 INFO - PROCESS | 5627 | 16:35:08 INFO - TEST-INFO | 5627: exit 0 16:35:08 INFO - TEST-OK | kraken | took 61965ms 16:35:08 INFO - SUITE-END | took 1180s 16:35:08 INFO - Completed test suite (00:19:41) 16:35:08 INFO - javascript benchmark 16:35:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2950.7491863191626, 2978.9702102978963, 2998.610180676512, 3016.381641763439, 3024.0625406124104, 5143.81996630118, 5178.171492561191, 5269.314989051428, 5289.841304760854, 5375.89248215035, 5269.525742683158, 5281.023010743005, 5345.572354211664, 5354.5716342692585, 5377.542908852753, 4704.341392205094, 4779.976100119512, 4820.228763397857, 4831.758412079382, 4842.927356089662, 4832.830850920219, 4832.951670483285, 4894.902101957959, 4897.559219670229, 4951.777170027357, 4718.504557021498, 4829.348038014893, 4842.273658951185, 4877.146499362615, 4946.356973593428, 4734.573888350065, 4811.398575178103, 4820.156472617278, 4831.782569784333, 4857.1742803723455, 4784.067106914154, 4785.928211076836, 4790.496997815214, 4848.539388758062, 4854.975725121351, 5255.553277971377, 5283.947160528384, 5286.497782710675, 5292.126799078147, 5292.417834038252, 5473.2063850741815, 5534.584906132056, 5558.527525160366, 5612.943870561283, 5649.435056494359, 5646.604737668365, 5648.4633959773755, 5651.547876169897, 5699.629524080963, 5718.685472299022, 5292.126799078147, 5293.7617807198385, 5295.4969277918535, 5296.655717378358, 5299.470052994747, 5624.3250809903075, 5688.77244910199, 5722.685252311079, 5752.741126649227, 5812.38969908162, 5568.777248910079, 5569.053260945649, 5570.832875013756, 5620.775168993195, 5626.521745651584, 5603.299587551556, 5604.327480702342, 5639.859003524863, 5653.575981801381, 5655.773769049274, 5483.917741233885, 5506.504414602705, 5660.915086273709, 5667.064934285879, 5669.092945128759, 5565.1374037024325, 5586.1062230043, 5609.411011843779, 5627.803026894039, 5701.173329867146, 4306.440162778881, 4318.201132790444, 4326.610605045561, 4358.3244597087505, 4372.1692878353015, 3893.9610603894166, 3896.9610303897166, 3914.451976723261, 3948.3879998600264, 3968.3650615901315, 5148.073346797612, 5153.072446959508, 5198.584113270929, 5309.177077552986, 5345.572354211654, 5550.333959924754, 5560.610757247035, 5598.076317407664, 5647.774089036392, 5652.293463317085, 5307.469253074739, 5332.973335133377, 5333.893322133613, 5342.252084708144, 5342.6260161788305, 4805.639577031737, 4807.0, 4808.735519546459, 4814.061258054716, 4869.561739443467, 5696.060150075191, 5760.8271751847515, 5764.308283005982, 5829.038208695518, 5846.503047241032, 5569.888602228014, 5649.12438572022, 5656.490915817596, 5657.43425657431, 5659.688717120598, 5808.419158084158, 5813.3605303417435, 5815.854603634943, 5821.592488525932, 5824.650520968756, 5474.178873169057, 5554.861128471821, 5556.611037227355, 5556.805511807067, 5559.63862348946, 5556.083246264483, 5558.666480011212, 5562.5549956002615, 5563.888722225452, 5565.332160140809, 5449.0, 5453.61824672285, 5495.422980587141, 5510.256115424367, 5581.944180558305, 5484.149956756709, 5494.395616482104, 5495.450454954473, 5496.148097044965, 5505.944940550543, 5470.507654311131, 5473.233747275305, 5476.507114359727, 5478.753456094406, 5538.363088244903, 5403.918941215807, 5501.3948465667945, 5514.944850551443, 5583.246261754611, 5589.664620122806, 5291.3121294231505, 5312.415634280149, 5313.548348390275, 5316.574674025991, 5317.335333083364], "value": 5190.536108673355, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [585.6632436349099, 622.0451606783587, 622.9876450767506, 633.8478765096376, 637.7959053103009, 31708.52437213441, 35019.29961400774, 35031.4745278821, 35045.64954350456, 35060.29879402411, 36054.0, 45101.77449112758, 46369.30446043312, 46417.0, 49706.254406183936, 8725.912740872605, 8852.247558957464, 8852.645894164225, 8859.335549833757, 8860.20258176764, 8742.694005709802, 8833.60248788806, 8837.248833849131, 8842.381033327669, 8845.469271843678, 7893.289603935645, 8035.919640803576, 8040.155783642721, 8257.83484330313, 8270.255676989069, 10372.481375931211, 10610.469476526143, 10632.681019569425, 11070.557177712883, 11071.446427678664, 10512.211584131144, 10600.575976960912, 10605.575776968912, 10606.628767993161, 10606.628767993161, 42627.36058959118, 42953.57046429558, 42980.355294670604, 43038.78480607577, 43082.35376469355, 3457.4468085106264, 3743.756655817363, 4034.798260087013, 4058.3506638937924, 4208.179405016023, 31977.52033719496, 32612.0, 32870.178245543815, 33166.502502462485, 34308.82845585781, 3988.122613025159, 4029.435878976946, 4052.736572122832, 4076.490438695163, 4103.056297051665, 344429.0, 344857.0, 345577.0, 345933.0, 346890.0, 55335.44664553383, 55551.72224138853, 55600.32796064498, 55623.44376556264, 55645.0, 35561.28877422437, 36547.63452365495, 36552.81723591365, 38477.0, 63690.36309636937, 15296.770548441782, 15583.454579089905, 15598.0, 15608.843911560965, 15609.921950390175, 11709.76580468403, 11785.292882426911, 11805.704857378634, 11813.40932953366, 11820.054395648327, 18911.338103166323, 18924.71612925807, 19405.479615591372, 19485.415437536896, 19520.38417088429, 6042.577019608585, 6771.830704232433, 6912.585244885323, 7067.646617669096, 7072.3634872861685, 911.8449863523084, 920.3419555018194, 1087.374759513283, 1110.161827820007, 1121.7644294698205, 28727.712722872922, 31873.840630796698, 31977.0, 32475.18812029671, 32569.837150814095, 1046.884842667306, 1050.2753100360726, 1072.2922870905165, 1135.0238794636605, 1156.7628636129573, 15464.381424742884, 16755.2460139294, 16845.747313790303, 16870.409535666193, 16882.577935551708, 476925.0, 478717.0, 479185.0, 479874.0, 482932.0, 59788.40211597915, 60600.39399606036, 60608.09087863685, 60660.393396065476, 60668.39331606716, 1170.6897672116895, 1205.2647884790447, 1220.9023278137727, 1270.371166272701, 1291.6060601516629, 22614.886925565268, 30373.392532149675, 31596.684033160294, 31677.366452670358, 31988.20029499188, 57983.710081449324, 59148.70425648017, 59184.0, 59207.703961479914, 59341.0, 438991.0, 439535.0, 441028.0, 441306.0, 441948.0, 40631.39052914268, 41057.38413923853, 42392.0, 42880.78559607182, 43700.0, 47271.0, 47874.281885771044, 48090.0, 48696.2695559574, 49171.508284916694, 39316.0, 39537.80231098826, 41846.58153418427, 42469.57530424656, 42800.57199427966, 40723.38914916338, 41186.9703257409, 41234.175316494104, 41281.380779287734, 42808.14383712246, 41274.79362603168, 42162.57837421587, 42442.15115697731, 42466.78766606147, 42586.78706606447, 34575.73909479038, 35682.28635427329, 37263.62736372602, 37890.537115087434, 39879.20241595094, 28010.71989280081, 28380.858095710217, 28595.428091438473, 28769.85615071911, 28780.71219287864], "value": 20043.856188450725, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [381.94270859371073, 391.92357490289385, 404.80367021994334, 405.15120821878156, 419.36466253625764, 13025.413856376463, 15007.474738384159, 16387.344506219753, 19067.904660476714, 19294.131764070615, 18447.631047379044, 18762.155702993365, 19193.0, 19396.03019849009, 19405.41783746486, 5590.580706447013, 5688.914666280009, 5936.376680448556, 5936.792212272571, 5939.0, 5458.235846981426, 5831.067029275317, 5837.737301821407, 5868.354481007107, 5872.5889187756875, 5704.629199102066, 5709.571782116337, 5797.072468405056, 5834.649921004732, 5837.50381217597, 5729.197912292282, 5807.738651760638, 5816.185733997244, 5822.941770582303, 5826.912596311059, 5003.524665156804, 5127.435982041972, 5184.7407629618365, 5190.091733946582, 5214.400343960455, 18460.81539184618, 18757.531061723428, 18850.811491885044, 22880.31359059214, 22997.88501057484, 2417.093589903786, 2512.786413154866, 2672.5189465896133, 2765.7925655575914, 2786.038816608267, 13956.720865582733, 14175.716485670331, 14594.124352538882, 14693.412263509446, 15082.0, 1869.392447454569, 1899.3352326685688, 1974.1905818614443, 2013.2148462099792, 2017.8284845788125, 76461.23538764597, 78929.60535197287, 79180.0, 79646.60176699137, 79964.0, 10687.625933092304, 10710.571577136983, 10839.945800270949, 10938.33565755465, 11029.44852757375, 15359.846401535842, 15360.078395296317, 15364.462243821412, 15366.385344586091, 15367.538973830802, 7491.288327608869, 7753.79816128501, 7828.882566761503, 7867.921320786719, 7900.288973992253, 7212.0, 7284.380827629605, 7286.453515986323, 7458.254174582498, 7535.434842386843, 4537.274036154199, 4608.124456353282, 4634.119517291704, 4745.430548334153, 4818.397700287464, 1901.9239230430906, 1906.8093190681097, 1923.5960448305732, 1956.4032969944303, 1963.244151001846, 749.9887501687479, 800.2437696376868, 888.2760550151735, 1024.1294899335653, 1046.1264843855313, 18984.240630374905, 19376.0, 19399.0, 19490.415287541113, 19634.607307853763, 990.0841721407669, 991.8462638291077, 999.0658734083655, 1017.9694609161737, 1024.3802499487851, 10518.368897866152, 10866.348019118721, 10937.179711521509, 10993.835092473619, 11050.723731906766, 420423.0, 424128.0, 433325.0, 433666.0, 436194.11379463365, 86384.56807715922, 89160.0, 90143.0, 90394.0, 91391.0, 970.69908328417, 993.1310103659298, 1013.2856336282903, 1015.8831734350497, 1019.4800651667555, 16366.345346186019, 16851.0, 17117.486475405756, 17161.656766864842, 17371.730884407763, 37211.81394093012, 40640.0, 40722.59277407188, 41031.58968410278, 41397.0, 51072.489275106775, 53572.464275356746, 56396.154057689986, 58435.70782146232, 58466.70766646139, 8007.0, 8370.832583348421, 8379.832403351777, 8669.133086691532, 8814.33892458081, 12327.69180770488, 13194.736105278032, 13328.200307981551, 13403.262820544964, 13405.597832065054, 11519.654410367702, 11789.528418863149, 11848.407579620813, 11924.582639607572, 12209.145359824726, 11519.94240028828, 11725.83816586635, 11756.0, 11761.294322340687, 12129.090318225992, 11300.265482743594, 11591.18861679708, 11948.163628545919, 12175.75648487043, 12273.202241854251, 8420.62107205165, 8471.0, 8713.825723485368, 8752.168543988566, 8823.867641985504, 11102.666919992413, 11264.436778160894, 11370.658880233606, 11441.885581144083, 11453.484593193492], "value": 9131.151266163295, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1482.0737039350406, 1505.3000354835003, 1654.7435147552126, 1794.2733193056818, 1806.2052696813394, 7959.48263362881, 8200.753977380688, 8760.211580957712, 9473.100055494735, 9486.00396958319, 8745.91254087459, 9068.365214434993, 9106.271498280139, 9298.721038368843, 9312.8603070954, 2327.848689835164, 2328.2433209206993, 2340.625499920013, 2357.174988753931, 2359.7994170495444, 2032.552838375555, 2072.274703853654, 2311.861288322706, 2332.2070496031347, 2374.6675465434855, 2069.8240649544805, 2121.448423409917, 2250.324902529243, 2298.7011688480557, 2311.6185829338137, 2261.6155253606844, 2266.1275408967504, 2271.7728227177317, 2272.6591011348264, 2272.9204477843364, 2223.655333423322, 2227.231605096239, 2236.731592208929, 2241.3724157236, 2242.798148166673, 8957.238634716057, 9117.133872282122, 9126.77183070422, 9129.680461183827, 9137.223336016446, 5097.337346144977, 5237.0, 5241.318628578299, 5242.895142097175, 5243.947560524422, 3350.430426827421, 3374.4769560718128, 3483.425234836249, 3507.7719948203285, 3519.8416071276856, 1131.519104380643, 1141.5547936304847, 1161.7444162284285, 1168.3398879633064, 1189.2032338333338, 12670.556530521388, 12698.238105713686, 12735.617931462071, 12744.553940612126, 12769.297688627123, 4703.318018887242, 4746.38297021385, 4845.63657725672, 4847.497529067593, 4894.951050489521, 10747.677569672922, 10794.244402891722, 10862.34825910448, 10881.183911206692, 10884.183686223565, 5336.386315573759, 5339.492748188994, 5350.9732451337495, 5351.57187425005, 5352.705601191894, 4903.95096049035, 4925.532074452921, 4926.211806111005, 4935.851924442272, 5038.470960549163, 3767.9058023549082, 3810.8094595270127, 3843.0776613612534, 3888.844446222176, 3893.3186692328727, 1147.17976646698, 1158.3918442817587, 1161.4715304536417, 1166.859976802772, 1168.8831116888414, 739.2755100002028, 800.3237264511479, 923.0, 943.7440829139496, 970.5001924009141, 5816.534677225812, 5835.328937172195, 5906.616069955439, 6125.816225513242, 6127.96936015326, 483.19065565178187, 492.6083763408099, 495.9404871415453, 499.5529001543598, 638.9042791612314, 3961.8811435656976, 4094.4472496213225, 4121.793910304473, 4128.876133715993, 4140.3375459926265, 11193.552257909756, 11670.358130302915, 11723.179377443668, 11731.706707332385, 11736.530538778525, 11588.36264005471, 11605.071594272438, 11627.476763545661, 11645.417729113511, 11652.76694466106, 8094.757157285291, 8381.41330106899, 8391.8321633567, 8470.449420787629, 8591.05498395176, 6038.396160383926, 6187.226596675416, 6232.75068997235, 6249.531285153541, 6333.683315834098, 10203.13273371742, 10596.8940310599, 10627.628033018807, 10705.625303114664, 10714.357138571711, 10892.40091794959, 10916.0, 10933.125349971824, 10940.124790016938, 10947.397893115955, 8165.510069395856, 8247.298979586802, 8262.091169971178, 8276.668933242603, 8286.46138001028, 8548.273396761097, 8569.871451928102, 8921.15249051339, 8975.102489750972, 8976.237019853124, 7695.57674327895, 7848.686052557834, 7899.368050556057, 8006.359491240571, 8121.309688676529, 7708.537487750753, 7775.339096176888, 7805.0, 7869.803254918673, 7931.5637639930355, 7112.822179445348, 7233.9638301810255, 7241.710331586678, 7250.456215783943, 7251.057362542836, 5094.541491265803, 5104.69371837691, 5122.334096567422, 5178.0679477694375, 5385.515303622536, 5161.380634323905, 5330.067238233371, 5398.568114550905, 5399.78400863961, 5420.0], "value": 4631.601014543363, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [289.3619568850686, 307.6492798210041, 312.3456358928045, 313.86503803364553, 314.2097624474447, 5048.980407836867, 5050.520200580939, 5179.896402071956, 5229.60777941654, 5251.763670634821, 5134.794608215676, 5162.612804039693, 5181.171012637969, 5183.2743415921805, 5200.193969934657, 4106.445629839964, 4107.958920410802, 4116.526599441057, 4125.484314460692, 4127.752334859903, 3935.77628639819, 4071.735337203087, 4103.569125241851, 4117.135401565675, 4119.752814831105, 4070.409790580364, 4080.469538959931, 4081.7346872453345, 4084.2035803018275, 4107.055377263231, 4066.9593304066875, 4076.2866498362964, 4076.612721791425, 4086.6309786221354, 4090.1819636072905, 3606.8737594184076, 3614.150674591469, 3628.5282913221376, 3635.0367152704553, 3641.8725344612812, 5010.473900240495, 5050.166722490784, 5056.544910958031, 5076.720780357079, 5078.873028174288, 4579.138038725796, 4579.22153233951, 4590.059037897223, 4601.5735122112255, 4615.423072115986, 5432.375276843174, 5446.754896029688, 5455.372632147314, 5462.126059830408, 5493.313335833021, 3812.093953023488, 3940.468036815022, 3964.108075682977, 3969.2458432897656, 3970.861019864291, 5525.502704756551, 5579.609427340048, 5640.548756099543, 5672.808710170869, 5693.77224911003, 3986.3422535281934, 3987.960120398817, 3989.84040638377, 4019.4975628046495, 4060.1879624075304, 3976.383660532622, 4025.2150830587752, 4069.2268468990796, 4070.3773641459125, 4132.772697501667, 4604.194266003436, 4626.542639068683, 4631.930521042187, 4639.584926597353, 4647.581717645428, 5468.7539060742365, 5473.397926228112, 5474.835754927359, 5496.477834605706, 5553.805616803393, 1333.926634035118, 1357.2806412601337, 1375.6492094516034, 1381.866869167273, 1401.6215621782062, 959.8128364968903, 960.2558017536466, 984.2126298960802, 984.7981163861391, 988.5353883674661, 5278.788848446096, 5281.867953301198, 5283.52448279649, 5285.070949103627, 5293.391260005072, 5554.750181209196, 5558.916011377823, 5568.693721845338, 5581.358143813432, 5596.2165296858475, 5105.3407642515585, 5269.762860671202, 5273.209018647233, 5292.2326262691695, 5337.733113344318, 2971.7176868197485, 2993.533168747298, 3000.0, 3003.234175285288, 3011.4278287125812, 5859.542869706894, 5868.794592189338, 5876.794312199053, 5881.176635271066, 5908.379620139824, 5518.227448157261, 5633.845061762328, 5657.660540367591, 5674.886502269931, 5711.6858572778065, 5779.0, 5785.479306862402, 5796.304443466811, 5806.332271788799, 5812.302523697268, 5370.812021579226, 5551.833444996657, 5616.5787565931905, 5639.436056394327, 5656.37779844225, 5534.086875665631, 5535.114381698909, 5542.528885044816, 5547.722613869371, 5550.222968784454, 5774.354309021908, 5804.287735118235, 5806.76772929095, 5823.621464604787, 5844.415558444121, 3842.423636454554, 3886.5530463997, 3907.374820028782, 3932.9606703932595, 3938.9955561331676, 5331.613780417042, 5563.248961390161, 5580.190872323572, 5596.817241275824, 5603.3836278008575, 5327.706976116196, 5361.35663720356, 5395.919061214006, 5468.0, 5469.808556700496, 5409.7024663642305, 5430.5384042356845, 5442.374126975448, 5451.182322651634, 5458.454154584669, 5200.375954885438, 5381.165919282517, 5408.161734931092, 5431.646942948696, 5439.0753571893665, 5480.72596370172, 5481.0, 5486.91769623448, 5495.005222154015, 5495.945040549704, 5327.600429967691, 5353.571714262927, 5359.142537194186, 5364.517193452608, 5382.246485491956], "value": 4167.159531520623, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [641.9967900160501, 671.7010930136088, 725.7169703815512, 745.1058729524572, 745.9780101261273, 14381.2809359532, 15169.0, 15459.613509662237, 15484.69030619387, 15487.845121548795, 14509.854901450983, 14656.633584160401, 14665.780013299809, 14747.262636868167, 15136.924315378435, 658.2791842932006, 800.3397197312227, 813.8657121574932, 816.1185919207242, 817.6770175780563, 677.3023785500917, 789.6091434739811, 811.1320886651285, 817.6565842346199, 819.2585709932491, 869.1829680100717, 871.5772850167664, 871.8430682477151, 871.9912800871973, 872.9301655867547, 692.3595674001529, 859.2138193552954, 860.724568138196, 861.0485413617956, 861.2421069458867, 517.7902949305537, 599.9340072592012, 614.3181069013392, 617.200725061047, 619.9256089269271, 13237.602871913858, 13280.601581952556, 13284.800727989088, 13717.862821371858, 13742.587722368346, 13988.0, 14509.70980580393, 14614.488492902698, 14641.48754793577, 15095.0, 13430.664233394145, 13476.39356228972, 13613.727725445535, 13828.654283642889, 14372.0, 4504.0, 4527.3661687363465, 4548.2495388260895, 4655.324977878223, 4774.092922344744, 77770.22229777744, 77861.61069194617, 77997.0, 78163.0, 78234.0, 11319.547218111347, 11476.19666623345, 11493.806508145151, 12198.14612977083, 12219.26684398939, 22402.327930162122, 22413.66379504309, 22417.10331586718, 22440.0, 22450.32649020532, 8202.17978202175, 8294.626741796634, 8389.244967952913, 8391.16088391156, 8410.201030902055, 4466.441694788152, 4718.598919091915, 4781.474037855903, 4817.325574419514, 4824.228123500223, 3415.1462134466383, 3499.8775042873376, 3539.7168226541817, 3546.414841551167, 3566.892993210208, 587.2336600735995, 589.8201048680194, 591.6982339007051, 593.2791658135386, 594.5956749410442, 605.8333958161453, 613.5643692977947, 671.1677519875319, 676.9864206817368, 709.8048036789924, 8804.207621314112, 9051.456912585267, 9112.225460835904, 9232.95383523078, 9391.389559678599, 559.3958524793213, 638.5211091681239, 666.4068978609042, 676.4284179868004, 710.8329542557495, 4506.662000349987, 4728.905421891543, 4750.881227969328, 4816.8795780105775, 4844.975775121173, 61334.38665613287, 103438.48280758547, 103595.0, 103617.48191259147, 104555.0, 73576.63211683907, 83783.16216837753, 83970.16029839624, 84918.0, 87901.0, 82578.02618620386, 83005.0, 83858.0, 84462.0, 85137.0, 9232.353735238468, 9336.159745622926, 9455.14903658674, 9464.242860571276, 9471.10024547667, 35081.94754157379, 46361.76819115883, 47626.0, 48219.0, 49678.28056334642, 66423.0, 68272.6586367065, 68383.65808170928, 68890.0, 69759.30240697529, 13185.53850615224, 13191.076624636184, 13202.273874936971, 13296.268705221306, 13578.93210533941, 14047.297635118408, 14141.858581414053, 14217.004809663224, 15219.695606088038, 15285.694286114438, 13016.934915325362, 13183.274919879499, 13324.40040198174, 13350.866491335351, 14776.261186940825, 13609.79585306241, 14086.436542538184, 14234.715305694035, 14670.853291466949, 14807.92689023516, 13335.533256335983, 13450.663733406744, 13753.79369309441, 13907.374168162254, 14137.505187318395, 10530.0, 10803.081738052353, 10813.62152324665, 11213.766768330417, 11312.547498099984, 11040.74656286629, 11640.301581905112, 11921.403929803648, 11992.920637142699, 12055.457504412147], "value": 7407.660371133686, "unit": "score"}], "name": "dromaeo_css", "value": 7169.731693915328, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 111.0, 111.0, 110.0, 110.0, 109.0, 110.0, 109.0, 111.0, 111.0], "value": 109.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 123.0, 121.0, 173.0, 133.0, 124.0, 124.0, 123.0, 154.0, 128.0], "value": 134.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 161.0, 161.0, 163.0, 163.0, 161.0, 162.0, 162.0, 161.0], "value": 161.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 74.0, 108.0, 76.0, 77.0, 76.0, 76.0, 100.0, 76.0], "value": 81.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 118.0, 83.0, 83.0, 82.0, 103.0, 83.0, 83.0, 120.0], "value": 92.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 118.0, 117.0, 118.0, 117.0, 117.0, 118.0, 118.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 85.0, 84.0, 84.0, 85.0, 85.0, 84.0, 84.0, 84.0], "value": 84.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 51.0, 51.0, 51.0, 52.0, 52.0, 52.0, 51.0, 53.0, 53.0], "value": 52.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 59.0, 59.0, 60.0, 59.0, 59.0, 59.0, 59.0, 60.0], "value": 59.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 79.0, 79.0, 85.0, 80.0, 80.0, 80.0, 79.0, 78.0, 78.0], "value": 80.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 132.0, 129.0, 133.0, 133.0, 133.0, 134.0, 133.0, 168.0, 138.0], "value": 136.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 170.0, 163.0, 163.0, 164.0, 164.0, 172.0, 165.0, 165.0, 164.0], "value": 165.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 67.0, 66.0, 65.0, 65.0, 64.0, 67.0, 63.0, 68.0], "value": 65.6, "unit": "score"}], "name": "kraken", "value": 1486.6999999999998, "alertThreshold": 2.0}]} 16:35:08 INFO - Return code: 0 16:35:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:35:08 INFO - # TBPL SUCCESS # 16:35:08 INFO - Running post-action listener: _resource_record_post_action 16:35:08 INFO - [mozharness: 2016-10-14 23:35:08.747130Z] Finished run-tests step (success) 16:35:08 INFO - Running post-run listener: _resource_record_post_run 16:35:08 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 4096; Write bytes: 393531392; Read time: 16; Write time: 393608 16:35:08 INFO - TinderboxPrint: CPU usage
13.1% 16:35:08 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 16:35:08 INFO - TinderboxPrint: I/O write bytes / time
393,531,392 / 393,608 16:35:08 INFO - TinderboxPrint: CPU idle
8,309.3 (86.9%) 16:35:08 INFO - TinderboxPrint: CPU user
1,198.9 (12.5%) 16:35:08 INFO - TinderboxPrint: Swap in / out
0 / 0 16:35:08 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 105517056; Read time: 0; Write time: 143296 16:35:08 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 0; Write bytes: 288014336; Read time: 0; Write time: 250312 16:35:09 INFO - Running post-run listener: _upload_blobber_files 16:35:09 INFO - Blob upload gear active. 16:35:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:35:09 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 16:35:09 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'] 16:35:09 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 16:35:09 INFO - (blobuploader) - INFO - Open directory for files ... 16:35:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:35:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:35:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:35:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:35:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:35:10 INFO - (blobuploader) - INFO - Done attempting. 16:35:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:35:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:35:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:35:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:35:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:35:14 INFO - (blobuploader) - INFO - Done attempting. 16:35:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:35:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:35:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:35:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:35:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:35:14 INFO - (blobuploader) - INFO - Done attempting. 16:35:14 INFO - (blobuploader) - INFO - Iteration through files over. 16:35:14 INFO - Return code: 0 16:35:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:35:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:35:14 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/11742d1186a549fdfb75f2b78411f28d7fb2387611b3ddf31828cf1c65bfcc5f4ae59d392555fb22902131e71256f5152dc5ae559937ce3b111a9d83f4a0301c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/de29ee348dbb35417e2fc6640ff8fa1da6952ea927cbab6b788b5dc8ec5c598057e8737fba9c60c3fae0b53f07c93366fe0006b01368df20bd8a415d31c705cc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/899564b5294a874892d31994b147988349203b820d8b760e98967d69cf51d54d498dde977f4ef571acfdff3681655d909cc3dab5146a457fce97b463675c2920"} 16:35:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:35:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:35:14 INFO - Contents: 16:35:14 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/11742d1186a549fdfb75f2b78411f28d7fb2387611b3ddf31828cf1c65bfcc5f4ae59d392555fb22902131e71256f5152dc5ae559937ce3b111a9d83f4a0301c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/de29ee348dbb35417e2fc6640ff8fa1da6952ea927cbab6b788b5dc8ec5c598057e8737fba9c60c3fae0b53f07c93366fe0006b01368df20bd8a415d31c705cc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/899564b5294a874892d31994b147988349203b820d8b760e98967d69cf51d54d498dde977f4ef571acfdff3681655d909cc3dab5146a457fce97b463675c2920"} 16:35:14 INFO - Running post-run listener: copy_logs_to_upload_dir 16:35:14 INFO - Copying logs to upload dir... 16:35:14 INFO - mkdir: /builds/slave/test/build/upload/logs 16:35:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.363463 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-10-14 16:35:14.839173) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-14 16:35:14.843157) ========= 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=cbe409c6de289db6ac707de3000001d4-1476486873.881300-2135266699 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/11742d1186a549fdfb75f2b78411f28d7fb2387611b3ddf31828cf1c65bfcc5f4ae59d392555fb22902131e71256f5152dc5ae559937ce3b111a9d83f4a0301c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/de29ee348dbb35417e2fc6640ff8fa1da6952ea927cbab6b788b5dc8ec5c598057e8737fba9c60c3fae0b53f07c93366fe0006b01368df20bd8a415d31c705cc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/899564b5294a874892d31994b147988349203b820d8b760e98967d69cf51d54d498dde977f4ef571acfdff3681655d909cc3dab5146a457fce97b463675c2920"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476473404/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011431 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476473404/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/11742d1186a549fdfb75f2b78411f28d7fb2387611b3ddf31828cf1c65bfcc5f4ae59d392555fb22902131e71256f5152dc5ae559937ce3b111a9d83f4a0301c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/de29ee348dbb35417e2fc6640ff8fa1da6952ea927cbab6b788b5dc8ec5c598057e8737fba9c60c3fae0b53f07c93366fe0006b01368df20bd8a415d31c705cc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/899564b5294a874892d31994b147988349203b820d8b760e98967d69cf51d54d498dde977f4ef571acfdff3681655d909cc3dab5146a457fce97b463675c2920"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-14 16:35:14.869473) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 16:35:14.869903) ========= 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=cbe409c6de289db6ac707de3000001d4-1476486873.881300-2135266699 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004414 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 16:35:14.951904) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-14 16:35:14.952381) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-14 16:35:14.952754) ========= ========= Total master_lag: 0.16 =========