builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-051 starttime: 1477759945.0 results: success (0) buildid: 20161029094439 builduid: 167820b431304418bf88e0d3b4f4f3ab revision: 1b170b39ed6bdbde366233ab84594bdaaa960a5a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-29 09:52:25.001466) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-29 09:52:25.002001) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-29 09:52:25.002329) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-29 09:52:25.018006) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-29 09:52:25.018482) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1477759944.458452-1428239084 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-29 09:52:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2016-10-29 09:52:25 (224 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.125568 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-29 09:52:25.158523) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-29 09:52:25.158890) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1477759944.458452-1428239084 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021190 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-29 09:52:25.208951) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-29 09:52:25.209394) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 1b170b39ed6bdbde366233ab84594bdaaa960a5a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 1b170b39ed6bdbde366233ab84594bdaaa960a5a --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5ac5dba3e01a12f1ff77ab15000001b1-1477759944.458452-1428239084 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-29 09:52:25,439 truncating revision to first 12 chars 2016-10-29 09:52:25,439 Setting DEBUG logging. 2016-10-29 09:52:25,439 attempt 1/10 2016-10-29 09:52:25,439 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/1b170b39ed6b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-29 09:52:25,755 unpacking tar archive at: fx-team-1b170b39ed6b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.645304 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-29 09:52:25.873598) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-29 09:52:25.874446) ========= script_repo_revision: 1b170b39ed6bdbde366233ab84594bdaaa960a5a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-29 09:52:25.875203) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-29 09:52:25.875530) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-29 09:52:25.887509) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-10-29 09:52:25.888106) ========= /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=5ac5dba3e01a12f1ff77ab15000001b1-1477759944.458452-1428239084 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:52:26 INFO - MultiFileLogger online at 20161029 09:52:26 in /builds/slave/test 09:52:26 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 09:52:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:52:26 INFO - {'append_to_log': False, 09:52:26 INFO - 'base_work_dir': '/builds/slave/test', 09:52:26 INFO - 'blob_upload_branch': 'Fx-Team', 09:52:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:52:26 INFO - 'branch': 'Fx-Team', 09:52:26 INFO - 'buildbot_json_path': 'buildprops.json', 09:52:26 INFO - 'config_files': ('talos/linux_config.py',), 09:52:26 INFO - 'default_actions': ('clobber', 09:52:26 INFO - 'read-buildbot-config', 09:52:26 INFO - 'download-and-extract', 09:52:26 INFO - 'populate-webroot', 09:52:26 INFO - 'create-virtualenv', 09:52:26 INFO - 'install', 09:52:26 INFO - 'run-tests'), 09:52:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:52:26 INFO - 'download_minidump_stackwalk': True, 09:52:26 INFO - 'download_symbols': 'ondemand', 09:52:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:52:26 INFO - 'tooltool.py': '/tools/tooltool.py', 09:52:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:52:26 INFO - '/tools/misc-python/virtualenv.py')}, 09:52:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:52:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:52:26 INFO - 'installer_path': 'installer.exe', 09:52:26 INFO - 'log_level': 'info', 09:52:26 INFO - 'log_name': 'talos', 09:52:26 INFO - 'log_to_console': True, 09:52:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:52:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:52:26 INFO - 'opt_config_files': (), 09:52:26 INFO - 'pip_index': False, 09:52:26 INFO - 'sps_profile': False, 09:52:26 INFO - 'sps_profile_interval': 0, 09:52:26 INFO - 'suite': 'dromaeojs', 09:52:26 INFO - 'system_bits': '32', 09:52:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:52:26 INFO - 'title': 'talos-linux64-ix-051', 09:52:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:52:26 INFO - 'use_talos_json': True, 09:52:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:52:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:52:26 INFO - 'work_dir': 'build'} 09:52:26 INFO - [mozharness: 2016-10-29 16:52:26.205766Z] Running clobber step. 09:52:26 INFO - Running pre-action listener: _resource_record_pre_action 09:52:26 INFO - Running main action method: clobber 09:52:26 INFO - rmtree: /builds/slave/test/build 09:52:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:52:26 INFO - Running post-action listener: _resource_record_post_action 09:52:26 INFO - [mozharness: 2016-10-29 16:52:26.717220Z] Finished clobber step (success) 09:52:26 INFO - [mozharness: 2016-10-29 16:52:26.717320Z] Running read-buildbot-config step. 09:52:26 INFO - Running pre-action listener: _resource_record_pre_action 09:52:26 INFO - Running main action method: read_buildbot_config 09:52:26 INFO - Using buildbot properties: 09:52:26 INFO - { 09:52:26 INFO - "project": "", 09:52:26 INFO - "product": "firefox", 09:52:26 INFO - "script_repo_revision": "production", 09:52:26 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 09:52:26 INFO - "repository": "", 09:52:26 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 09:52:26 INFO - "buildid": "20161029094439", 09:52:26 INFO - "stage_platform": "linux64-pgo", 09:52:26 INFO - "basedir": "/builds/slave/test", 09:52:26 INFO - "buildnumber": 568, 09:52:26 INFO - "platform": "ubuntu64_hw", 09:52:26 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 09:52:26 INFO - "slavebuilddir": "test", 09:52:26 INFO - "branch": "fx-team", 09:52:26 INFO - "revision": "1b170b39ed6bdbde366233ab84594bdaaa960a5a", 09:52:26 INFO - "slavename": "talos-linux64-ix-051", 09:52:26 INFO - "builduid": "167820b431304418bf88e0d3b4f4f3ab", 09:52:26 INFO - "repo_path": "integration/fx-team" 09:52:26 INFO - } 09:52:26 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477747962/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 09:52:26 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477747962/firefox-52.0a1.en-US.linux-x86_64.test_packages.json. 09:52:26 INFO - Running post-action listener: _resource_record_post_action 09:52:26 INFO - [mozharness: 2016-10-29 16:52:26.720306Z] Finished read-buildbot-config step (success) 09:52:26 INFO - [mozharness: 2016-10-29 16:52:26.720394Z] Running download-and-extract step. 09:52:26 INFO - Running pre-action listener: _resource_record_pre_action 09:52:26 INFO - Running main action method: download_and_extract 09:52:26 INFO - mkdir: /builds/slave/test/build/tests 09:52:26 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')]} 09:52:26 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477747962/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 09:52:26 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477747962/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 09:52:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477747962/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 09:52:27 INFO - Downloaded 1361 bytes. 09:52:27 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 09:52:27 INFO - Using the following test package requirements: 09:52:27 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 09:52:27 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:52:27 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:52:27 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:52:27 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:52:27 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:52:27 INFO - u'jsshell-linux-x86_64.zip'], 09:52:27 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:52:27 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:52:27 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 09:52:27 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:52:27 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:52:27 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:52:27 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:52:27 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:52:27 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:52:27 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:52:27 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:52:27 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:52:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477747962/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 09:52:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477747962/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:52:27 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477747962/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 09:52:27 INFO - Http code: 200 09:52:27 INFO - via: 1.1 4c2196e36fd33f377384d605b4424e95.cloudfront.net (CloudFront) 09:52:27 INFO - x-amz-cf-id: GDHtMS7r7yyciRHR-J_S-SRcgFNc4cKA_hsqmSh3P9Ql_jlQ65c2rQ== 09:52:27 INFO - x-amz-replication-status: PENDING 09:52:27 INFO - x-amz-version-id: osZ4AQHSLmYHTnKNoyV3cZDRYrTso.BD 09:52:30 INFO - Expected file size: 22006612 09:52:30 INFO - Obtained file size: 22006612 09:52:34 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:52:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477747962/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 09:52:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477747962/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:52:34 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477747962/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 09:52:34 INFO - Http code: 200 09:52:34 INFO - via: 1.1 73fa5a1ee49cf827e596b502b5927eab.cloudfront.net (CloudFront) 09:52:34 INFO - x-amz-cf-id: GBj_h9QomAePdtOz6QooqL1Dfs2M-AY6h_eSj6Ugn_6Boss_2FPmBQ== 09:52:34 INFO - x-amz-replication-status: PENDING 09:52:34 INFO - x-amz-version-id: osZ4AQHSLmYHTnKNoyV3cZDRYrTso.BD 09:52:35 INFO - Expected file size: 22006612 09:52:35 INFO - Obtained file size: 22006612 09:52:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477747962/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 09:52:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477747962/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:52:39 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477747962/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 09:52:40 INFO - Http code: 200 09:52:40 INFO - via: 1.1 1b52a5dd431f9e3c81753e61dfdf467a.cloudfront.net (CloudFront) 09:52:40 INFO - x-amz-cf-id: 7F_YAKQQgB2jlWj9lcQfrY4uoqeAIn4s664DrgYSJfsP6_7Ot6-kCQ== 09:52:40 INFO - x-amz-replication-status: PENDING 09:52:40 INFO - x-amz-version-id: OEkE0NHKtrItDByKteAlalVk7PCLvBv7 09:52:42 INFO - Expected file size: 14409038 09:52:42 INFO - Obtained file size: 14409038 09:52:42 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')]} 09:52:42 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477747962/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 09:52:42 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477747962/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 09:52:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477747962/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:52:47 INFO - Downloaded 59632139 bytes. 09:52:47 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477747962/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 09:52:47 INFO - mkdir: /builds/slave/test/properties 09:52:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:52:47 INFO - Writing to file /builds/slave/test/properties/build_url 09:52:47 INFO - Contents: 09:52:47 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477747962/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 09:52:47 INFO - Running post-action listener: _resource_record_post_action 09:52:47 INFO - Running post-action listener: set_extra_try_arguments 09:52:47 INFO - [mozharness: 2016-10-29 16:52:47.973757Z] Finished download-and-extract step (success) 09:52:47 INFO - [mozharness: 2016-10-29 16:52:47.973991Z] Running populate-webroot step. 09:52:47 INFO - Running pre-action listener: _resource_record_pre_action 09:52:47 INFO - Running main action method: populate_webroot 09:52:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:52:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:52:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:52:47 INFO - '--tppagecycles', 09:52:47 INFO - '7'], 09:52:47 INFO - 'tests': ['tsvgm']}}, 09:52:47 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:52:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:52:47 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:52:47 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:52:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:52:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:52:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:52:47 INFO - 'talos_options': ['--disable-e10s'], 09:52:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:52:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:52:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:52:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:52:47 INFO - 'talos_options': ['--disable-e10s'], 09:52:47 INFO - 'tests': ['damp', 'tps']}, 09:52:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:52:47 INFO - 'tests': ['damp', 'tps']}, 09:52:47 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:52:47 INFO - 'tests': ['dromaeo_dom']}, 09:52:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:52:47 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:52:47 INFO - 'tests': ['basic_compositor_video']}, 09:52:47 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:52:47 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:52:47 INFO - 'tests': ['a11yr', 09:52:47 INFO - 'ts_paint', 09:52:47 INFO - 'tpaint', 09:52:47 INFO - 'sessionrestore', 09:52:47 INFO - 'sessionrestore_no_auto_restore', 09:52:47 INFO - 'tabpaint']}, 09:52:47 INFO - 'other-e10s': {'tests': ['a11yr', 09:52:47 INFO - 'ts_paint', 09:52:47 INFO - 'tpaint', 09:52:47 INFO - 'sessionrestore', 09:52:47 INFO - 'sessionrestore_no_auto_restore', 09:52:47 INFO - 'tabpaint']}, 09:52:47 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:52:47 INFO - 'ts_paint', 09:52:47 INFO - 'tpaint', 09:52:47 INFO - 'sessionrestore', 09:52:47 INFO - 'sessionrestore_no_auto_restore', 09:52:47 INFO - 'tabpaint']}, 09:52:47 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:52:47 INFO - 'ts_paint', 09:52:47 INFO - 'tpaint', 09:52:47 INFO - 'sessionrestore', 09:52:47 INFO - 'sessionrestore_no_auto_restore', 09:52:47 INFO - 'tabpaint']}, 09:52:47 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:52:47 INFO - 'tests': ['a11yr', 09:52:47 INFO - 'ts_paint', 09:52:47 INFO - 'tpaint', 09:52:47 INFO - 'sessionrestore', 09:52:47 INFO - 'sessionrestore_no_auto_restore', 09:52:47 INFO - 'tabpaint']}, 09:52:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:52:47 INFO - 'tests': ['a11yr', 09:52:47 INFO - 'ts_paint', 09:52:47 INFO - 'tpaint', 09:52:47 INFO - 'sessionrestore', 09:52:47 INFO - 'sessionrestore_no_auto_restore', 09:52:47 INFO - 'tabpaint']}, 09:52:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:52:47 INFO - 'tests': ['tsvgx', 09:52:47 INFO - 'tsvgr_opacity', 09:52:47 INFO - 'tart', 09:52:47 INFO - 'tscrollx', 09:52:47 INFO - 'cart']}, 09:52:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:52:47 INFO - 'tsvgr_opacity', 09:52:47 INFO - 'tart', 09:52:47 INFO - 'tscrollx', 09:52:47 INFO - 'cart']}, 09:52:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:52:47 INFO - 'talos_options': ['--disable-e10s'], 09:52:47 INFO - 'tests': ['tp5o']}, 09:52:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:52:47 INFO - 'tests': ['tp5o']}, 09:52:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:52:47 INFO - 'talos_options': ['--disable-e10s', 09:52:47 INFO - '--xperf_path', 09:52:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:52:47 INFO - 'tests': ['tp5n']}, 09:52:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:52:47 INFO - 'talos_options': ['--xperf_path', 09:52:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:52:47 INFO - 'tests': ['tp5n']}}, 09:52:47 INFO - 'talos.zip': {'path': '', 09:52:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:52:47 INFO - Running post-action listener: _resource_record_post_action 09:52:47 INFO - [mozharness: 2016-10-29 16:52:47.999706Z] Finished populate-webroot step (success) 09:52:47 INFO - [mozharness: 2016-10-29 16:52:47.999794Z] Running create-virtualenv step. 09:52:47 INFO - Running pre-action listener: _resource_record_pre_action 09:52:47 INFO - Running main action method: create_virtualenv 09:52:48 INFO - Creating virtualenv /builds/slave/test/build/venv 09:52:48 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 09:52:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:52:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:52:48 INFO - Using real prefix '/usr' 09:52:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:52:48 INFO - Installing distribute.............................................................................................................................................................................................done. 09:52:50 INFO - Installing pip.................done. 09:52:50 INFO - Return code: 0 09:52:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:52:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:52:50 INFO - Reading from file tmpfile_stdout 09:52:50 INFO - Output received: 09:52: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) 09:52:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:52: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')]} 09:52:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:52:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52: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')]} 09:52:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:52:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52: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 0x7f29050d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2196790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2193930>, '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 0x2194830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2194cc0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1477759944.458452-1428239084', '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 09:52: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 09:52: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 09:52:50 INFO - Using env: {'DISPLAY': ':0', 09:52:50 INFO - 'HOME': '/home/cltbld', 09:52:50 INFO - 'LANG': 'en_US.UTF-8', 09:52:50 INFO - 'LANGUAGE': 'en_US:en', 09:52:50 INFO - 'LOGNAME': 'cltbld', 09:52:50 INFO - 'MAIL': '/var/mail/cltbld', 09:52:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:52:50 INFO - 'MOZ_NO_REMOTE': '1', 09:52:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:52:50 INFO - 'NO_EM_RESTART': '1', 09:52:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:52:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:52:50 INFO - 'PWD': '/builds/slave/test', 09:52:50 INFO - 'SHELL': '/bin/bash', 09:52:50 INFO - 'SHLVL': '1', 09:52:50 INFO - 'TERM': 'linux', 09:52:50 INFO - 'TMOUT': '86400', 09:52:50 INFO - 'USER': 'cltbld', 09:52:50 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1477759944.458452-1428239084', 09:52:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:52:50 INFO - '_': '/tools/buildbot/bin/python'} 09:52:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:52: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 09:52:50 INFO - Cleaning up... 09:52:51 INFO - Return code: 0 09:52:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:52:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:52:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:52:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:52:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:52:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f29050d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2196790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2193930>, '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 0x2194830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2194cc0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1477759944.458452-1428239084', '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 09:52:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:52:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:52:51 INFO - Using env: {'DISPLAY': ':0', 09:52:51 INFO - 'HOME': '/home/cltbld', 09:52:51 INFO - 'LANG': 'en_US.UTF-8', 09:52:51 INFO - 'LANGUAGE': 'en_US:en', 09:52:51 INFO - 'LOGNAME': 'cltbld', 09:52:51 INFO - 'MAIL': '/var/mail/cltbld', 09:52:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:52:51 INFO - 'MOZ_NO_REMOTE': '1', 09:52:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:52:51 INFO - 'NO_EM_RESTART': '1', 09:52:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:52:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:52:51 INFO - 'PWD': '/builds/slave/test', 09:52:51 INFO - 'SHELL': '/bin/bash', 09:52:51 INFO - 'SHLVL': '1', 09:52:51 INFO - 'TERM': 'linux', 09:52:51 INFO - 'TMOUT': '86400', 09:52:51 INFO - 'USER': 'cltbld', 09:52:51 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1477759944.458452-1428239084', 09:52:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:52:51 INFO - '_': '/tools/buildbot/bin/python'} 09:52:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:52:51 INFO - Downloading/unpacking psutil>=3.1.1 09:52:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:52:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:52:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:52:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:52:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:52:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:52:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:52:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:52:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:52:53 INFO - Installing collected packages: psutil 09:52:53 INFO - Running setup.py install for psutil 09:52:53 INFO - building 'psutil._psutil_linux' extension 09:52: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 09:52: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 09:52:53 INFO - building 'psutil._psutil_posix' extension 09:52: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 09:52: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 09:52:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:52:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:52:53 INFO - Successfully installed psutil 09:52:53 INFO - Cleaning up... 09:52:53 INFO - Return code: 0 09:52:53 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:52: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')]} 09:52:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:52:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52: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')]} 09:52:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:52:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52: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 0x7f29050d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2196790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2193930>, '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 0x2194830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2194cc0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1477759944.458452-1428239084', '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 09:52: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 09:52: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 09:52:53 INFO - Using env: {'DISPLAY': ':0', 09:52:53 INFO - 'HOME': '/home/cltbld', 09:52:53 INFO - 'LANG': 'en_US.UTF-8', 09:52:53 INFO - 'LANGUAGE': 'en_US:en', 09:52:53 INFO - 'LOGNAME': 'cltbld', 09:52:53 INFO - 'MAIL': '/var/mail/cltbld', 09:52:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:52:53 INFO - 'MOZ_NO_REMOTE': '1', 09:52:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:52:53 INFO - 'NO_EM_RESTART': '1', 09:52:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:52:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:52:53 INFO - 'PWD': '/builds/slave/test', 09:52:53 INFO - 'SHELL': '/bin/bash', 09:52:53 INFO - 'SHLVL': '1', 09:52:53 INFO - 'TERM': 'linux', 09:52:53 INFO - 'TMOUT': '86400', 09:52:53 INFO - 'USER': 'cltbld', 09:52:53 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1477759944.458452-1428239084', 09:52:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:52:53 INFO - '_': '/tools/buildbot/bin/python'} 09:52:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:52:54 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:52:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:52:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:52:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:52:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:52:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:52:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:52:55 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:52:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:52:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:52:56 INFO - Installing collected packages: mozsystemmonitor 09:52:56 INFO - Running setup.py install for mozsystemmonitor 09:52:56 INFO - Successfully installed mozsystemmonitor 09:52:56 INFO - Cleaning up... 09:52:56 INFO - Return code: 0 09:52:56 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:52:56 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')]} 09:52:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:52:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52:56 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')]} 09:52:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:52:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52:56 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 0x7f29050d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2196790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2193930>, '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 0x2194830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2194cc0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1477759944.458452-1428239084', '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 09:52:56 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 09:52:56 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 09:52:56 INFO - Using env: {'DISPLAY': ':0', 09:52:56 INFO - 'HOME': '/home/cltbld', 09:52:56 INFO - 'LANG': 'en_US.UTF-8', 09:52:56 INFO - 'LANGUAGE': 'en_US:en', 09:52:56 INFO - 'LOGNAME': 'cltbld', 09:52:56 INFO - 'MAIL': '/var/mail/cltbld', 09:52:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:52:56 INFO - 'MOZ_NO_REMOTE': '1', 09:52:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:52:56 INFO - 'NO_EM_RESTART': '1', 09:52:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:52:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:52:56 INFO - 'PWD': '/builds/slave/test', 09:52:56 INFO - 'SHELL': '/bin/bash', 09:52:56 INFO - 'SHLVL': '1', 09:52:56 INFO - 'TERM': 'linux', 09:52:56 INFO - 'TMOUT': '86400', 09:52:56 INFO - 'USER': 'cltbld', 09:52:56 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1477759944.458452-1428239084', 09:52:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:52:56 INFO - '_': '/tools/buildbot/bin/python'} 09:52:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:52:56 INFO - Downloading/unpacking jsonschema==2.5.1 09:52: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 09:52: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 09:52: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 09:52: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 09:52: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 09:52: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 09:52:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:52:58 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:52: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 09:52: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 09:52: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 09:52: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 09:52: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 09:52: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 09:52:58 INFO - Downloading functools32-3.2.3-2.tar.gz 09:52:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:52:58 INFO - warning: no files found matching '*.txt' 09:52:58 INFO - no previously-included directories found matching 'build' 09:52:58 INFO - no previously-included directories found matching 'dist' 09:52:58 INFO - no previously-included directories found matching '.git*' 09:52:58 INFO - Installing collected packages: jsonschema, functools32 09:52:58 INFO - Running setup.py install for functools32 09:52:58 INFO - warning: no files found matching '*.txt' 09:52:58 INFO - no previously-included directories found matching 'build' 09:52:58 INFO - no previously-included directories found matching 'dist' 09:52:58 INFO - no previously-included directories found matching '.git*' 09:52:58 INFO - Successfully installed jsonschema functools32 09:52:58 INFO - Cleaning up... 09:52:58 INFO - Return code: 0 09:52:58 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:52: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')]} 09:52:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:52:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52: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')]} 09:52:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:52:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52: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 0x7f29050d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2196790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2193930>, '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 0x2194830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2194cc0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1477759944.458452-1428239084', '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 09:52: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 09:52: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 09:52:58 INFO - Using env: {'DISPLAY': ':0', 09:52:58 INFO - 'HOME': '/home/cltbld', 09:52:58 INFO - 'LANG': 'en_US.UTF-8', 09:52:58 INFO - 'LANGUAGE': 'en_US:en', 09:52:58 INFO - 'LOGNAME': 'cltbld', 09:52:58 INFO - 'MAIL': '/var/mail/cltbld', 09:52:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:52:58 INFO - 'MOZ_NO_REMOTE': '1', 09:52:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:52:58 INFO - 'NO_EM_RESTART': '1', 09:52:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:52:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:52:58 INFO - 'PWD': '/builds/slave/test', 09:52:58 INFO - 'SHELL': '/bin/bash', 09:52:58 INFO - 'SHLVL': '1', 09:52:58 INFO - 'TERM': 'linux', 09:52:58 INFO - 'TMOUT': '86400', 09:52:58 INFO - 'USER': 'cltbld', 09:52:58 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1477759944.458452-1428239084', 09:52:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:52:58 INFO - '_': '/tools/buildbot/bin/python'} 09:52:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:52:59 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:52:59 INFO - Cleaning up... 09:52:59 INFO - Return code: 0 09:52:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:52:59 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')]} 09:52:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:52:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52:59 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')]} 09:52:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:52:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52:59 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 0x7f29050d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2196790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2193930>, '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 0x2194830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2194cc0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1477759944.458452-1428239084', '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 09:52:59 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 09:52:59 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 09:52:59 INFO - Using env: {'DISPLAY': ':0', 09:52:59 INFO - 'HOME': '/home/cltbld', 09:52:59 INFO - 'LANG': 'en_US.UTF-8', 09:52:59 INFO - 'LANGUAGE': 'en_US:en', 09:52:59 INFO - 'LOGNAME': 'cltbld', 09:52:59 INFO - 'MAIL': '/var/mail/cltbld', 09:52:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:52:59 INFO - 'MOZ_NO_REMOTE': '1', 09:52:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:52:59 INFO - 'NO_EM_RESTART': '1', 09:52:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:52:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:52:59 INFO - 'PWD': '/builds/slave/test', 09:52:59 INFO - 'SHELL': '/bin/bash', 09:52:59 INFO - 'SHLVL': '1', 09:52:59 INFO - 'TERM': 'linux', 09:52:59 INFO - 'TMOUT': '86400', 09:52:59 INFO - 'USER': 'cltbld', 09:52:59 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1477759944.458452-1428239084', 09:52:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:52:59 INFO - '_': '/tools/buildbot/bin/python'} 09:52:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:52:59 INFO - Downloading/unpacking blobuploader==1.2.4 09:52: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 09:52: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 09:52: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 09:52: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 09:52: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 09:52: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 09:53:01 INFO - Downloading blobuploader-1.2.4.tar.gz 09:53:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:53:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:53: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 09:53: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 09:53: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 09:53: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 09:53: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 09:53: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 09:53:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:53:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:53: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 09:53: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 09:53: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 09:53: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 09:53: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 09:53: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 09:53:01 INFO - Downloading docopt-0.6.1.tar.gz 09:53:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:53:01 INFO - Installing collected packages: blobuploader, requests, docopt 09:53:01 INFO - Running setup.py install for blobuploader 09:53:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:53:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:53:02 INFO - Running setup.py install for requests 09:53:02 INFO - Running setup.py install for docopt 09:53:02 INFO - Successfully installed blobuploader requests docopt 09:53:02 INFO - Cleaning up... 09:53:02 INFO - Return code: 0 09:53:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:53: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')]} 09:53:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:53:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:53: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')]} 09:53:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:53:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:53: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 0x7f29050d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2196790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2193930>, '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 0x2194830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2194cc0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1477759944.458452-1428239084', '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 09:53: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 09:53: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 09:53:02 INFO - Using env: {'DISPLAY': ':0', 09:53:02 INFO - 'HOME': '/home/cltbld', 09:53:02 INFO - 'LANG': 'en_US.UTF-8', 09:53:02 INFO - 'LANGUAGE': 'en_US:en', 09:53:02 INFO - 'LOGNAME': 'cltbld', 09:53:02 INFO - 'MAIL': '/var/mail/cltbld', 09:53:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:53:02 INFO - 'MOZ_NO_REMOTE': '1', 09:53:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:53:02 INFO - 'NO_EM_RESTART': '1', 09:53:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:53:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:53:02 INFO - 'PWD': '/builds/slave/test', 09:53:02 INFO - 'SHELL': '/bin/bash', 09:53:02 INFO - 'SHLVL': '1', 09:53:02 INFO - 'TERM': 'linux', 09:53:02 INFO - 'TMOUT': '86400', 09:53:02 INFO - 'USER': 'cltbld', 09:53:02 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1477759944.458452-1428239084', 09:53:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:53:02 INFO - '_': '/tools/buildbot/bin/python'} 09:53:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:53:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:53:02 INFO - Running setup.py (path:/tmp/pip-x9pf_8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:53:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:53:02 INFO - Running setup.py (path:/tmp/pip-delvf_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:53:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:53:02 INFO - Running setup.py (path:/tmp/pip-1Z9HED-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:53:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:53:03 INFO - Running setup.py (path:/tmp/pip-5bcry6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:53:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:53:03 INFO - Running setup.py (path:/tmp/pip-EKkeqv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:53:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:53:03 INFO - Running setup.py (path:/tmp/pip-n1r1fv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:53:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:53:03 INFO - Running setup.py (path:/tmp/pip-fJPVmL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:53:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:53:03 INFO - Running setup.py (path:/tmp/pip-cjJW_W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:53:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:53:03 INFO - Running setup.py (path:/tmp/pip-43AAQc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:53:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:53:03 INFO - Running setup.py (path:/tmp/pip-3NdzvA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:53:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:53:03 INFO - Running setup.py (path:/tmp/pip-PLhzzq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:53:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:53:03 INFO - Running setup.py (path:/tmp/pip-43bgUp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:53:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:53:03 INFO - Running setup.py (path:/tmp/pip-PD7_ZT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:53:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:53:03 INFO - Running setup.py (path:/tmp/pip-hMd3NF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:53:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:53:03 INFO - Running setup.py (path:/tmp/pip-EDDKCm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:53:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:53:03 INFO - Running setup.py (path:/tmp/pip-lezNT8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:53:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:53:03 INFO - Running setup.py (path:/tmp/pip-LpkAs2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:53:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:53:04 INFO - Running setup.py install for manifestparser 09:53:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:53:04 INFO - Running setup.py install for mozcrash 09:53:04 INFO - Running setup.py install for mozdebug 09:53:04 INFO - Running setup.py install for mozdevice 09:53:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:53:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:53:04 INFO - Running setup.py install for mozfile 09:53:04 INFO - Running setup.py install for mozhttpd 09:53:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:53:04 INFO - Running setup.py install for mozinfo 09:53:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:53:04 INFO - Running setup.py install for mozInstall 09:53:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:53:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:53:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:53:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:53:04 INFO - Running setup.py install for mozleak 09:53:04 INFO - Running setup.py install for mozlog 09:53:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:53:05 INFO - Running setup.py install for moznetwork 09:53:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:53:05 INFO - Running setup.py install for mozprocess 09:53:05 INFO - Running setup.py install for mozprofile 09:53:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:53:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:53:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:53:05 INFO - Running setup.py install for mozrunner 09:53:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:53:05 INFO - Running setup.py install for mozscreenshot 09:53:05 INFO - Running setup.py install for moztest 09:53:05 INFO - Running setup.py install for mozversion 09:53:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:53:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:53:05 INFO - Cleaning up... 09:53:05 INFO - Return code: 0 09:53:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:53: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')]} 09:53:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:53:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:53: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')]} 09:53:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:53:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:53: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 0x7f29050d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2196790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2193930>, '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 0x2194830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2194cc0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1477759944.458452-1428239084', '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 09:53: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 09:53: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 09:53:05 INFO - Using env: {'DISPLAY': ':0', 09:53:05 INFO - 'HOME': '/home/cltbld', 09:53:05 INFO - 'LANG': 'en_US.UTF-8', 09:53:05 INFO - 'LANGUAGE': 'en_US:en', 09:53:05 INFO - 'LOGNAME': 'cltbld', 09:53:05 INFO - 'MAIL': '/var/mail/cltbld', 09:53:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:53:05 INFO - 'MOZ_NO_REMOTE': '1', 09:53:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:53:05 INFO - 'NO_EM_RESTART': '1', 09:53:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:53:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:53:05 INFO - 'PWD': '/builds/slave/test', 09:53:05 INFO - 'SHELL': '/bin/bash', 09:53:05 INFO - 'SHLVL': '1', 09:53:05 INFO - 'TERM': 'linux', 09:53:05 INFO - 'TMOUT': '86400', 09:53:05 INFO - 'USER': 'cltbld', 09:53:05 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1477759944.458452-1428239084', 09:53:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:53:05 INFO - '_': '/tools/buildbot/bin/python'} 09:53:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:53:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:53:06 INFO - Running setup.py (path:/tmp/pip-2GKsq_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:53:06 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)) 09:53:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:53:06 INFO - Running setup.py (path:/tmp/pip-vqhkQ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:53:06 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)) 09:53:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:53:06 INFO - Running setup.py (path:/tmp/pip-knq8Y6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:53:06 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)) 09:53:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:53:06 INFO - Running setup.py (path:/tmp/pip-9EpZb3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:53: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)) 09:53:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:53:06 INFO - Running setup.py (path:/tmp/pip-viO4aK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:53: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)) 09:53:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:53:06 INFO - Running setup.py (path:/tmp/pip-9rPQps-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:53: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)) 09:53:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:53:06 INFO - Running setup.py (path:/tmp/pip-eARvN5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:53: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)) 09:53:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:53:06 INFO - Running setup.py (path:/tmp/pip-vD2dZv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:53: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)) 09:53:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:53:06 INFO - Running setup.py (path:/tmp/pip-LTyJ3j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:53: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)) 09:53:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:53:06 INFO - Running setup.py (path:/tmp/pip-EEcfoU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:53: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)) 09:53:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:53:06 INFO - Running setup.py (path:/tmp/pip-awDFeo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:53: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)) 09:53:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:53:06 INFO - Running setup.py (path:/tmp/pip-QG_CRG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:53: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)) 09:53:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:53:06 INFO - Running setup.py (path:/tmp/pip-PoUCvs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:53:07 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)) 09:53:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:53:07 INFO - Running setup.py (path:/tmp/pip-byr7Xz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:53:07 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)) 09:53:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:53:07 INFO - Running setup.py (path:/tmp/pip-MzjS6Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:53:07 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)) 09:53:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:53:07 INFO - Running setup.py (path:/tmp/pip-CPmb1r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:53:07 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)) 09:53:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:53:07 INFO - Running setup.py (path:/tmp/pip-_ZidhM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:53:07 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)) 09:53:07 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)) 09:53:07 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)) 09:53:07 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)) 09:53:07 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)) 09:53:07 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)) 09:53:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:53:07 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 09:53:07 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 09:53:07 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 09:53:07 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 09:53:07 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 09:53:07 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 09:53:09 INFO - Downloading blessings-1.6.tar.gz 09:53:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:53:09 INFO - Installing collected packages: blessings 09:53:09 INFO - Running setup.py install for blessings 09:53:09 INFO - Successfully installed blessings 09:53:09 INFO - Cleaning up... 09:53:09 INFO - Return code: 0 09:53:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:53:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:53:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:53:09 INFO - Reading from file tmpfile_stdout 09:53:09 INFO - Current package versions: 09:53:09 INFO - argparse == 1.2.1 09:53:09 INFO - blessings == 1.6 09:53:09 INFO - blobuploader == 1.2.4 09:53:09 INFO - docopt == 0.6.1 09:53:09 INFO - functools32 == 3.2.3-2 09:53:09 INFO - jsonschema == 2.5.1 09:53:09 INFO - manifestparser == 1.1 09:53:09 INFO - mozInstall == 1.12 09:53:09 INFO - mozcrash == 0.17 09:53:09 INFO - mozdebug == 0.1 09:53:09 INFO - mozdevice == 0.48 09:53:09 INFO - mozfile == 1.2 09:53:09 INFO - mozhttpd == 0.7 09:53:09 INFO - mozinfo == 0.9 09:53:09 INFO - mozleak == 0.1 09:53:09 INFO - mozlog == 3.4 09:53:09 INFO - moznetwork == 0.27 09:53:09 INFO - mozprocess == 0.23 09:53:09 INFO - mozprofile == 0.28 09:53:09 INFO - mozrunner == 6.12 09:53:09 INFO - mozscreenshot == 0.1 09:53:09 INFO - mozsystemmonitor == 0.3 09:53:09 INFO - moztest == 0.7 09:53:09 INFO - mozversion == 1.4 09:53:09 INFO - psutil == 3.1.1 09:53:09 INFO - requests == 1.2.3 09:53:09 INFO - wsgiref == 0.1.2 09:53:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:53: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')]} 09:53:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:53:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:53: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')]} 09:53:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:53:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:53: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 0x7f29050d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2196790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2193930>, '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 0x2194830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2194cc0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1477759944.458452-1428239084', '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 09:53: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 09:53: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 09:53:09 INFO - Using env: {'DISPLAY': ':0', 09:53:09 INFO - 'HOME': '/home/cltbld', 09:53:09 INFO - 'LANG': 'en_US.UTF-8', 09:53:09 INFO - 'LANGUAGE': 'en_US:en', 09:53:09 INFO - 'LOGNAME': 'cltbld', 09:53:09 INFO - 'MAIL': '/var/mail/cltbld', 09:53:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:53:09 INFO - 'MOZ_NO_REMOTE': '1', 09:53:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:53:09 INFO - 'NO_EM_RESTART': '1', 09:53:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:53:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:53:09 INFO - 'PWD': '/builds/slave/test', 09:53:09 INFO - 'SHELL': '/bin/bash', 09:53:09 INFO - 'SHLVL': '1', 09:53:09 INFO - 'TERM': 'linux', 09:53:09 INFO - 'TMOUT': '86400', 09:53:09 INFO - 'USER': 'cltbld', 09:53:09 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1477759944.458452-1428239084', 09:53:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:53:09 INFO - '_': '/tools/buildbot/bin/python'} 09:53:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:53: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)) 09:53: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)) 09:53: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)) 09:53: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)) 09:53: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)) 09:53: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)) 09:53: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)) 09:53: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)) 09:53: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)) 09:53: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)) 09:53: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)) 09:53:09 INFO - Cleaning up... 09:53:09 INFO - Return code: 0 09:53:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:53: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')]} 09:53:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:53:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:53: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')]} 09:53:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:53:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:53: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 0x7f29050d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2196790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2193930>, '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 0x2194830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2194cc0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1477759944.458452-1428239084', '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 09:53: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 09:53: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 09:53:09 INFO - Using env: {'DISPLAY': ':0', 09:53:09 INFO - 'HOME': '/home/cltbld', 09:53:09 INFO - 'LANG': 'en_US.UTF-8', 09:53:09 INFO - 'LANGUAGE': 'en_US:en', 09:53:09 INFO - 'LOGNAME': 'cltbld', 09:53:09 INFO - 'MAIL': '/var/mail/cltbld', 09:53:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:53:09 INFO - 'MOZ_NO_REMOTE': '1', 09:53:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:53:09 INFO - 'NO_EM_RESTART': '1', 09:53:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:53:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:53:09 INFO - 'PWD': '/builds/slave/test', 09:53:09 INFO - 'SHELL': '/bin/bash', 09:53:09 INFO - 'SHLVL': '1', 09:53:09 INFO - 'TERM': 'linux', 09:53:09 INFO - 'TMOUT': '86400', 09:53:09 INFO - 'USER': 'cltbld', 09:53:09 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1477759944.458452-1428239084', 09:53:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:53:09 INFO - '_': '/tools/buildbot/bin/python'} 09:53:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:53:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:53:10 INFO - Cleaning up... 09:53:10 INFO - Return code: 0 09:53:10 INFO - Running post-action listener: _resource_record_post_action 09:53:10 INFO - Running post-action listener: _start_resource_monitoring 09:53:10 INFO - Starting resource monitoring. 09:53:10 INFO - [mozharness: 2016-10-29 16:53:10.186589Z] Finished create-virtualenv step (success) 09:53:10 INFO - [mozharness: 2016-10-29 16:53:10.187064Z] Running install step. 09:53:10 INFO - Running pre-action listener: _resource_record_pre_action 09:53:10 INFO - Running main action method: install 09:53:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:53:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:53:10 INFO - Reading from file tmpfile_stdout 09:53:10 INFO - Detecting whether we're running mozinstall >=1.0... 09:53:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:53:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:53:10 INFO - Reading from file tmpfile_stdout 09:53:10 INFO - Output received: 09:53:10 INFO - Usage: mozinstall [options] installer 09:53:10 INFO - Options: 09:53:10 INFO - -h, --help show this help message and exit 09:53:10 INFO - -d DEST, --destination=DEST 09:53:10 INFO - Directory to install application into. [default: 09:53:10 INFO - "/builds/slave/test"] 09:53:10 INFO - --app=APP Application being installed. [default: firefox] 09:53:10 INFO - mkdir: /builds/slave/test/build/application 09:53: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'] 09:53: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 09:53:27 INFO - Reading from file tmpfile_stdout 09:53:27 INFO - Output received: 09:53:27 INFO - /builds/slave/test/build/application/firefox/firefox 09:53:27 INFO - Running post-action listener: _resource_record_post_action 09:53:27 INFO - [mozharness: 2016-10-29 16:53:27.435608Z] Finished install step (success) 09:53:27 INFO - [mozharness: 2016-10-29 16:53:27.435883Z] Running run-tests step. 09:53:27 INFO - Running pre-action listener: _resource_record_pre_action 09:53:27 INFO - Running main action method: run_tests 09:53:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:53:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:53:27 INFO - Python 2.7.3 09:53:27 INFO - Return code: 0 09:53:27 INFO - grabbing minidump binary from tooltool 09:53: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')]} 09:53: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 0x2193930>, '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 0x2194830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2194cc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:53: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 09:53: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 09:53: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 09:53:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:53:27 INFO - Return code: 0 09:53:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:53:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:53:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:53:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:53:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:53: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/1477747962/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--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 09:53: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/1477747962/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-051 --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 09:53:27 INFO - Using env: {'DISPLAY': ':0', 09:53:27 INFO - 'HOME': '/home/cltbld', 09:53:27 INFO - 'LANG': 'en_US.UTF-8', 09:53:27 INFO - 'LANGUAGE': 'en_US:en', 09:53:27 INFO - 'LOGNAME': 'cltbld', 09:53:27 INFO - 'MAIL': '/var/mail/cltbld', 09:53:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:53:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:53:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:53:27 INFO - 'MOZ_NO_REMOTE': '1', 09:53:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:53:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:53:27 INFO - 'NO_EM_RESTART': '1', 09:53:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:53:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:53:27 INFO - 'PWD': '/builds/slave/test', 09:53:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:53:27 INFO - 'SHELL': '/bin/bash', 09:53:27 INFO - 'SHLVL': '1', 09:53:27 INFO - 'TERM': 'linux', 09:53:27 INFO - 'TMOUT': '86400', 09:53:27 INFO - 'USER': 'cltbld', 09:53:27 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1477759944.458452-1428239084', 09:53:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:53:27 INFO - '_': '/tools/buildbot/bin/python'} 09:53: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/1477747962/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--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 09:53:27 INFO - mozversion application_buildid: 20161029063242 09:53:27 INFO - mozversion application_changeset: 1b170b39ed6bdbde366233ab84594bdaaa960a5a 09:53:27 INFO - mozversion application_display_name: Nightly 09:53:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:53:27 INFO - mozversion application_name: Firefox 09:53:27 INFO - mozversion application_remotingname: firefox 09:53:27 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 09:53:27 INFO - mozversion application_vendor: Mozilla 09:53:27 INFO - mozversion application_version: 52.0a1 09:53:27 INFO - mozversion platform_buildid: 20161029063242 09:53:27 INFO - mozversion platform_changeset: 1b170b39ed6bdbde366233ab84594bdaaa960a5a 09:53:27 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 09:53:27 INFO - mozversion platform_version: 52.0a1 09:53:27 INFO - using testdate: 1477760007 09:53:27 INFO - actual date: 1477760007 09:53:27 INFO - starting webserver on 'localhost:38844' 09:53:27 INFO - SUITE-START | Running 2 tests 09:53:27 INFO - TEST-START | dromaeo_css 09:53:27 INFO - operating with platform_type : linux_ 09:53:27 INFO - Initialising browser for dromaeo_css test... 09:53:27 INFO - TEST-INFO | started process 18307 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppWb_NS/profile http://localhost:38844/getInfo.html) 09:53:31 INFO - PROCESS | 18307 | __metrics Screen width/height:1600/1200 09:53:31 INFO - PROCESS | 18307 | colorDepth:24 09:53:31 INFO - PROCESS | 18307 | Browser inner width/height: 1024/697 09:53:31 INFO - PROCESS | 18307 | __metrics 09:53:32 INFO - PROCESS | 18307 | 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" 09:53:32 INFO - PROCESS | 18307 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 205: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:53:32 INFO - PROCESS | 18307 | console.error: PushService: 09:53:32 INFO - PROCESS | 18307 | stateChangeProcessEnqueue: Error transitioning state 09:53:32 INFO - PROCESS | 18307 | UnknownError 09:53:33 INFO - TEST-INFO | 18307: exit 0 09:53:33 INFO - Browser initialized. 09:53:33 INFO - Running cycle 1/1 for dromaeo_css test... 09:53:33 INFO - TEST-INFO | started process 18388 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppWb_NS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:53:45 INFO - PROCESS | 18388 | RSS: Main: 173887488 09:53:45 INFO - PROCESS | 18388 | 09:54:37 INFO - PROCESS | 18388 | 1477760077009 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] 09:56:47 INFO - PROCESS | 18388 | Cycle 1(1): loaded http://localhost:38844/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38844/tests/dromaeo/cssquery-ext.html) 09:56:49 INFO - PROCESS | 18388 | RSS: Main: 287363072 09:56:49 INFO - PROCESS | 18388 | 09:59:51 INFO - PROCESS | 18388 | Cycle 1(1): loaded http://localhost:38844/tests/dromaeo/cssquery-ext.html (next: http://localhost:38844/tests/dromaeo/cssquery-jquery.html) 09:59:52 INFO - PROCESS | 18388 | RSS: Main: 280125440 09:59:52 INFO - PROCESS | 18388 | 10:02:54 INFO - PROCESS | 18388 | Cycle 1(1): loaded http://localhost:38844/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38844/tests/dromaeo/cssquery-mootools.html) 10:02:54 INFO - PROCESS | 18388 | RSS: Main: 216801280 10:02:54 INFO - PROCESS | 18388 | 10:05:56 INFO - PROCESS | 18388 | Cycle 1(1): loaded http://localhost:38844/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38844/tests/dromaeo/cssquery-prototype.html) 10:05:57 INFO - PROCESS | 18388 | RSS: Main: 256217088 10:05:57 INFO - PROCESS | 18388 | 10:09:00 INFO - PROCESS | 18388 | Cycle 1(1): loaded http://localhost:38844/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38844/tests/dromaeo/cssquery-yui.html) 10:09:00 INFO - PROCESS | 18388 | RSS: Main: 216924160 10:09:00 INFO - PROCESS | 18388 | 10:12:03 INFO - PROCESS | 18388 | Cycle 1(1): loaded http://localhost:38844/tests/dromaeo/cssquery-yui.html (next: http://localhost:38844/tests/dromaeo/cssquery-dojo.html) 10:12:03 INFO - PROCESS | 18388 | RSS: Main: 314658816 10:12:03 INFO - PROCESS | 18388 | 10:12:03 INFO - PROCESS | 18388 | __start_tp_report 10:12:03 INFO - PROCESS | 18388 | _x_x_mozilla_page_load 10:12:03 INFO - PROCESS | 18388 | _x_x_mozilla_page_load_details 10:12:03 INFO - PROCESS | 18388 | |i|pagename|runs| 10:12:03 INFO - PROCESS | 18388 | |0;dojo.html;2946.248706579822;2946.4549058424195;2996.9250768730785;3000.4899167141584;3005.2637103909533;5038.848834534961;5114.360704911886;5173.637845350827;5271.288376069229;5350.063738845706;5177.326947496829;5336.519713225809;5452.890942181164;5467.535259502947;5471.945280547194;4772.68977516462;4799.52004799519;4852.708837469745;4867.488913664068;4899.510048995107;4880.145974454474;4897.951020489803;4949.307097006404;4958.6281028922795;4995.425526064513;4828.372311599504;4847.224444088929;4905.632077594177;4920.753962301888;4939.234418665113;4699.835505757316;4711.575958163782;4737.834175803865;4743.928841067387;4744.383230180089;4709.222978208626;4719.811207551694;4733;4791.7124972501415;4795.784189711471;5190;5195;5195.714235717034;5200.479952004769;5215.452377500384;5458.4541545845095;5499.1476321170285;5555.111182210827;5563.13771365439;5595.048841696921;5662.773489060432;5666.801661941812;5695.743691533891;5760.423957604248;5768.451997060314;5294.100002999499;5301.6818990860675;5308.23030660552;5312.5218730314455;5312.814051508218;5655.971720141373;5706.058500347479;5789.073748200268;5801.747968891901;5866.6186697864505;5523.364813046471;5532.972335138298;5573.888522229533;5605.775768969277;5627.324721033502;5566.053770858964;5600.299962504687;5694.088945768657;5695.772169113272;5702.800401985911;5408.756605952742;5638.464345887134;5703.885922281531;5711.8000869969355;5715.085586306171;5475.288212532345;5665.858353541112;5671.971640141773;5722.885542289131;5725.255716756878;4421.955780442155;4424.646028317727;4425.867223983286;4439.600435960779;4486.820527178877;3819.8854034378455;3834.0989867381145;3908.511436070491;3952.644262016375;3978.8607398740905;5296.232046353257;5327.493888080626;5331.360236771535;5343.038253114399;5416.322959630046;5623.606347555714;5625.38120806711;5626;5629.211910332557;5636.60543761941;5247.396549396792;5342.572594192456;5347.197920311906;5349.5720342372515;5407.107827208467;4812.1578723723205;4879.536444037811;4880.633952453509;4882.316475693406;4886.242632391985;5783.826485205451;5838.445347692047;5847.561432892635;5851.093080572518;5864.44287792659;5639.6334238274385;5642.492175704207;5642.689652069175;5644.463775941279;5650.180723795109;5797.681127538026;5851.356350801323;5856.560757943256;5859.677717725566;5863;5555.833325000256;5567.69377684215;5568;5575.470330318613;5577.024020796263;5612.382637909908;5630.0991841305195;5641.153826925994;5643.322801263875;5643.52030077448;5522.723863806874;5526.723663816712;5536.390996990408;5580.665160090408;5592.916106258328;5547.0570003098765;5558.471945165203;5559.58303127259;5560.249366335493;5569.303837020372;5278;5306.28365170697;5472.91790623133;5509.256250406143;5631.465010823965;5576.888462230651;5589.944100558942;5596.300462442195;5643.802466913638;5646.548276137982;5447.264619276505;5449.400565937823;5454.563634909118;5461;5465.262189604353 10:12:03 INFO - PROCESS | 18388 | |1;ext.html;569.5045310579796;608.2670382189461;630.4263120560289;636.7643971730463;648.7696867611995;30221;41237.587624123786;42016;42122.57877421233;45260.77369613155;41744.58255417445;42139.367909481385;42199.15601687964;42213;42225.155496890045;7970.681172753083;8747.737567872973;8890.333225008118;8893.28853691703;8898.42160259581;7836.4906281091835;10416.322939008978;10628.362298262091;10635.468226588679;10956.726081847977;10711;10737.624183153592;10737.892621073806;10746.892531074707;10747.247692661516;7900.288973992311;8107.067687215927;10581.523831427567;10632.78734425307;10641.5211315491;10117.595296188143;10434.217433692427;10436.895631043668;10727.892721072845;10759.462026898702;40748.59251407478;41334;41346.1730765386;41409.1718165635;41473.585264147274;3390.3219356128875;3412.095794614429;3511.9122021949656;3762.2475504898857;4047.5952404759582;29088.272793180127;29493.41013179746;31210.843945780354;31273;32729.345413091603;4407.493138289105;4416.955830441719;4436.689431739779;4455.598996090367;4468.784227820392;306536;312345.43827280944;313475;314066;314562;59655.70172149112;60539.39460605426;60618.393816062155;60713.696431518445;60723;34971.125721856646;35487;35643;37538.05545974003;63550;15870.44453444124;16105.19474026294;16137.515874523782;16150.19249037567;16153;9884.901150988542;9972.202223822076;11906.226095303951;12136.87863121375;12335.568255111028;18996.715049274273;19201.231950722093;19322.80677193238;19356;19376.806231937782;7326.699038826605;7406.44736776506;7473.887891681629;7673.091719376049;7914.169012253746;990.782027953849;1010.7220514358463;1055.0820785916303;1076.2412499188054;1113.1150735165563;31993.840030799696;32407.67592324094;32496.512552311735;32571;33014.8349258257;1102.7463683352873;1123.2811000959393;1130.9264897781618;1135.3471753741633;1149.1898211760688;16357.263923123488;17097.83690017351;17106.230219640147;17223.483295501155;17359.65280694379;491647;498216;499012;499073;499554;56446.15330770042;57061.42938570561;57075;57080.42919570834;57186.14220786691;1195.4560674892903;1197.5329621447643;1311.265691212924;1320.854705982341;1364.5000573529064;29033.564496532148;32516.34967300688;32901;33279.66720332862;33565.83217083899;43573.782131089145;43782;43797.34303985379;43880.122397552506;43891.12217755691;366654;369117;369143;370304;370701;27253.454930900873;28276.43447131087;28328.716712832607;28332.57501137526;28345.574816378183;45676.771616141705;45855;46270.30594541152;46394.53605463902;46908.7654561725;38857.80571097126;39163.804180980056;39234.2153156941;39713.40429893612;41270.58729412667;39161.41257881191;39485.210295794495;40225.19549608933;40487.59512404956;41341;39848;40430.79784601176;41031.58968410397;41075.383869242585;41172.79413602913;33496.83251583727;34694.30611387808;35443.82278088593;36274.4558831623;36831;27540.724592753817;27722.722772772013;27779.86110069437;27794;27904.30239244035 10:12:03 INFO - PROCESS | 18388 | |2;jquery.html;361.8733443294849;372.2536314689048;380.75355403121586;383.1819066293464;398.96409323160907;14140.363683634236;17933.372331968385;18504.814951850476;19341.129649165785;19533.12100955457;17593.56016099595;17689.29242830285;18255.54361140972;18411;18539.887606743603;5429.972850135754;5702.344230413514;5703.31560212773;5704.058830293017;5705.543556515489;5399.9730001349935;5574.526165275956;5656.886862262752;5662.518685911682;5668.319801623811;5736.885262294752;5739.253896993385;5739.598228124012;5743.712814359286;5745.368009518949;5569.359523654791;5700.543956483471;5734.627249228808;5742.770289188427;5745.138229265602;5551.1118221084835;5565.3599836018975;5568.777248910039;5569.693666848321;5569.805056823032;13426.0601757877;13561.25413102279;13562.118462300017;13571.1857288563;16610.00339979593;2182.792634699701;2194.7272772536066;2263.5812374710567;2518.043143605418;2530.266222795387;8975.551222438851;9146.496942668151;9556.522173891348;9638.566264518113;9770.51147442625;1831.349870795875;1849.5745978424902;1884.0579710144928;1918.2327069172304;1925.5282455798279;75469;77878;78178;78528.82206766961;79436.60281698612;10253.282270241012;10320.69737683934;10504.789904201873;10677.412742299248;11211.103111751041;14557.199354035629;14557.490487832874;14560.199189044492;14570.562883113524;14577.635559110895;6789.592624442451;6944.965275173693;6947.687354069079;7044.189918159374;7357.705691772269;6161.84595385119;6248.562600618004;6494.447971922439;6505.707243174069;6512.316206798313;4351.6518678505645;4480.663950203748;4506.3465797459185;4574.519675434098;4609.331646911179;1860.237302705884;1868.2993877296014;1937.2928880958348;1942.4366933589383;1956.2761778141894;846.8391005708895;932.6222879733718;979.5543027922279;987;1055.145332280855;17911.641767164845;18678;18839.811601883805;18890.90554547246;19207.8079219206;924.6994726713845;939.478589382899;940.6989763275823;961.8990006049404;968.9031096890254;10122.797544049077;10788.406637635006;10792.190585706103;10810;10810.783784324269;417565;418491;420000;426103;433876;85074;88430.55784721163;89764;90366;92643;988.7132731507783;1022.6625213679467;1026.7895081508273;1029.6756521695643;1036.03131072446;16905.577360566083;17489.179220104423;18089;18129;18237.361692340703;41055.178896421305;41153.79423102865;41571.37642935419;42232.36651450169;43561.23846561474;56269.71865140648;56995;57639.711801440724;58250.12624810716;58323.4167658335;8077.394195435249;8150.7147249845975;8193.67225310981;8337.958310208653;8498.362622803192;12738.936305318784;12893.226406415644;12943.5469758558;13511;13615.319234038456;10923.781524369628;11247.943760281147;11366.431678416211;11486.885131148581;12142.392880356123;10138.594456221668;11060.17048721333;11267.661970140909;11351.318920864443;11520.711982200512;10957.780844382909;10999.670009899715;11281.830772538582;11478.196526243082;11735.941320293345;7992.600369981361;8063.435559510778;8064.314533264738;8174.754757357289;8392.32861371101;9679.467629280458;11019.559217631526;11327.716807079889;11391;11494.367809770543 10:12:03 INFO - PROCESS | 18388 | |3;mootools.html;1287.9871201287983;1437.374741987236;1457.2640816387725;1588.2535208452023;1714.1429285357322;7238.565686058841;8139.593020348981;8399.202075802805;8424.705135320264;8593.699220527284;8416.95791521043;8473.872891906627;8474.279686226679;8521.954730864594;8531.829363412728;2312.6762253284555;2344.601417758985;2347.542229265294;2349.5300939812105;2355.458244603742;2241.2267767620147;2318.5942460069505;2321.071571371448;2322.1872344679396;2328.057136859566;2294.1511640692966;2312.1329501436962;2322.477442575424;2323.1056043423237;2327.034280773477;2216.2686313516583;2265.501589650274;2267.1271560449263;2268.5576312619046;2270.3189043286948;2253.7971582557648;2270.4096934796908;2290.89690963907;2293.6100862853355;2294.988525057364;8165.428420010601;8436.87344689824;8454.746357609281;8491.872621910676;8494.702685406042;5176.611754118456;5306;5386.084365657847;5395.541378982791;5399.811006614749;3300.273939733255;3354.66453354665;3485.494603282535;3572.5355703758346;3603.3694103531775;1082.3505896462138;1107.5126944144552;1109.1625822504038;1112.933224006562;1137.1585027079984;11577.479013444416;11734.941325293405;11780.646580602595;11823.527058917633;11824.172307938534;4385.912281754347;4603.125406172817;4640.1879671058105;4707.646926480527;4711.293306004127;9877.456739879375;9917.603295868084;9918;9939.850902236472;9942.950285248528;5191.5846732261325;5196.142636465017;5196.662216955886;5200.037992971313;5200.739963001834;4210.726302790309;4235.9364609530885;4810.927836082462;4846.7818948147415;4854.927176092361;3762.887113386603;3771.113788259757;3884.320243957296;3896.493455850721;3933.783641899723;1241.2862604002735;1257.8427696537933;1274.120856608937;1277.8147168660678;1287.7939529675207;786.8150984518634;792.484884824857;851.3699862102;905.899332311245;907.5280853956037;5475.479829416199;5691.686957217393;5735.569832262597;5854.2389489366105;5893.44012318829;976.7753416714054;992.1417973453056;993.8807343118727;1002.4686915934566;1003.9548220330103;3700.4264339027495;3708.7589306694977;3766;3782.9432558511644;3845.6346647068485;10215.489225538693;10419.06228439429;10496.527656255486;10522.684319470429;10525.315854469434;10377.9481102594;10404.531796069195;10477.738056548495;10488.26582139243;10492.16062714981;7538.434617403716;7822.6479808409895;7864.72473463426;8050.396220283502;8056.436049476481;5622.8313150605545;5778.306603207474;5784.5083167929515;5819.447152520504;5929.110633405024;9431.717048488556;9456;9528.666496672584;9545.570449329936;9613.230941524802;9576.425414475154;9648.131668149901;9657.565409556728;9752.512374381395;9763.85354219673;6586.1438013058;6786.049953006682;7398.630068496661;7508.436867235088;7542.962285188539;7981.122076571456;8150.062742784656;8298.792530186794;8315.95842020786;8316.251537361666;7184.892226616709;7294.088238970129;7429.5542267464125;7487.288707572772;7632.771016869503;7060;7309.232530584212;7373.483856130019;7431;7516.285952834472;6579.934200658124;6648.601083934979;6815.182178138655;6927.134108236471;6937.167539895245;4780.139574876555;4946.8763280918265;5016.724080175625;5029.044481548494;5107.489251074863;5063.291139240583;5214.32213812202;5223.712695801767;5250.369955605352;5336.706481143575 10:12:03 INFO - PROCESS | 18388 | |4;prototype.html;324.09738877226914;325.2356961141318;333.9716124129448;337.7652531490615;341.39743352981975;5007.799688012475;5131.2046632771935;5182.818601348954;5211.244369566415;5213.139831927737;4999.625028122896;5023.522765337287;5047.671901326411;5065.341505604266;5109.620402491325;4081.755094694328;4101.671866250693;4105.137921036586;4107.383892416139;4133.090720041586;3999.8200080996426;4091.9590804092027;4094.9385759213637;4095.9555313395044;4119.7940102994735;4050.5949405059405;4065.6137666921595;4083.9370472145893;4097.651699605537;4100;4047.433359329696;4067.2272268268935;4070.633642972147;4074.5925407459313;4101;3645.143391303042;3652.214773823614;3661.21283923955;3661.9450708239397;3691.427828686531;4811.855644330676;5023.246513023076;5038.345015148044;5038.571721403649;5052.120291433884;4643.210654188796;4646.628269738413;4681.50844161365;4683.531646835289;4689.906201875943;5350.652207606493;5359.767253531671;5364.892702145974;5367.785288588452;5384.246205531229;3779.9433008504893;3951.4072889066583;3962.821673024721;3967.107400834818;3983.092342589897;5430.945690543083;5480.945190548123;5511.862203444946;5517.641353312022;5531.814933101443;4059.3910913363234;4059.817308221137;4060.167665628539;4061.654759345489;4100.91798164035;4034.374671925856;4066.3900414938;4092.708083473205;4151.878992671962;4161.417401563784;4578.496365399803;4587.472440669366;4597.678162528658;4600.7469589172915;4609.7695115244105;5319.893602128013;5334.786608535615;5336;5347.67376191358;5355.839324820262;1357.1585616917575;1383.6056723833658;1383.6471699716508;1410.379433049455;1420.808190894216;972.7665360313615;993.4635296939572;1009.8687170667766;1011.3022014809758;1022.8619136416637;5144.71704056273;5161;5192.636515443958;5226.346706661668;5235.73821308933;5412.863298707237;5435.374931882884;5440.898687747946;5471.151971444432;5476.7535460904355;4950.975245123824;5108.489151084862;5145.794168233304;5185.2999845021195;5203.635745497854;2529.784968277717;2542.703221357121;2559.8208125431042;2561.398071453207;2569.678790151231;4938.629602779806;4957.132501812169;4957.414391687675;4974.552290293818;4984.529563778694;4824.372831531879;4841.3222148899185;4856.353287458273;5239.751354160445;5550.972245138829;5724.599278050497;5726.341470730836;5729.598928074995;5735.397783232784;5752.482276595127;5448.692313844728;5450.863728406822;5485.835424937259;5499.780008799603;5584.357798853184;5157.484251574812;5362.195670649277;5388.434214407431;5434.157705555645;5462.262594549685;5664.915026274692;5682.147677848356;5685.232493613309;5685.630434021776;5691;3976.363781794899;3982.940255896222;3990.700697447645;3995.340768773236;3997.380406037069;5140.228965655182;5343.759530821045;5422.430644782399;5423.3491980962535;5429.592780541554;5152.536271735562;5227.372715274191;5334.399680096033;5367.892642147213;5368.919466207932;5354.303940487712;5362.758675859518;5392.35291764975;5399.5950303726595;5432.511074003359;5258.921116183184;5330.653507521999;5356.437574054668;5407.378151512627;5413;5361.276227709365;5366.543843773323;5377.542908852792;5389.299391079135;5404.784153428861;5281.445448228034;5295.338082739658;5313.707746073848;5324.866878328073;5330.413654497925 10:12:03 INFO - PROCESS | 18388 | |5;yui.html;728.2062551818517;730.1347902735256;739.9297066778657;783;789.3763926498067;14551.78172327416;14603.269836508158;14800.185989770558;15691.45079922203;15695.686086278281;14004.29978501076;14474.131552106855;14497.202653854034;14500.492482763078;14642.853571464282;665.8435267712084;682.754208484945;789.1792535762828;803.0283357137855;807.6002378822491;812.2567850416862;814.1776805426532;815.0463957170095;815.2499700275761;815.5636734347125;842.0232530264894;847.9448835825651;848.101012926297;849.6389034660275;849.6473963305252;842.8988521377444;843.696269343036;844.0462277626274;844.2401838345507;844.5692696724715;616.1466369078857;616.2266355723583;616.5499185594541;616.747133675191;616.8951278282702;13402.396892139877;13543.729125417436;13714;13725.45098196071;15077;14133.434662613587;14874.107553546713;14934.850651493454;14990.47533336328;15131.697366052727;11278.097752179807;11284.774304513945;11334.71663208418;11411.087113030937;11570.247933884271;4325.956740432587;4400.779961001969;4413.7793110344355;4526.094781043805;4617.284320930261;63136.68431657858;63304;64807.351926481075;65174;65247;10970.232083754061;10996.505157267782;10996.725081872857;11022.724431889266;11283.323000619988;19138;19202.327918522784;19204.615907681768;19208.80791192098;19368.612627747367;7964.243396877403;8049.356051515864;8065.556394398247;8156.062052863878;8394.328453723687;4603.58567728906;4626.4910859805395;4671.602913752301;4722.598579120813;4777.928331075037;3226.419244535959;3292.506124081407;3301.992892167864;3600.2439487707875;3655.391627683811;589.3369958796354;593.8663800644907;625.5902383938527;629.6190804563173;636.6912047656883;615.827568280882;650.4861159683892;737.8229224985964;745.3887811994222;777.1994845309227;9553.952230238805;9710.805783884423;9718;9739.853902191473;9830.655927042662;611.2909025530363;634.4321831960369;650.1807722269974;725.5972935021008;760.4068826315482;4528.184926713157;4649.139909116824;4707.552782485658;4741.502142275081;4753.619710423158;51721.224181637306;69009;87657.56171219103;87885;91059.54470227606;47901;48349.75825120852;55711;63218.68390658109;77443;66914.30114085138;68780.65609671919;69191.3080869195;70851.99999999897;71666.64166679133;8957.417767845069;9013.729588112366;9180.586873590839;9287.257019438293;9333.859992099988;48639.756801215764;49020.2646960303;49269.50730492649;49883.50116498789;50144;60906;66120.66939665271;66648.33351666616;66776.33223667895;66822;11061.281016733887;11303.547858085585;11497.425128743362;11579.768404631692;11686.415679215836;13039.934800325938;13058.673533161367;13209.603711888658;13315.600531984055;13466.326683665582;12391.62825115248;12466.56367027186;12559.62321130331;12582.811257830957;12744.299063551594;11811.291322520676;11813.173077884465;11855.407229638311;12288.262704237774;12289.938550307548;11900.76198476043;12176.208546444454;12180.817287740514;12232.755344892874;12759.74480510366;10103.49482525856;10345.793084138124;10393.636222732168;10522.21083418762;10542.051215390651;9931.304808663324;10525.315854469742;10549;10734.946325268324;10738.248322617343 10:12:03 INFO - PROCESS | 18388 | __end_tp_report 10:12:03 INFO - PROCESS | 18388 | __start_cc_report 10:12:03 INFO - PROCESS | 18388 | _x_x_mozilla_cycle_collect,1182 10:12:03 INFO - PROCESS | 18388 | __end_cc_report 10:12:03 INFO - PROCESS | 18388 | __startTimestamp1477761123676__endTimestamp 10:12:03 INFO - PROCESS | 18388 | 10:12:03 INFO - PROCESS | 18388 | ------- Summary: start ------- 10:12:03 INFO - PROCESS | 18388 | Number of tests: 6 10:12:03 INFO - PROCESS | 18388 | 10:12:03 INFO - PROCESS | 18388 | [#0] dojo.html Cycles:165 Average:5253.92 Median:5467.54 stddev:595.33 (10.9%) stddev-sans-first:568.97 10:12:03 INFO - PROCESS | 18388 | Values: 2946.2 2946.5 2996.9 3000.5 3005.3 5038.8 5114.4 5173.6 5271.3 5350.1 5177.3 5336.5 5452.9 5467.5 5471.9 4772.7 4799.5 4852.7 4867.5 4899.5 4880.1 4898.0 4949.3 4958.6 4995.4 4828.4 4847.2 4905.6 4920.8 4939.2 4699.8 4711.6 4737.8 4743.9 4744.4 4709.2 4719.8 4733.0 4791.7 4795.8 5190.0 5195.0 5195.7 5200.5 5215.5 5458.5 5499.1 5555.1 5563.1 5595.0 5662.8 5666.8 5695.7 5760.4 5768.5 5294.1 5301.7 5308.2 5312.5 5312.8 5656.0 5706.1 5789.1 5801.7 5866.6 5523.4 5533.0 5573.9 5605.8 5627.3 5566.1 5600.3 5694.1 5695.8 5702.8 5408.8 5638.5 5703.9 5711.8 5715.1 5475.3 5665.9 5672.0 5722.9 5725.3 4422.0 4424.6 4425.9 4439.6 4486.8 3819.9 3834.1 3908.5 3952.6 3978.9 5296.2 5327.5 5331.4 5343.0 5416.3 5623.6 5625.4 5626.0 5629.2 5636.6 5247.4 5342.6 5347.2 5349.6 5407.1 4812.2 4879.5 4880.6 4882.3 4886.2 5783.8 5838.4 5847.6 5851.1 5864.4 5639.6 5642.5 5642.7 5644.5 5650.2 5797.7 5851.4 5856.6 5859.7 5863.0 5555.8 5567.7 5568.0 5575.5 5577.0 5612.4 5630.1 5641.2 5643.3 5643.5 5522.7 5526.7 5536.4 5580.7 5592.9 5547.1 5558.5 5559.6 5560.2 5569.3 5278.0 5306.3 5472.9 5509.3 5631.5 5576.9 5589.9 5596.3 5643.8 5646.5 5447.3 5449.4 5454.6 5461.0 5465.3 10:12:03 INFO - PROCESS | 18388 | 10:12:03 INFO - PROCESS | 18388 | [#1] ext.html Cycles:180 Average:55316.25 Median:201742.50 stddev:105885.84 (52.5%) stddev-sans-first:106103.09 10:12:03 INFO - PROCESS | 18388 | Values: 569.5 608.3 630.4 636.8 648.8 30221.0 41237.6 42016.0 42122.6 45260.8 41744.6 42139.4 42199.2 42213.0 42225.2 7970.7 8747.7 8890.3 8893.3 8898.4 7836.5 10416.3 10628.4 10635.5 10956.7 10711.0 10737.6 10737.9 10746.9 10747.2 7900.3 8107.1 10581.5 10632.8 10641.5 10117.6 10434.2 10436.9 10727.9 10759.5 40748.6 41334.0 41346.2 41409.2 41473.6 3390.3 3412.1 3511.9 3762.2 4047.6 29088.3 29493.4 31210.8 31273.0 32729.3 4407.5 4417.0 4436.7 4455.6 4468.8 306536.0 312345.4 313475.0 314066.0 314562.0 59655.7 60539.4 60618.4 60713.7 60723.0 34971.1 35487.0 35643.0 37538.1 63550.0 15870.4 16105.2 16137.5 16150.2 16153.0 9884.9 9972.2 11906.2 12136.9 12335.6 18996.7 19201.2 19322.8 19356.0 19376.8 7326.7 7406.4 7473.9 7673.1 7914.2 990.8 1010.7 1055.1 1076.2 1113.1 31993.8 32407.7 32496.5 32571.0 33014.8 1102.7 1123.3 1130.9 1135.3 1149.2 16357.3 17097.8 17106.2 17223.5 17359.7 491647.0 498216.0 499012.0 499073.0 499554.0 56446.2 57061.4 57075.0 57080.4 57186.1 1195.5 1197.5 1311.3 1320.9 1364.5 29033.6 32516.3 32901.0 33279.7 33565.8 43573.8 43782.0 43797.3 43880.1 43891.1 366654.0 369117.0 369143.0 370304.0 370701.0 27253.5 28276.4 28328.7 28332.6 28345.6 45676.8 45855.0 46270.3 46394.5 46908.8 38857.8 39163.8 39234.2 39713.4 41270.6 39161.4 39485.2 40225.2 40487.6 41341.0 39848.0 40430.8 41031.6 41075.4 41172.8 33496.8 34694.3 35443.8 36274.5 36831.0 27540.7 27722.7 27779.9 27794.0 27904.3 10:12:03 INFO - PROCESS | 18388 | 10:12:03 INFO - PROCESS | 18388 | [#2] jquery.html Cycles:180 Average:26431.04 Median:41362.59 stddev:70163.43 (169.6%) stddev-sans-first:70332.95 10:12:03 INFO - PROCESS | 18388 | Values: 361.9 372.3 380.8 383.2 399.0 14140.4 17933.4 18504.8 19341.1 19533.1 17593.6 17689.3 18255.5 18411.0 18539.9 5430.0 5702.3 5703.3 5704.1 5705.5 5400.0 5574.5 5656.9 5662.5 5668.3 5736.9 5739.3 5739.6 5743.7 5745.4 5569.4 5700.5 5734.6 5742.8 5745.1 5551.1 5565.4 5568.8 5569.7 5569.8 13426.1 13561.3 13562.1 13571.2 16610.0 2182.8 2194.7 2263.6 2518.0 2530.3 8975.6 9146.5 9556.5 9638.6 9770.5 1831.3 1849.6 1884.1 1918.2 1925.5 75469.0 77878.0 78178.0 78528.8 79436.6 10253.3 10320.7 10504.8 10677.4 11211.1 14557.2 14557.5 14560.2 14570.6 14577.6 6789.6 6945.0 6947.7 7044.2 7357.7 6161.8 6248.6 6494.4 6505.7 6512.3 4351.7 4480.7 4506.3 4574.5 4609.3 1860.2 1868.3 1937.3 1942.4 1956.3 846.8 932.6 979.6 987.0 1055.1 17911.6 18678.0 18839.8 18890.9 19207.8 924.7 939.5 940.7 961.9 968.9 10122.8 10788.4 10792.2 10810.0 10810.8 417565.0 418491.0 420000.0 426103.0 433876.0 85074.0 88430.6 89764.0 90366.0 92643.0 988.7 1022.7 1026.8 1029.7 1036.0 16905.6 17489.2 18089.0 18129.0 18237.4 41055.2 41153.8 41571.4 42232.4 43561.2 56269.7 56995.0 57639.7 58250.1 58323.4 8077.4 8150.7 8193.7 8338.0 8498.4 12738.9 12893.2 12943.5 13511.0 13615.3 10923.8 11247.9 11366.4 11486.9 12142.4 10138.6 11060.2 11267.7 11351.3 11520.7 10957.8 10999.7 11281.8 11478.2 11735.9 7992.6 8063.4 8064.3 8174.8 8392.3 9679.5 11019.6 11327.7 11391.0 11494.4 10:12:03 INFO - PROCESS | 18388 | 10:12:03 INFO - PROCESS | 18388 | [#3] mootools.html Cycles:180 Average:5591.71 Median:5196.40 stddev:3121.18 (60.1%) stddev-sans-first:3113.18 10:12:03 INFO - PROCESS | 18388 | Values: 1288.0 1437.4 1457.3 1588.3 1714.1 7238.6 8139.6 8399.2 8424.7 8593.7 8417.0 8473.9 8474.3 8522.0 8531.8 2312.7 2344.6 2347.5 2349.5 2355.5 2241.2 2318.6 2321.1 2322.2 2328.1 2294.2 2312.1 2322.5 2323.1 2327.0 2216.3 2265.5 2267.1 2268.6 2270.3 2253.8 2270.4 2290.9 2293.6 2295.0 8165.4 8436.9 8454.7 8491.9 8494.7 5176.6 5306.0 5386.1 5395.5 5399.8 3300.3 3354.7 3485.5 3572.5 3603.4 1082.4 1107.5 1109.2 1112.9 1137.2 11577.5 11734.9 11780.6 11823.5 11824.2 4385.9 4603.1 4640.2 4707.6 4711.3 9877.5 9917.6 9918.0 9939.9 9943.0 5191.6 5196.1 5196.7 5200.0 5200.7 4210.7 4235.9 4810.9 4846.8 4854.9 3762.9 3771.1 3884.3 3896.5 3933.8 1241.3 1257.8 1274.1 1277.8 1287.8 786.8 792.5 851.4 905.9 907.5 5475.5 5691.7 5735.6 5854.2 5893.4 976.8 992.1 993.9 1002.5 1004.0 3700.4 3708.8 3766.0 3782.9 3845.6 10215.5 10419.1 10496.5 10522.7 10525.3 10377.9 10404.5 10477.7 10488.3 10492.2 7538.4 7822.6 7864.7 8050.4 8056.4 5622.8 5778.3 5784.5 5819.4 5929.1 9431.7 9456.0 9528.7 9545.6 9613.2 9576.4 9648.1 9657.6 9752.5 9763.9 6586.1 6786.0 7398.6 7508.4 7543.0 7981.1 8150.1 8298.8 8316.0 8316.3 7184.9 7294.1 7429.6 7487.3 7632.8 7060.0 7309.2 7373.5 7431.0 7516.3 6579.9 6648.6 6815.2 6927.1 6937.2 4780.1 4946.9 5016.7 5029.0 5107.5 5063.3 5214.3 5223.7 5250.4 5336.7 10:12:03 INFO - PROCESS | 18388 | 10:12:03 INFO - PROCESS | 18388 | [#4] prototype.html Cycles:180 Average:4504.06 Median:5058.73 stddev:1297.05 (25.6%) stddev-sans-first:1262.17 10:12:03 INFO - PROCESS | 18388 | Values: 324.1 325.2 334.0 337.8 341.4 5007.8 5131.2 5182.8 5211.2 5213.1 4999.6 5023.5 5047.7 5065.3 5109.6 4081.8 4101.7 4105.1 4107.4 4133.1 3999.8 4092.0 4094.9 4096.0 4119.8 4050.6 4065.6 4083.9 4097.7 4100.0 4047.4 4067.2 4070.6 4074.6 4101.0 3645.1 3652.2 3661.2 3661.9 3691.4 4811.9 5023.2 5038.3 5038.6 5052.1 4643.2 4646.6 4681.5 4683.5 4689.9 5350.7 5359.8 5364.9 5367.8 5384.2 3779.9 3951.4 3962.8 3967.1 3983.1 5430.9 5480.9 5511.9 5517.6 5531.8 4059.4 4059.8 4060.2 4061.7 4100.9 4034.4 4066.4 4092.7 4151.9 4161.4 4578.5 4587.5 4597.7 4600.7 4609.8 5319.9 5334.8 5336.0 5347.7 5355.8 1357.2 1383.6 1383.6 1410.4 1420.8 972.8 993.5 1009.9 1011.3 1022.9 5144.7 5161.0 5192.6 5226.3 5235.7 5412.9 5435.4 5440.9 5471.2 5476.8 4951.0 5108.5 5145.8 5185.3 5203.6 2529.8 2542.7 2559.8 2561.4 2569.7 4938.6 4957.1 4957.4 4974.6 4984.5 4824.4 4841.3 4856.4 5239.8 5551.0 5724.6 5726.3 5729.6 5735.4 5752.5 5448.7 5450.9 5485.8 5499.8 5584.4 5157.5 5362.2 5388.4 5434.2 5462.3 5664.9 5682.1 5685.2 5685.6 5691.0 3976.4 3982.9 3990.7 3995.3 3997.4 5140.2 5343.8 5422.4 5423.3 5429.6 5152.5 5227.4 5334.4 5367.9 5368.9 5354.3 5362.8 5392.4 5399.6 5432.5 5258.9 5330.7 5356.4 5407.4 5413.0 5361.3 5366.5 5377.5 5389.3 5404.8 5281.4 5295.3 5313.7 5324.9 5330.4 10:12:03 INFO - PROCESS | 18388 | 10:12:03 INFO - PROCESS | 18388 | [#5] yui.html Cycles:180 Average:17157.72 Median:48494.76 stddev:22200.33 (45.8%) stddev-sans-first:22228.33 10:12:03 INFO - PROCESS | 18388 | Values: 728.2 730.1 739.9 783.0 789.4 14551.8 14603.3 14800.2 15691.5 15695.7 14004.3 14474.1 14497.2 14500.5 14642.9 665.8 682.8 789.2 803.0 807.6 812.3 814.2 815.0 815.2 815.6 842.0 847.9 848.1 849.6 849.6 842.9 843.7 844.0 844.2 844.6 616.1 616.2 616.5 616.7 616.9 13402.4 13543.7 13714.0 13725.5 15077.0 14133.4 14874.1 14934.9 14990.5 15131.7 11278.1 11284.8 11334.7 11411.1 11570.2 4326.0 4400.8 4413.8 4526.1 4617.3 63136.7 63304.0 64807.4 65174.0 65247.0 10970.2 10996.5 10996.7 11022.7 11283.3 19138.0 19202.3 19204.6 19208.8 19368.6 7964.2 8049.4 8065.6 8156.1 8394.3 4603.6 4626.5 4671.6 4722.6 4777.9 3226.4 3292.5 3302.0 3600.2 3655.4 589.3 593.9 625.6 629.6 636.7 615.8 650.5 737.8 745.4 777.2 9554.0 9710.8 9718.0 9739.9 9830.7 611.3 634.4 650.2 725.6 760.4 4528.2 4649.1 4707.6 4741.5 4753.6 51721.2 69009.0 87657.6 87885.0 91059.5 47901.0 48349.8 55711.0 63218.7 77443.0 66914.3 68780.7 69191.3 70852.0 71666.6 8957.4 9013.7 9180.6 9287.3 9333.9 48639.8 49020.3 49269.5 49883.5 50144.0 60906.0 66120.7 66648.3 66776.3 66822.0 11061.3 11303.5 11497.4 11579.8 11686.4 13039.9 13058.7 13209.6 13315.6 13466.3 12391.6 12466.6 12559.6 12582.8 12744.3 11811.3 11813.2 11855.4 12288.3 12289.9 11900.8 12176.2 12180.8 12232.8 12759.7 10103.5 10345.8 10393.6 10522.2 10542.1 9931.3 10525.3 10549.0 10734.9 10738.2 10:12:03 INFO - PROCESS | 18388 | -------- Summary: end -------- 10:12:03 INFO - PROCESS | 18388 | 10:12:04 INFO - TEST-INFO | 18388: exit 0 10:12:04 INFO - TEST-OK | dromaeo_css | took 1116912ms 10:12:04 INFO - TEST-START | kraken 10:12:04 INFO - operating with platform_type : linux_ 10:12:04 INFO - Initialising browser for kraken test... 10:12:04 INFO - TEST-INFO | started process 18693 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdgHXcG/profile http://localhost:38844/getInfo.html) 10:12:08 INFO - PROCESS | 18693 | __metrics Screen width/height:1600/1200 10:12:08 INFO - PROCESS | 18693 | colorDepth:24 10:12:08 INFO - PROCESS | 18693 | Browser inner width/height: 1024/697 10:12:08 INFO - PROCESS | 18693 | __metrics 10:12:09 INFO - PROCESS | 18693 | 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" 10:12:09 INFO - PROCESS | 18693 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 205: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:12:09 INFO - PROCESS | 18693 | console.error: PushService: 10:12:09 INFO - PROCESS | 18693 | stateChangeProcessEnqueue: Error transitioning state 10:12:09 INFO - PROCESS | 18693 | UnknownError 10:12:10 INFO - TEST-INFO | 18693: exit 0 10:12:10 INFO - Browser initialized. 10:12:10 INFO - Running cycle 1/1 for kraken test... 10:12:10 INFO - TEST-INFO | started process 18775 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdgHXcG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:12:22 INFO - PROCESS | 18775 | RSS: Main: 174264320 10:12:22 INFO - PROCESS | 18775 | 10:12:24 INFO - PROCESS | 18775 | Cycle 1(1): loaded http://localhost:38844/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38844/tests/kraken/driver.html?testName=audio-beat-detection) 10:12:25 INFO - PROCESS | 18775 | RSS: Main: 230776832 10:12:25 INFO - PROCESS | 18775 | 10:12:28 INFO - PROCESS | 18775 | Cycle 1(1): loaded http://localhost:38844/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38844/tests/kraken/driver.html?testName=audio-dft) 10:12:29 INFO - PROCESS | 18775 | RSS: Main: 217358336 10:12:29 INFO - PROCESS | 18775 | 10:12:32 INFO - PROCESS | 18775 | Cycle 1(1): loaded http://localhost:38844/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38844/tests/kraken/driver.html?testName=audio-fft) 10:12:32 INFO - PROCESS | 18775 | RSS: Main: 299892736 10:12:32 INFO - PROCESS | 18775 | 10:12:34 INFO - PROCESS | 18775 | Cycle 1(1): loaded http://localhost:38844/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38844/tests/kraken/driver.html?testName=audio-oscillator) 10:12:35 INFO - PROCESS | 18775 | RSS: Main: 210702336 10:12:35 INFO - PROCESS | 18775 | 10:12:37 INFO - PROCESS | 18775 | Cycle 1(1): loaded http://localhost:38844/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38844/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:12:38 INFO - PROCESS | 18775 | RSS: Main: 213794816 10:12:38 INFO - PROCESS | 18775 | 10:12:41 INFO - PROCESS | 18775 | Cycle 1(1): loaded http://localhost:38844/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38844/tests/kraken/driver.html?testName=imaging-darkroom) 10:12:41 INFO - PROCESS | 18775 | RSS: Main: 249540608 10:12:41 INFO - PROCESS | 18775 | 10:12:45 INFO - PROCESS | 18775 | Cycle 1(1): loaded http://localhost:38844/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38844/tests/kraken/driver.html?testName=imaging-desaturate) 10:12:45 INFO - PROCESS | 18775 | RSS: Main: 248541184 10:12:45 INFO - PROCESS | 18775 | 10:12:48 INFO - PROCESS | 18775 | Cycle 1(1): loaded http://localhost:38844/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38844/tests/kraken/driver.html?testName=json-parse-financial) 10:12:49 INFO - PROCESS | 18775 | RSS: Main: 247992320 10:12:49 INFO - PROCESS | 18775 | 10:12:50 INFO - PROCESS | 18775 | Cycle 1(1): loaded http://localhost:38844/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38844/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:12:51 INFO - PROCESS | 18775 | RSS: Main: 210141184 10:12:51 INFO - PROCESS | 18775 | 10:12:52 INFO - PROCESS | 18775 | Cycle 1(1): loaded http://localhost:38844/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38844/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:12:53 INFO - PROCESS | 18775 | RSS: Main: 217899008 10:12:53 INFO - PROCESS | 18775 | 10:12:55 INFO - PROCESS | 18775 | Cycle 1(1): loaded http://localhost:38844/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38844/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:12:56 INFO - PROCESS | 18775 | RSS: Main: 227438592 10:12:56 INFO - PROCESS | 18775 | 10:12:58 INFO - PROCESS | 18775 | Cycle 1(1): loaded http://localhost:38844/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38844/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:12:59 INFO - PROCESS | 18775 | RSS: Main: 233000960 10:12:59 INFO - PROCESS | 18775 | 10:13:02 INFO - PROCESS | 18775 | Cycle 1(1): loaded http://localhost:38844/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38844/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:13:03 INFO - PROCESS | 18775 | RSS: Main: 233213952 10:13:03 INFO - PROCESS | 18775 | 10:13:04 INFO - PROCESS | 18775 | Cycle 1(1): loaded http://localhost:38844/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38844/tests/kraken/driver.html?testName=ai-astar) 10:13:05 INFO - PROCESS | 18775 | RSS: Main: 284356608 10:13:05 INFO - PROCESS | 18775 | 10:13:05 INFO - PROCESS | 18775 | __start_tp_report 10:13:05 INFO - PROCESS | 18775 | _x_x_mozilla_page_load 10:13:05 INFO - PROCESS | 18775 | _x_x_mozilla_page_load_details 10:13:05 INFO - PROCESS | 18775 | |i|pagename|runs| 10:13:05 INFO - PROCESS | 18775 | |0;ai-astar;105;113;112;110;112;112;113;114;112;111 10:13:05 INFO - PROCESS | 18775 | |1;audio-beat-detection;149;122;122;162;125;126;121;122;172;130 10:13:05 INFO - PROCESS | 18775 | |2;audio-dft;160;161;160;160;159;163;161;161;161;162 10:13:05 INFO - PROCESS | 18775 | |3;audio-fft;75;77;76;105;77;79;76;75;113;75 10:13:05 INFO - PROCESS | 18775 | |4;audio-oscillator;83;83;123;83;84;82;103;83;84;116 10:13:05 INFO - PROCESS | 18775 | |5;imaging-gaussian-blur;117;116;116;118;117;118;118;117;117;116 10:13:05 INFO - PROCESS | 18775 | |6;imaging-darkroom;146;146;146;145;145;146;145;145;145;145 10:13:05 INFO - PROCESS | 18775 | |7;imaging-desaturate;85;85;85;85;85;85;85;85;84;84 10:13:05 INFO - PROCESS | 18775 | |8;json-parse-financial;52;51;52;52;54;55;55;53;53;52 10:13:05 INFO - PROCESS | 18775 | |9;json-stringify-tinderbox;61;62;63;62;63;63;63;62;62;63 10:13:05 INFO - PROCESS | 18775 | |10;stanford-crypto-aes;88;80;81;80;86;79;88;84;81;85 10:13:05 INFO - PROCESS | 18775 | |11;stanford-crypto-ccm;143;131;133;139;133;141;143;139;160;143 10:13:05 INFO - PROCESS | 18775 | |12;stanford-crypto-pbkdf2;173;172;176;170;171;167;165;163;165;170 10:13:05 INFO - PROCESS | 18775 | |13;stanford-crypto-sha256-iterative;66;68;66;65;68;65;65;66;64;63 10:13:05 INFO - PROCESS | 18775 | __end_tp_report 10:13:05 INFO - PROCESS | 18775 | __start_cc_report 10:13:05 INFO - PROCESS | 18775 | _x_x_mozilla_cycle_collect,1734 10:13:05 INFO - PROCESS | 18775 | __end_cc_report 10:13:05 INFO - PROCESS | 18775 | __startTimestamp1477761185003__endTimestamp 10:13:05 INFO - PROCESS | 18775 | 10:13:05 INFO - PROCESS | 18775 | ------- Summary: start ------- 10:13:05 INFO - PROCESS | 18775 | Number of tests: 14 10:13:05 INFO - PROCESS | 18775 | 10:13:05 INFO - PROCESS | 18775 | [#0] ai-astar Cycles:10 Average:111.40 Median:112.00 stddev:2.50 (2.2%) stddev-sans-first:1.17 10:13:05 INFO - PROCESS | 18775 | Values: 105.0 113.0 112.0 110.0 112.0 112.0 113.0 114.0 112.0 111.0 10:13:05 INFO - PROCESS | 18775 | 10:13:05 INFO - PROCESS | 18775 | [#1] audio-beat-detection Cycles:10 Average:135.10 Median:128.00 stddev:18.86 (14.7%) stddev-sans-first:19.33 10:13:05 INFO - PROCESS | 18775 | Values: 149.0 122.0 122.0 162.0 125.0 126.0 121.0 122.0 172.0 130.0 10:13:05 INFO - PROCESS | 18775 | 10:13:05 INFO - PROCESS | 18775 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:1.14 (0.7%) stddev-sans-first:1.17 10:13:05 INFO - PROCESS | 18775 | Values: 160.0 161.0 160.0 160.0 159.0 163.0 161.0 161.0 161.0 162.0 10:13:05 INFO - PROCESS | 18775 | 10:13:05 INFO - PROCESS | 18775 | [#3] audio-fft Cycles:10 Average:82.80 Median:76.00 stddev:13.99 (18.4%) stddev-sans-first:14.55 10:13:05 INFO - PROCESS | 18775 | Values: 75.0 77.0 76.0 105.0 77.0 79.0 76.0 75.0 113.0 75.0 10:13:05 INFO - PROCESS | 18775 | 10:13:05 INFO - PROCESS | 18775 | [#4] audio-oscillator Cycles:10 Average:92.40 Median:83.00 stddev:15.66 (18.9%) stddev-sans-first:16.24 10:13:05 INFO - PROCESS | 18775 | Values: 83.0 83.0 123.0 83.0 84.0 82.0 103.0 83.0 84.0 116.0 10:13:05 INFO - PROCESS | 18775 | 10:13:05 INFO - PROCESS | 18775 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.82 (0.7%) stddev-sans-first:0.87 10:13:05 INFO - PROCESS | 18775 | Values: 117.0 116.0 116.0 118.0 117.0 118.0 118.0 117.0 117.0 116.0 10:13:05 INFO - PROCESS | 18775 | 10:13:05 INFO - PROCESS | 18775 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 10:13:05 INFO - PROCESS | 18775 | Values: 146.0 146.0 146.0 145.0 145.0 146.0 145.0 145.0 145.0 145.0 10:13:05 INFO - PROCESS | 18775 | 10:13:05 INFO - PROCESS | 18775 | [#7] imaging-desaturate Cycles:10 Average:84.80 Median:85.00 stddev:0.42 (0.5%) stddev-sans-first:0.44 10:13:05 INFO - PROCESS | 18775 | Values: 85.0 85.0 85.0 85.0 85.0 85.0 85.0 85.0 84.0 84.0 10:13:05 INFO - PROCESS | 18775 | 10:13:05 INFO - PROCESS | 18775 | [#8] json-parse-financial Cycles:10 Average:52.90 Median:53.00 stddev:1.37 (2.6%) stddev-sans-first:1.41 10:13:05 INFO - PROCESS | 18775 | Values: 52.0 51.0 52.0 52.0 54.0 55.0 55.0 53.0 53.0 52.0 10:13:05 INFO - PROCESS | 18775 | 10:13:05 INFO - PROCESS | 18775 | [#9] json-stringify-tinderbox Cycles:10 Average:62.40 Median:63.00 stddev:0.70 (1.1%) stddev-sans-first:0.53 10:13:05 INFO - PROCESS | 18775 | Values: 61.0 62.0 63.0 62.0 63.0 63.0 63.0 62.0 62.0 63.0 10:13:05 INFO - PROCESS | 18775 | 10:13:05 INFO - PROCESS | 18775 | [#10] stanford-crypto-aes Cycles:10 Average:83.20 Median:84.50 stddev:3.43 (4.1%) stddev-sans-first:3.16 10:13:05 INFO - PROCESS | 18775 | Values: 88.0 80.0 81.0 80.0 86.0 79.0 88.0 84.0 81.0 85.0 10:13:05 INFO - PROCESS | 18775 | 10:13:05 INFO - PROCESS | 18775 | [#11] stanford-crypto-ccm Cycles:10 Average:140.50 Median:142.00 stddev:8.21 (5.8%) stddev-sans-first:8.66 10:13:05 INFO - PROCESS | 18775 | Values: 143.0 131.0 133.0 139.0 133.0 141.0 143.0 139.0 160.0 143.0 10:13:05 INFO - PROCESS | 18775 | 10:13:05 INFO - PROCESS | 18775 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.20 Median:170.50 stddev:4.10 (2.4%) stddev-sans-first:4.12 10:13:05 INFO - PROCESS | 18775 | Values: 173.0 172.0 176.0 170.0 171.0 167.0 165.0 163.0 165.0 170.0 10:13:05 INFO - PROCESS | 18775 | 10:13:05 INFO - PROCESS | 18775 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.60 Median:66.00 stddev:1.58 (2.4%) stddev-sans-first:1.67 10:13:05 INFO - PROCESS | 18775 | Values: 66.0 68.0 66.0 65.0 68.0 65.0 65.0 66.0 64.0 63.0 10:13:05 INFO - PROCESS | 18775 | -------- Summary: end -------- 10:13:05 INFO - PROCESS | 18775 | 10:13:06 INFO - TEST-INFO | 18775: exit 0 10:13:06 INFO - TEST-OK | kraken | took 61596ms 10:13:06 INFO - SUITE-END | took 1178s 10:13:06 INFO - Completed test suite (00:19:38) 10:13:06 INFO - javascript benchmark 10:13:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2946.248706579822, 2946.4549058424195, 2996.9250768730785, 3000.4899167141584, 3005.2637103909533, 5038.848834534961, 5114.360704911886, 5173.637845350827, 5271.288376069229, 5350.063738845706, 5177.326947496829, 5336.519713225809, 5452.890942181164, 5467.535259502947, 5471.945280547194, 4772.68977516462, 4799.52004799519, 4852.708837469745, 4867.488913664068, 4899.510048995107, 4880.145974454474, 4897.951020489803, 4949.307097006404, 4958.6281028922795, 4995.425526064513, 4828.372311599504, 4847.224444088929, 4905.632077594177, 4920.753962301888, 4939.234418665113, 4699.835505757316, 4711.575958163782, 4737.834175803865, 4743.928841067387, 4744.383230180089, 4709.222978208626, 4719.811207551694, 4733.0, 4791.7124972501415, 4795.784189711471, 5190.0, 5195.0, 5195.714235717034, 5200.479952004769, 5215.452377500384, 5458.4541545845095, 5499.1476321170285, 5555.111182210827, 5563.13771365439, 5595.048841696921, 5662.773489060432, 5666.801661941812, 5695.743691533891, 5760.423957604248, 5768.451997060314, 5294.100002999499, 5301.6818990860675, 5308.23030660552, 5312.5218730314455, 5312.814051508218, 5655.971720141373, 5706.058500347479, 5789.073748200268, 5801.747968891901, 5866.6186697864505, 5523.364813046471, 5532.972335138298, 5573.888522229533, 5605.775768969277, 5627.324721033502, 5566.053770858964, 5600.299962504687, 5694.088945768657, 5695.772169113272, 5702.800401985911, 5408.756605952742, 5638.464345887134, 5703.885922281531, 5711.8000869969355, 5715.085586306171, 5475.288212532345, 5665.858353541112, 5671.971640141773, 5722.885542289131, 5725.255716756878, 4421.955780442155, 4424.646028317727, 4425.867223983286, 4439.600435960779, 4486.820527178877, 3819.8854034378455, 3834.0989867381145, 3908.511436070491, 3952.644262016375, 3978.8607398740905, 5296.232046353257, 5327.493888080626, 5331.360236771535, 5343.038253114399, 5416.322959630046, 5623.606347555714, 5625.38120806711, 5626.0, 5629.211910332557, 5636.60543761941, 5247.396549396792, 5342.572594192456, 5347.197920311906, 5349.5720342372515, 5407.107827208467, 4812.1578723723205, 4879.536444037811, 4880.633952453509, 4882.316475693406, 4886.242632391985, 5783.826485205451, 5838.445347692047, 5847.561432892635, 5851.093080572518, 5864.44287792659, 5639.6334238274385, 5642.492175704207, 5642.689652069175, 5644.463775941279, 5650.180723795109, 5797.681127538026, 5851.356350801323, 5856.560757943256, 5859.677717725566, 5863.0, 5555.833325000256, 5567.69377684215, 5568.0, 5575.470330318613, 5577.024020796263, 5612.382637909908, 5630.0991841305195, 5641.153826925994, 5643.322801263875, 5643.52030077448, 5522.723863806874, 5526.723663816712, 5536.390996990408, 5580.665160090408, 5592.916106258328, 5547.0570003098765, 5558.471945165203, 5559.58303127259, 5560.249366335493, 5569.303837020372, 5278.0, 5306.28365170697, 5472.91790623133, 5509.256250406143, 5631.465010823965, 5576.888462230651, 5589.944100558942, 5596.300462442195, 5643.802466913638, 5646.548276137982, 5447.264619276505, 5449.400565937823, 5454.563634909118, 5461.0, 5465.262189604353], "value": 5213.245268721361, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [569.5045310579796, 608.2670382189461, 630.4263120560289, 636.7643971730463, 648.7696867611995, 30221.0, 41237.587624123786, 42016.0, 42122.57877421233, 45260.77369613155, 41744.58255417445, 42139.367909481385, 42199.15601687964, 42213.0, 42225.155496890045, 7970.681172753083, 8747.737567872973, 8890.333225008118, 8893.28853691703, 8898.42160259581, 7836.4906281091835, 10416.322939008978, 10628.362298262091, 10635.468226588679, 10956.726081847977, 10711.0, 10737.624183153592, 10737.892621073806, 10746.892531074707, 10747.247692661516, 7900.288973992311, 8107.067687215927, 10581.523831427567, 10632.78734425307, 10641.5211315491, 10117.595296188143, 10434.217433692427, 10436.895631043668, 10727.892721072845, 10759.462026898702, 40748.59251407478, 41334.0, 41346.1730765386, 41409.1718165635, 41473.585264147274, 3390.3219356128875, 3412.095794614429, 3511.9122021949656, 3762.2475504898857, 4047.5952404759582, 29088.272793180127, 29493.41013179746, 31210.843945780354, 31273.0, 32729.345413091603, 4407.493138289105, 4416.955830441719, 4436.689431739779, 4455.598996090367, 4468.784227820392, 306536.0, 312345.43827280944, 313475.0, 314066.0, 314562.0, 59655.70172149112, 60539.39460605426, 60618.393816062155, 60713.696431518445, 60723.0, 34971.125721856646, 35487.0, 35643.0, 37538.05545974003, 63550.0, 15870.44453444124, 16105.19474026294, 16137.515874523782, 16150.19249037567, 16153.0, 9884.901150988542, 9972.202223822076, 11906.226095303951, 12136.87863121375, 12335.568255111028, 18996.715049274273, 19201.231950722093, 19322.80677193238, 19356.0, 19376.806231937782, 7326.699038826605, 7406.44736776506, 7473.887891681629, 7673.091719376049, 7914.169012253746, 990.782027953849, 1010.7220514358463, 1055.0820785916303, 1076.2412499188054, 1113.1150735165563, 31993.840030799696, 32407.67592324094, 32496.512552311735, 32571.0, 33014.8349258257, 1102.7463683352873, 1123.2811000959393, 1130.9264897781618, 1135.3471753741633, 1149.1898211760688, 16357.263923123488, 17097.83690017351, 17106.230219640147, 17223.483295501155, 17359.65280694379, 491647.0, 498216.0, 499012.0, 499073.0, 499554.0, 56446.15330770042, 57061.42938570561, 57075.0, 57080.42919570834, 57186.14220786691, 1195.4560674892903, 1197.5329621447643, 1311.265691212924, 1320.854705982341, 1364.5000573529064, 29033.564496532148, 32516.34967300688, 32901.0, 33279.66720332862, 33565.83217083899, 43573.782131089145, 43782.0, 43797.34303985379, 43880.122397552506, 43891.12217755691, 366654.0, 369117.0, 369143.0, 370304.0, 370701.0, 27253.454930900873, 28276.43447131087, 28328.716712832607, 28332.57501137526, 28345.574816378183, 45676.771616141705, 45855.0, 46270.30594541152, 46394.53605463902, 46908.7654561725, 38857.80571097126, 39163.804180980056, 39234.2153156941, 39713.40429893612, 41270.58729412667, 39161.41257881191, 39485.210295794495, 40225.19549608933, 40487.59512404956, 41341.0, 39848.0, 40430.79784601176, 41031.58968410397, 41075.383869242585, 41172.79413602913, 33496.83251583727, 34694.30611387808, 35443.82278088593, 36274.4558831623, 36831.0, 27540.724592753817, 27722.722772772013, 27779.86110069437, 27794.0, 27904.30239244035], "value": 19736.597933027457, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [361.8733443294849, 372.2536314689048, 380.75355403121586, 383.1819066293464, 398.96409323160907, 14140.363683634236, 17933.372331968385, 18504.814951850476, 19341.129649165785, 19533.12100955457, 17593.56016099595, 17689.29242830285, 18255.54361140972, 18411.0, 18539.887606743603, 5429.972850135754, 5702.344230413514, 5703.31560212773, 5704.058830293017, 5705.543556515489, 5399.9730001349935, 5574.526165275956, 5656.886862262752, 5662.518685911682, 5668.319801623811, 5736.885262294752, 5739.253896993385, 5739.598228124012, 5743.712814359286, 5745.368009518949, 5569.359523654791, 5700.543956483471, 5734.627249228808, 5742.770289188427, 5745.138229265602, 5551.1118221084835, 5565.3599836018975, 5568.777248910039, 5569.693666848321, 5569.805056823032, 13426.0601757877, 13561.25413102279, 13562.118462300017, 13571.1857288563, 16610.00339979593, 2182.792634699701, 2194.7272772536066, 2263.5812374710567, 2518.043143605418, 2530.266222795387, 8975.551222438851, 9146.496942668151, 9556.522173891348, 9638.566264518113, 9770.51147442625, 1831.349870795875, 1849.5745978424902, 1884.0579710144928, 1918.2327069172304, 1925.5282455798279, 75469.0, 77878.0, 78178.0, 78528.82206766961, 79436.60281698612, 10253.282270241012, 10320.69737683934, 10504.789904201873, 10677.412742299248, 11211.103111751041, 14557.199354035629, 14557.490487832874, 14560.199189044492, 14570.562883113524, 14577.635559110895, 6789.592624442451, 6944.965275173693, 6947.687354069079, 7044.189918159374, 7357.705691772269, 6161.84595385119, 6248.562600618004, 6494.447971922439, 6505.707243174069, 6512.316206798313, 4351.6518678505645, 4480.663950203748, 4506.3465797459185, 4574.519675434098, 4609.331646911179, 1860.237302705884, 1868.2993877296014, 1937.2928880958348, 1942.4366933589383, 1956.2761778141894, 846.8391005708895, 932.6222879733718, 979.5543027922279, 987.0, 1055.145332280855, 17911.641767164845, 18678.0, 18839.811601883805, 18890.90554547246, 19207.8079219206, 924.6994726713845, 939.478589382899, 940.6989763275823, 961.8990006049404, 968.9031096890254, 10122.797544049077, 10788.406637635006, 10792.190585706103, 10810.0, 10810.783784324269, 417565.0, 418491.0, 420000.0, 426103.0, 433876.0, 85074.0, 88430.55784721163, 89764.0, 90366.0, 92643.0, 988.7132731507783, 1022.6625213679467, 1026.7895081508273, 1029.6756521695643, 1036.03131072446, 16905.577360566083, 17489.179220104423, 18089.0, 18129.0, 18237.361692340703, 41055.178896421305, 41153.79423102865, 41571.37642935419, 42232.36651450169, 43561.23846561474, 56269.71865140648, 56995.0, 57639.711801440724, 58250.12624810716, 58323.4167658335, 8077.394195435249, 8150.7147249845975, 8193.67225310981, 8337.958310208653, 8498.362622803192, 12738.936305318784, 12893.226406415644, 12943.5469758558, 13511.0, 13615.319234038456, 10923.781524369628, 11247.943760281147, 11366.431678416211, 11486.885131148581, 12142.392880356123, 10138.594456221668, 11060.17048721333, 11267.661970140909, 11351.318920864443, 11520.711982200512, 10957.780844382909, 10999.670009899715, 11281.830772538582, 11478.196526243082, 11735.941320293345, 7992.600369981361, 8063.435559510778, 8064.314533264738, 8174.754757357289, 8392.32861371101, 9679.467629280458, 11019.559217631526, 11327.716807079889, 11391.0, 11494.367809770543], "value": 8745.329040072611, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1287.9871201287983, 1437.374741987236, 1457.2640816387725, 1588.2535208452023, 1714.1429285357322, 7238.565686058841, 8139.593020348981, 8399.202075802805, 8424.705135320264, 8593.699220527284, 8416.95791521043, 8473.872891906627, 8474.279686226679, 8521.954730864594, 8531.829363412728, 2312.6762253284555, 2344.601417758985, 2347.542229265294, 2349.5300939812105, 2355.458244603742, 2241.2267767620147, 2318.5942460069505, 2321.071571371448, 2322.1872344679396, 2328.057136859566, 2294.1511640692966, 2312.1329501436962, 2322.477442575424, 2323.1056043423237, 2327.034280773477, 2216.2686313516583, 2265.501589650274, 2267.1271560449263, 2268.5576312619046, 2270.3189043286948, 2253.7971582557648, 2270.4096934796908, 2290.89690963907, 2293.6100862853355, 2294.988525057364, 8165.428420010601, 8436.87344689824, 8454.746357609281, 8491.872621910676, 8494.702685406042, 5176.611754118456, 5306.0, 5386.084365657847, 5395.541378982791, 5399.811006614749, 3300.273939733255, 3354.66453354665, 3485.494603282535, 3572.5355703758346, 3603.3694103531775, 1082.3505896462138, 1107.5126944144552, 1109.1625822504038, 1112.933224006562, 1137.1585027079984, 11577.479013444416, 11734.941325293405, 11780.646580602595, 11823.527058917633, 11824.172307938534, 4385.912281754347, 4603.125406172817, 4640.1879671058105, 4707.646926480527, 4711.293306004127, 9877.456739879375, 9917.603295868084, 9918.0, 9939.850902236472, 9942.950285248528, 5191.5846732261325, 5196.142636465017, 5196.662216955886, 5200.037992971313, 5200.739963001834, 4210.726302790309, 4235.9364609530885, 4810.927836082462, 4846.7818948147415, 4854.927176092361, 3762.887113386603, 3771.113788259757, 3884.320243957296, 3896.493455850721, 3933.783641899723, 1241.2862604002735, 1257.8427696537933, 1274.120856608937, 1277.8147168660678, 1287.7939529675207, 786.8150984518634, 792.484884824857, 851.3699862102, 905.899332311245, 907.5280853956037, 5475.479829416199, 5691.686957217393, 5735.569832262597, 5854.2389489366105, 5893.44012318829, 976.7753416714054, 992.1417973453056, 993.8807343118727, 1002.4686915934566, 1003.9548220330103, 3700.4264339027495, 3708.7589306694977, 3766.0, 3782.9432558511644, 3845.6346647068485, 10215.489225538693, 10419.06228439429, 10496.527656255486, 10522.684319470429, 10525.315854469434, 10377.9481102594, 10404.531796069195, 10477.738056548495, 10488.26582139243, 10492.16062714981, 7538.434617403716, 7822.6479808409895, 7864.72473463426, 8050.396220283502, 8056.436049476481, 5622.8313150605545, 5778.306603207474, 5784.5083167929515, 5819.447152520504, 5929.110633405024, 9431.717048488556, 9456.0, 9528.666496672584, 9545.570449329936, 9613.230941524802, 9576.425414475154, 9648.131668149901, 9657.565409556728, 9752.512374381395, 9763.85354219673, 6586.1438013058, 6786.049953006682, 7398.630068496661, 7508.436867235088, 7542.962285188539, 7981.122076571456, 8150.062742784656, 8298.792530186794, 8315.95842020786, 8316.251537361666, 7184.892226616709, 7294.088238970129, 7429.5542267464125, 7487.288707572772, 7632.771016869503, 7060.0, 7309.232530584212, 7373.483856130019, 7431.0, 7516.285952834472, 6579.934200658124, 6648.601083934979, 6815.182178138655, 6927.134108236471, 6937.167539895245, 4780.139574876555, 4946.8763280918265, 5016.724080175625, 5029.044481548494, 5107.489251074863, 5063.291139240583, 5214.32213812202, 5223.712695801767, 5250.369955605352, 5336.706481143575], "value": 4503.6892101230005, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [324.09738877226914, 325.2356961141318, 333.9716124129448, 337.7652531490615, 341.39743352981975, 5007.799688012475, 5131.2046632771935, 5182.818601348954, 5211.244369566415, 5213.139831927737, 4999.625028122896, 5023.522765337287, 5047.671901326411, 5065.341505604266, 5109.620402491325, 4081.755094694328, 4101.671866250693, 4105.137921036586, 4107.383892416139, 4133.090720041586, 3999.8200080996426, 4091.9590804092027, 4094.9385759213637, 4095.9555313395044, 4119.7940102994735, 4050.5949405059405, 4065.6137666921595, 4083.9370472145893, 4097.651699605537, 4100.0, 4047.433359329696, 4067.2272268268935, 4070.633642972147, 4074.5925407459313, 4101.0, 3645.143391303042, 3652.214773823614, 3661.21283923955, 3661.9450708239397, 3691.427828686531, 4811.855644330676, 5023.246513023076, 5038.345015148044, 5038.571721403649, 5052.120291433884, 4643.210654188796, 4646.628269738413, 4681.50844161365, 4683.531646835289, 4689.906201875943, 5350.652207606493, 5359.767253531671, 5364.892702145974, 5367.785288588452, 5384.246205531229, 3779.9433008504893, 3951.4072889066583, 3962.821673024721, 3967.107400834818, 3983.092342589897, 5430.945690543083, 5480.945190548123, 5511.862203444946, 5517.641353312022, 5531.814933101443, 4059.3910913363234, 4059.817308221137, 4060.167665628539, 4061.654759345489, 4100.91798164035, 4034.374671925856, 4066.3900414938, 4092.708083473205, 4151.878992671962, 4161.417401563784, 4578.496365399803, 4587.472440669366, 4597.678162528658, 4600.7469589172915, 4609.7695115244105, 5319.893602128013, 5334.786608535615, 5336.0, 5347.67376191358, 5355.839324820262, 1357.1585616917575, 1383.6056723833658, 1383.6471699716508, 1410.379433049455, 1420.808190894216, 972.7665360313615, 993.4635296939572, 1009.8687170667766, 1011.3022014809758, 1022.8619136416637, 5144.71704056273, 5161.0, 5192.636515443958, 5226.346706661668, 5235.73821308933, 5412.863298707237, 5435.374931882884, 5440.898687747946, 5471.151971444432, 5476.7535460904355, 4950.975245123824, 5108.489151084862, 5145.794168233304, 5185.2999845021195, 5203.635745497854, 2529.784968277717, 2542.703221357121, 2559.8208125431042, 2561.398071453207, 2569.678790151231, 4938.629602779806, 4957.132501812169, 4957.414391687675, 4974.552290293818, 4984.529563778694, 4824.372831531879, 4841.3222148899185, 4856.353287458273, 5239.751354160445, 5550.972245138829, 5724.599278050497, 5726.341470730836, 5729.598928074995, 5735.397783232784, 5752.482276595127, 5448.692313844728, 5450.863728406822, 5485.835424937259, 5499.780008799603, 5584.357798853184, 5157.484251574812, 5362.195670649277, 5388.434214407431, 5434.157705555645, 5462.262594549685, 5664.915026274692, 5682.147677848356, 5685.232493613309, 5685.630434021776, 5691.0, 3976.363781794899, 3982.940255896222, 3990.700697447645, 3995.340768773236, 3997.380406037069, 5140.228965655182, 5343.759530821045, 5422.430644782399, 5423.3491980962535, 5429.592780541554, 5152.536271735562, 5227.372715274191, 5334.399680096033, 5367.892642147213, 5368.919466207932, 5354.303940487712, 5362.758675859518, 5392.35291764975, 5399.5950303726595, 5432.511074003359, 5258.921116183184, 5330.653507521999, 5356.437574054668, 5407.378151512627, 5413.0, 5361.276227709365, 5366.543843773323, 5377.542908852792, 5389.299391079135, 5404.784153428861, 5281.445448228034, 5295.338082739658, 5313.707746073848, 5324.866878328073, 5330.413654497925], "value": 4097.981602480422, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [728.2062551818517, 730.1347902735256, 739.9297066778657, 783.0, 789.3763926498067, 14551.78172327416, 14603.269836508158, 14800.185989770558, 15691.45079922203, 15695.686086278281, 14004.29978501076, 14474.131552106855, 14497.202653854034, 14500.492482763078, 14642.853571464282, 665.8435267712084, 682.754208484945, 789.1792535762828, 803.0283357137855, 807.6002378822491, 812.2567850416862, 814.1776805426532, 815.0463957170095, 815.2499700275761, 815.5636734347125, 842.0232530264894, 847.9448835825651, 848.101012926297, 849.6389034660275, 849.6473963305252, 842.8988521377444, 843.696269343036, 844.0462277626274, 844.2401838345507, 844.5692696724715, 616.1466369078857, 616.2266355723583, 616.5499185594541, 616.747133675191, 616.8951278282702, 13402.396892139877, 13543.729125417436, 13714.0, 13725.45098196071, 15077.0, 14133.434662613587, 14874.107553546713, 14934.850651493454, 14990.47533336328, 15131.697366052727, 11278.097752179807, 11284.774304513945, 11334.71663208418, 11411.087113030937, 11570.247933884271, 4325.956740432587, 4400.779961001969, 4413.7793110344355, 4526.094781043805, 4617.284320930261, 63136.68431657858, 63304.0, 64807.351926481075, 65174.0, 65247.0, 10970.232083754061, 10996.505157267782, 10996.725081872857, 11022.724431889266, 11283.323000619988, 19138.0, 19202.327918522784, 19204.615907681768, 19208.80791192098, 19368.612627747367, 7964.243396877403, 8049.356051515864, 8065.556394398247, 8156.062052863878, 8394.328453723687, 4603.58567728906, 4626.4910859805395, 4671.602913752301, 4722.598579120813, 4777.928331075037, 3226.419244535959, 3292.506124081407, 3301.992892167864, 3600.2439487707875, 3655.391627683811, 589.3369958796354, 593.8663800644907, 625.5902383938527, 629.6190804563173, 636.6912047656883, 615.827568280882, 650.4861159683892, 737.8229224985964, 745.3887811994222, 777.1994845309227, 9553.952230238805, 9710.805783884423, 9718.0, 9739.853902191473, 9830.655927042662, 611.2909025530363, 634.4321831960369, 650.1807722269974, 725.5972935021008, 760.4068826315482, 4528.184926713157, 4649.139909116824, 4707.552782485658, 4741.502142275081, 4753.619710423158, 51721.224181637306, 69009.0, 87657.56171219103, 87885.0, 91059.54470227606, 47901.0, 48349.75825120852, 55711.0, 63218.68390658109, 77443.0, 66914.30114085138, 68780.65609671919, 69191.3080869195, 70851.99999999897, 71666.64166679133, 8957.417767845069, 9013.729588112366, 9180.586873590839, 9287.257019438293, 9333.859992099988, 48639.756801215764, 49020.2646960303, 49269.50730492649, 49883.50116498789, 50144.0, 60906.0, 66120.66939665271, 66648.33351666616, 66776.33223667895, 66822.0, 11061.281016733887, 11303.547858085585, 11497.425128743362, 11579.768404631692, 11686.415679215836, 13039.934800325938, 13058.673533161367, 13209.603711888658, 13315.600531984055, 13466.326683665582, 12391.62825115248, 12466.56367027186, 12559.62321130331, 12582.811257830957, 12744.299063551594, 11811.291322520676, 11813.173077884465, 11855.407229638311, 12288.262704237774, 12289.938550307548, 11900.76198476043, 12176.208546444454, 12180.817287740514, 12232.755344892874, 12759.74480510366, 10103.49482525856, 10345.793084138124, 10393.636222732168, 10522.21083418762, 10542.051215390651, 9931.304808663324, 10525.315854469742, 10549.0, 10734.946325268324, 10738.248322617343], "value": 7031.430669107356, "unit": "score"}], "name": "dromaeo_css", "value": 6991.400649502932, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 113.0, 112.0, 110.0, 112.0, 112.0, 113.0, 114.0, 112.0, 111.0], "value": 111.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 122.0, 122.0, 162.0, 125.0, 126.0, 121.0, 122.0, 172.0, 130.0], "value": 135.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 160.0, 160.0, 159.0, 163.0, 161.0, 161.0, 161.0, 162.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 76.0, 105.0, 77.0, 79.0, 76.0, 75.0, 113.0, 75.0], "value": 82.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 123.0, 83.0, 84.0, 82.0, 103.0, 83.0, 84.0, 116.0], "value": 92.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 116.0, 118.0, 117.0, 118.0, 118.0, 117.0, 117.0, 116.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 145.0, 145.0, 146.0, 145.0, 145.0, 145.0, 145.0], "value": 145.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 85.0, 85.0, 85.0, 85.0, 85.0, 85.0, 84.0, 84.0], "value": 84.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 51.0, 52.0, 52.0, 54.0, 55.0, 55.0, 53.0, 53.0, 52.0], "value": 52.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 63.0, 62.0, 63.0, 63.0, 63.0, 62.0, 62.0, 63.0], "value": 62.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 80.0, 81.0, 80.0, 86.0, 79.0, 88.0, 84.0, 81.0, 85.0], "value": 83.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 131.0, 133.0, 139.0, 133.0, 141.0, 143.0, 139.0, 160.0, 143.0], "value": 140.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 172.0, 176.0, 170.0, 171.0, 167.0, 165.0, 163.0, 165.0, 170.0], "value": 169.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 66.0, 65.0, 68.0, 65.0, 65.0, 66.0, 64.0, 63.0], "value": 65.6, "unit": "score"}], "name": "kraken", "value": 1503.5, "alertThreshold": 2.0}]} 10:13:06 INFO - Return code: 0 10:13:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:13:06 INFO - # TBPL SUCCESS # 10:13:06 INFO - Running post-action listener: _resource_record_post_action 10:13:06 INFO - [mozharness: 2016-10-29 17:13:06.800547Z] Finished run-tests step (success) 10:13:06 INFO - Running post-run listener: _resource_record_post_run 10:13:06 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 4096; Write bytes: 397479936; Read time: 16; Write time: 255372 10:13:06 INFO - TinderboxPrint: CPU usage
13.1% 10:13:06 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 10:13:06 INFO - TinderboxPrint: I/O write bytes / time
397,479,936 / 255,372 10:13:06 INFO - TinderboxPrint: CPU idle
8,295.2 (86.9%) 10:13:06 INFO - TinderboxPrint: CPU user
1,198.5 (12.6%) 10:13:06 INFO - TinderboxPrint: Swap in / out
0 / 0 10:13:06 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 108879872; Read time: 0; Write time: 62092 10:13:06 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 0; Write bytes: 288600064; Read time: 0; Write time: 193280 10:13:07 INFO - Running post-run listener: _upload_blobber_files 10:13:07 INFO - Blob upload gear active. 10:13:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:13:07 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 10:13:07 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'] 10:13:07 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 10:13:07 INFO - (blobuploader) - INFO - Open directory for files ... 10:13:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:13:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:13:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:13:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:13:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:13:08 INFO - (blobuploader) - INFO - Done attempting. 10:13:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:13:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:13:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:13:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:13:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:13:10 INFO - (blobuploader) - INFO - Done attempting. 10:13:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:13:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:13:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:13:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:13:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:13:14 INFO - (blobuploader) - INFO - Done attempting. 10:13:14 INFO - (blobuploader) - INFO - Iteration through files over. 10:13:14 INFO - Return code: 0 10:13:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:13:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:13:14 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/75960a377790a47b9a93301c9570f59e8e6090c5c8185ec4e28c48cb2d7d87b4348da66e5a1fe0a5b125ca86dffba2bd3bb44ab8a00f1a1fde1d443605568168", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f12c6354ec809ed7f398cc8c6056e19ea5954233f9988bb035769d6c91e257c6a83efd8302d048b58b54cf52a2c6dc46e965102324620a6aefbaed2b07ebe47e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0ddae58243b67bf29f5c6faa925b3171793b077bd12db4ca3cf1e6b3d5aae3226369b4f6dc522953ab861e3c8f2555add88d308d9d51fb597d522529ac141dfc"} 10:13:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:13:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:13:14 INFO - Contents: 10:13:14 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/75960a377790a47b9a93301c9570f59e8e6090c5c8185ec4e28c48cb2d7d87b4348da66e5a1fe0a5b125ca86dffba2bd3bb44ab8a00f1a1fde1d443605568168", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f12c6354ec809ed7f398cc8c6056e19ea5954233f9988bb035769d6c91e257c6a83efd8302d048b58b54cf52a2c6dc46e965102324620a6aefbaed2b07ebe47e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0ddae58243b67bf29f5c6faa925b3171793b077bd12db4ca3cf1e6b3d5aae3226369b4f6dc522953ab861e3c8f2555add88d308d9d51fb597d522529ac141dfc"} 10:13:14 INFO - Running post-run listener: copy_logs_to_upload_dir 10:13:14 INFO - Copying logs to upload dir... 10:13:14 INFO - mkdir: /builds/slave/test/build/upload/logs 10:13:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.807736 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-10-29 10:13:14.709385) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-29 10:13:14.712760) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1477759944.458452-1428239084 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/75960a377790a47b9a93301c9570f59e8e6090c5c8185ec4e28c48cb2d7d87b4348da66e5a1fe0a5b125ca86dffba2bd3bb44ab8a00f1a1fde1d443605568168", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f12c6354ec809ed7f398cc8c6056e19ea5954233f9988bb035769d6c91e257c6a83efd8302d048b58b54cf52a2c6dc46e965102324620a6aefbaed2b07ebe47e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0ddae58243b67bf29f5c6faa925b3171793b077bd12db4ca3cf1e6b3d5aae3226369b4f6dc522953ab861e3c8f2555add88d308d9d51fb597d522529ac141dfc"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477747962/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011147 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477747962/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/75960a377790a47b9a93301c9570f59e8e6090c5c8185ec4e28c48cb2d7d87b4348da66e5a1fe0a5b125ca86dffba2bd3bb44ab8a00f1a1fde1d443605568168", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f12c6354ec809ed7f398cc8c6056e19ea5954233f9988bb035769d6c91e257c6a83efd8302d048b58b54cf52a2c6dc46e965102324620a6aefbaed2b07ebe47e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0ddae58243b67bf29f5c6faa925b3171793b077bd12db4ca3cf1e6b3d5aae3226369b4f6dc522953ab861e3c8f2555add88d308d9d51fb597d522529ac141dfc"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-29 10:13:14.743175) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-29 10:13:14.743529) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1477759944.458452-1428239084 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004365 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-29 10:13:14.828079) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-29 10:13:14.828825) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-29 10:13:14.829503) ========= ========= Total master_lag: 0.18 =========