builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-023 starttime: 1476917499.12 results: success (0) buildid: 20161019153020 builduid: 731323c3f2f641fc8070440e9478e638 revision: 557c6a8209fe88525f3a061a9e250aa43962709a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-19 15:51:39.122401) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-19 15:51:39.122973) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-19 15:51:39.123289) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-19 15:51:39.135257) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 15:51:39.135601) ========= 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=6d15e502d8e29d5d2676d664000001c3-1476917498.461722-1957287578 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-19 15:51:39-- 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% 46.6M=0s 2016-10-19 15:51:39 (46.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.114831 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 15:51:39.262591) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 15:51:39.262961) ========= 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=6d15e502d8e29d5d2676d664000001c3-1476917498.461722-1957287578 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015592 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 15:51:39.312865) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-19 15:51:39.313258) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 557c6a8209fe88525f3a061a9e250aa43962709a --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 557c6a8209fe88525f3a061a9e250aa43962709a --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=6d15e502d8e29d5d2676d664000001c3-1476917498.461722-1957287578 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-19 15:51:39,517 truncating revision to first 12 chars 2016-10-19 15:51:39,517 Setting DEBUG logging. 2016-10-19 15:51:39,517 attempt 1/10 2016-10-19 15:51:39,517 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/557c6a8209fe?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-19 15:51:40,496 unpacking tar archive at: fx-team-557c6a8209fe/testing/mozharness/ program finished with exit code 0 elapsedTime=1.300309 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-19 15:51:40.627182) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-19 15:51:40.627500) ========= script_repo_revision: 557c6a8209fe88525f3a061a9e250aa43962709a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-19 15:51:40.628009) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-19 15:51:40.628299) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-19 15:51:40.639229) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-10-19 15:51:40.639660) ========= /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=6d15e502d8e29d5d2676d664000001c3-1476917498.461722-1957287578 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:51:40 INFO - MultiFileLogger online at 20161019 15:51:40 in /builds/slave/test 15:51:40 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 15:51:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:51:40 INFO - {'append_to_log': False, 15:51:40 INFO - 'base_work_dir': '/builds/slave/test', 15:51:40 INFO - 'blob_upload_branch': 'Fx-Team', 15:51:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:51:40 INFO - 'branch': 'Fx-Team', 15:51:40 INFO - 'buildbot_json_path': 'buildprops.json', 15:51:40 INFO - 'config_files': ('talos/linux_config.py',), 15:51:40 INFO - 'default_actions': ('clobber', 15:51:40 INFO - 'read-buildbot-config', 15:51:40 INFO - 'download-and-extract', 15:51:40 INFO - 'populate-webroot', 15:51:40 INFO - 'create-virtualenv', 15:51:40 INFO - 'install', 15:51:40 INFO - 'run-tests'), 15:51:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:51:40 INFO - 'download_minidump_stackwalk': True, 15:51:40 INFO - 'download_symbols': 'ondemand', 15:51:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:51:40 INFO - 'tooltool.py': '/tools/tooltool.py', 15:51:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:51:40 INFO - '/tools/misc-python/virtualenv.py')}, 15:51:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:51:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:51:40 INFO - 'installer_path': 'installer.exe', 15:51:40 INFO - 'log_level': 'info', 15:51:40 INFO - 'log_name': 'talos', 15:51:40 INFO - 'log_to_console': True, 15:51:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:51:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:51:40 INFO - 'opt_config_files': (), 15:51:40 INFO - 'pip_index': False, 15:51:40 INFO - 'sps_profile': False, 15:51:40 INFO - 'sps_profile_interval': 0, 15:51:40 INFO - 'suite': 'dromaeojs', 15:51:40 INFO - 'system_bits': '32', 15:51:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:51:40 INFO - 'title': 'talos-linux64-ix-023', 15:51:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:51:40 INFO - 'use_talos_json': True, 15:51:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:51:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:51:40 INFO - 'work_dir': 'build'} 15:51:40 INFO - [mozharness: 2016-10-19 22:51:40.939516Z] Running clobber step. 15:51:40 INFO - Running pre-action listener: _resource_record_pre_action 15:51:40 INFO - Running main action method: clobber 15:51:40 INFO - rmtree: /builds/slave/test/build 15:51:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:51:41 INFO - Running post-action listener: _resource_record_post_action 15:51:41 INFO - [mozharness: 2016-10-19 22:51:41.387948Z] Finished clobber step (success) 15:51:41 INFO - [mozharness: 2016-10-19 22:51:41.388047Z] Running read-buildbot-config step. 15:51:41 INFO - Running pre-action listener: _resource_record_pre_action 15:51:41 INFO - Running main action method: read_buildbot_config 15:51:41 INFO - Using buildbot properties: 15:51:41 INFO - { 15:51:41 INFO - "project": "", 15:51:41 INFO - "product": "firefox", 15:51:41 INFO - "script_repo_revision": "production", 15:51:41 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 15:51:41 INFO - "repository": "", 15:51:41 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 15:51:41 INFO - "buildid": "20161019153020", 15:51:41 INFO - "stage_platform": "linux64-pgo", 15:51:41 INFO - "basedir": "/builds/slave/test", 15:51:41 INFO - "buildnumber": 1152, 15:51:41 INFO - "platform": "ubuntu64_hw", 15:51:41 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 15:51:41 INFO - "slavebuilddir": "test", 15:51:41 INFO - "branch": "fx-team", 15:51:41 INFO - "revision": "557c6a8209fe88525f3a061a9e250aa43962709a", 15:51:41 INFO - "slavename": "talos-linux64-ix-023", 15:51:41 INFO - "builduid": "731323c3f2f641fc8070440e9478e638", 15:51:41 INFO - "repo_path": "integration/fx-team" 15:51:41 INFO - } 15:51:41 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476905443/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 15:51:41 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476905443/firefox-52.0a1.en-US.linux-x86_64.test_packages.json. 15:51:41 INFO - Running post-action listener: _resource_record_post_action 15:51:41 INFO - [mozharness: 2016-10-19 22:51:41.390394Z] Finished read-buildbot-config step (success) 15:51:41 INFO - [mozharness: 2016-10-19 22:51:41.390483Z] Running download-and-extract step. 15:51:41 INFO - Running pre-action listener: _resource_record_pre_action 15:51:41 INFO - Running main action method: download_and_extract 15:51:41 INFO - mkdir: /builds/slave/test/build/tests 15:51:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:51:41 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476905443/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 15:51:41 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476905443/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 15:51:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476905443/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 15:51:41 INFO - Downloaded 1361 bytes. 15:51:41 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 15:51:41 INFO - Using the following test package requirements: 15:51:41 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 15:51:41 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:51:41 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:51:41 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:51:41 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:51:41 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:51:41 INFO - u'jsshell-linux-x86_64.zip'], 15:51:41 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:51:41 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:51:41 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 15:51:41 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:51:41 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:51:41 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:51:41 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:51:41 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:51:41 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:51:41 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:51:41 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:51:41 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:51:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476905443/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 15:51:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476905443/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:51:41 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476905443/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 15:51:41 INFO - Http code: 200 15:51:41 INFO - via: 1.1 bfd7406fdd888e34dfca79886cb7c964.cloudfront.net (CloudFront) 15:51:41 INFO - x-amz-cf-id: zQVOWd-E9BFV0ezsTj0vSjIhGKzTwCQWBORhuy8EdPDGH_sq10a2XQ== 15:51:41 INFO - x-amz-replication-status: COMPLETED 15:51:41 INFO - x-amz-version-id: HbtwXMLQSBSZz6T.jy3gaM39O59a0Elt 15:51:41 INFO - Expected file size: 22111251 15:51:41 INFO - Obtained file size: 22111251 15:51:45 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 15:51:45 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/1476905443/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 15:51:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476905443/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:51:45 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476905443/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 15:51:45 INFO - Http code: 200 15:51:45 INFO - via: 1.1 5ed093c37d643652e278a198e0556a40.cloudfront.net (CloudFront) 15:51:45 INFO - x-amz-cf-id: -UV0SrB0qygCrouW_z6NEflquuZMKZJBoYfTUhZnvad2TR2EVUT0Hg== 15:51:45 INFO - x-amz-replication-status: COMPLETED 15:51:45 INFO - x-amz-version-id: HbtwXMLQSBSZz6T.jy3gaM39O59a0Elt 15:51:46 INFO - Expected file size: 22111251 15:51:46 INFO - Obtained file size: 22111251 15:51:50 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/1476905443/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 15:51:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476905443/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:51:50 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476905443/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 15:51:50 INFO - Http code: 200 15:51:50 INFO - via: 1.1 ccaa055c9a26ce13da709353563e04a5.cloudfront.net (CloudFront) 15:51:50 INFO - x-amz-cf-id: QGzei0vzoos9ICHOcnOC70cgqIbl-xYeKdIllRUSh0rsxNpsrTvWow== 15:51:50 INFO - x-amz-replication-status: COMPLETED 15:51:50 INFO - x-amz-version-id: IcgVivRFuSvl0HFgYtcVoXKDHBQjla0B 15:51:50 INFO - Expected file size: 14409028 15:51:50 INFO - Obtained file size: 14409028 15:51: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')]} 15:51:51 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476905443/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 15:51:51 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476905443/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 15:51:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476905443/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 15:51:51 INFO - Downloaded 59482601 bytes. 15:51:51 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476905443/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 15:51:51 INFO - mkdir: /builds/slave/test/properties 15:51:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:51:51 INFO - Writing to file /builds/slave/test/properties/build_url 15:51:51 INFO - Contents: 15:51:51 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476905443/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 15:51:51 INFO - Running post-action listener: _resource_record_post_action 15:51:51 INFO - Running post-action listener: set_extra_try_arguments 15:51:51 INFO - [mozharness: 2016-10-19 22:51:51.923520Z] Finished download-and-extract step (success) 15:51:51 INFO - [mozharness: 2016-10-19 22:51:51.923747Z] Running populate-webroot step. 15:51:51 INFO - Running pre-action listener: _resource_record_pre_action 15:51:51 INFO - Running main action method: populate_webroot 15:51:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:51:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:51:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:51:51 INFO - '--tppagecycles', 15:51:51 INFO - '7'], 15:51:51 INFO - 'tests': ['tsvgm']}}, 15:51:51 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:51:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:51:51 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:51:51 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:51:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:51:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:51:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:51 INFO - 'talos_options': ['--disable-e10s'], 15:51:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:51:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:51:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:51 INFO - 'talos_options': ['--disable-e10s'], 15:51:51 INFO - 'tests': ['damp', 'tps']}, 15:51:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:51 INFO - 'tests': ['damp', 'tps']}, 15:51:51 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:51:51 INFO - 'tests': ['dromaeo_dom']}, 15:51:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:51:51 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:51:51 INFO - 'tests': ['basic_compositor_video']}, 15:51:51 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:51:51 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:51:51 INFO - 'tests': ['a11yr', 15:51:51 INFO - 'ts_paint', 15:51:51 INFO - 'tpaint', 15:51:51 INFO - 'sessionrestore', 15:51:51 INFO - 'sessionrestore_no_auto_restore', 15:51:51 INFO - 'tabpaint']}, 15:51:51 INFO - 'other-e10s': {'tests': ['a11yr', 15:51:51 INFO - 'ts_paint', 15:51:51 INFO - 'tpaint', 15:51:51 INFO - 'sessionrestore', 15:51:51 INFO - 'sessionrestore_no_auto_restore', 15:51:51 INFO - 'tabpaint']}, 15:51:51 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:51:51 INFO - 'ts_paint', 15:51:51 INFO - 'tpaint', 15:51:51 INFO - 'sessionrestore', 15:51:51 INFO - 'sessionrestore_no_auto_restore', 15:51:51 INFO - 'tabpaint']}, 15:51:51 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:51:51 INFO - 'ts_paint', 15:51:51 INFO - 'tpaint', 15:51:51 INFO - 'sessionrestore', 15:51:51 INFO - 'sessionrestore_no_auto_restore', 15:51:51 INFO - 'tabpaint']}, 15:51:51 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:51:51 INFO - 'tests': ['a11yr', 15:51:51 INFO - 'ts_paint', 15:51:51 INFO - 'tpaint', 15:51:51 INFO - 'sessionrestore', 15:51:51 INFO - 'sessionrestore_no_auto_restore', 15:51:51 INFO - 'tabpaint']}, 15:51:51 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:51:51 INFO - 'tests': ['a11yr', 15:51:51 INFO - 'ts_paint', 15:51:51 INFO - 'tpaint', 15:51:51 INFO - 'sessionrestore', 15:51:51 INFO - 'sessionrestore_no_auto_restore', 15:51:51 INFO - 'tabpaint']}, 15:51:51 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:51:51 INFO - 'tests': ['tsvgx', 15:51:51 INFO - 'tsvgr_opacity', 15:51:51 INFO - 'tart', 15:51:51 INFO - 'tscrollx', 15:51:51 INFO - 'cart']}, 15:51:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:51:51 INFO - 'tsvgr_opacity', 15:51:51 INFO - 'tart', 15:51:51 INFO - 'tscrollx', 15:51:51 INFO - 'cart']}, 15:51:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:51 INFO - 'talos_options': ['--disable-e10s'], 15:51:51 INFO - 'tests': ['tp5o']}, 15:51:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:51 INFO - 'tests': ['tp5o']}, 15:51:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:51 INFO - 'talos_options': ['--disable-e10s', 15:51:51 INFO - '--xperf_path', 15:51:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:51:51 INFO - 'tests': ['tp5n']}, 15:51:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:51 INFO - 'talos_options': ['--xperf_path', 15:51:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:51:51 INFO - 'tests': ['tp5n']}}, 15:51:51 INFO - 'talos.zip': {'path': '', 15:51:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:51:51 INFO - Running post-action listener: _resource_record_post_action 15:51:51 INFO - [mozharness: 2016-10-19 22:51:51.939507Z] Finished populate-webroot step (success) 15:51:51 INFO - [mozharness: 2016-10-19 22:51:51.939596Z] Running create-virtualenv step. 15:51:51 INFO - Running pre-action listener: _resource_record_pre_action 15:51:51 INFO - Running main action method: create_virtualenv 15:51:51 INFO - Creating virtualenv /builds/slave/test/build/venv 15:51:51 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 15:51:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:51:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:51:52 INFO - Using real prefix '/usr' 15:51:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:51:52 INFO - Installing distribute.............................................................................................................................................................................................done. 15:51:54 INFO - Installing pip.................done. 15:51:54 INFO - Return code: 0 15:51:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:51:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:51:54 INFO - Reading from file tmpfile_stdout 15:51:54 INFO - Output received: 15:51:54 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) 15:51:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:51:54 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')]} 15:51:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:54 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')]} 15:51:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:54 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 0x7f464570ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17907b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181f790>, '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 0x1820690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1820b20>, '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': '6d15e502d8e29d5d2676d664000001c3-1476917498.461722-1957287578', '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 15:51:54 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 15:51:54 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 15:51:54 INFO - Using env: {'DISPLAY': ':0', 15:51:54 INFO - 'HOME': '/home/cltbld', 15:51:54 INFO - 'LANG': 'en_US.UTF-8', 15:51:54 INFO - 'LANGUAGE': 'en_US:en', 15:51:54 INFO - 'LOGNAME': 'cltbld', 15:51:54 INFO - 'MAIL': '/var/mail/cltbld', 15:51:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:54 INFO - 'MOZ_NO_REMOTE': '1', 15:51:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:54 INFO - 'NO_EM_RESTART': '1', 15:51:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:54 INFO - 'PWD': '/builds/slave/test', 15:51:54 INFO - 'SHELL': '/bin/bash', 15:51:54 INFO - 'SHLVL': '1', 15:51:54 INFO - 'TERM': 'linux', 15:51:54 INFO - 'TMOUT': '86400', 15:51:54 INFO - 'USER': 'cltbld', 15:51:54 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1476917498.461722-1957287578', 15:51:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:54 INFO - '_': '/tools/buildbot/bin/python'} 15:51:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:54 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 15:51:54 INFO - Cleaning up... 15:51:54 INFO - Return code: 0 15:51:54 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:51:54 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')]} 15:51:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:54 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')]} 15:51:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:54 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 0x7f464570ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17907b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181f790>, '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 0x1820690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1820b20>, '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': '6d15e502d8e29d5d2676d664000001c3-1476917498.461722-1957287578', '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 15:51:54 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 15:51:54 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 15:51:54 INFO - Using env: {'DISPLAY': ':0', 15:51:54 INFO - 'HOME': '/home/cltbld', 15:51:54 INFO - 'LANG': 'en_US.UTF-8', 15:51:54 INFO - 'LANGUAGE': 'en_US:en', 15:51:54 INFO - 'LOGNAME': 'cltbld', 15:51:54 INFO - 'MAIL': '/var/mail/cltbld', 15:51:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:54 INFO - 'MOZ_NO_REMOTE': '1', 15:51:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:54 INFO - 'NO_EM_RESTART': '1', 15:51:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:54 INFO - 'PWD': '/builds/slave/test', 15:51:54 INFO - 'SHELL': '/bin/bash', 15:51:54 INFO - 'SHLVL': '1', 15:51:54 INFO - 'TERM': 'linux', 15:51:54 INFO - 'TMOUT': '86400', 15:51:54 INFO - 'USER': 'cltbld', 15:51:54 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1476917498.461722-1957287578', 15:51:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:54 INFO - '_': '/tools/buildbot/bin/python'} 15:51:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:55 INFO - Downloading/unpacking psutil>=3.1.1 15:51:55 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 15:51:55 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 15:51:55 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 15:51:55 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 15:51:55 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 15:51:55 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 15:51:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:51:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:51:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:51:57 INFO - Installing collected packages: psutil 15:51:57 INFO - Running setup.py install for psutil 15:51:57 INFO - building 'psutil._psutil_linux' extension 15:51:57 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 15:51:57 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 15:51:57 INFO - building 'psutil._psutil_posix' extension 15:51:57 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 15:51:57 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 15:51:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:51:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:51:57 INFO - Successfully installed psutil 15:51:57 INFO - Cleaning up... 15:51:57 INFO - Return code: 0 15:51:57 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:51:57 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')]} 15:51:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:57 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')]} 15:51:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:57 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 0x7f464570ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17907b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181f790>, '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 0x1820690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1820b20>, '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': '6d15e502d8e29d5d2676d664000001c3-1476917498.461722-1957287578', '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 15:51:57 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 15:51:57 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 15:51:57 INFO - Using env: {'DISPLAY': ':0', 15:51:57 INFO - 'HOME': '/home/cltbld', 15:51:57 INFO - 'LANG': 'en_US.UTF-8', 15:51:57 INFO - 'LANGUAGE': 'en_US:en', 15:51:57 INFO - 'LOGNAME': 'cltbld', 15:51:57 INFO - 'MAIL': '/var/mail/cltbld', 15:51:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:57 INFO - 'MOZ_NO_REMOTE': '1', 15:51:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:57 INFO - 'NO_EM_RESTART': '1', 15:51:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:57 INFO - 'PWD': '/builds/slave/test', 15:51:57 INFO - 'SHELL': '/bin/bash', 15:51:57 INFO - 'SHLVL': '1', 15:51:57 INFO - 'TERM': 'linux', 15:51:57 INFO - 'TMOUT': '86400', 15:51:57 INFO - 'USER': 'cltbld', 15:51:57 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1476917498.461722-1957287578', 15:51:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:57 INFO - '_': '/tools/buildbot/bin/python'} 15:51:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:57 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:51:57 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 15:51:57 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 15:51:57 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 15:51:57 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 15:51:57 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 15:51:57 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 15:51:59 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:51:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:51:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:51:59 INFO - Installing collected packages: mozsystemmonitor 15:51:59 INFO - Running setup.py install for mozsystemmonitor 15:52:00 INFO - Successfully installed mozsystemmonitor 15:52:00 INFO - Cleaning up... 15:52:00 INFO - Return code: 0 15:52:00 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:52:00 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')]} 15:52:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:52:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:00 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')]} 15:52:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:52:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:00 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 0x7f464570ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17907b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181f790>, '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 0x1820690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1820b20>, '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': '6d15e502d8e29d5d2676d664000001c3-1476917498.461722-1957287578', '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 15:52:00 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 15:52:00 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 15:52:00 INFO - Using env: {'DISPLAY': ':0', 15:52:00 INFO - 'HOME': '/home/cltbld', 15:52:00 INFO - 'LANG': 'en_US.UTF-8', 15:52:00 INFO - 'LANGUAGE': 'en_US:en', 15:52:00 INFO - 'LOGNAME': 'cltbld', 15:52:00 INFO - 'MAIL': '/var/mail/cltbld', 15:52:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:52:00 INFO - 'MOZ_NO_REMOTE': '1', 15:52:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:52:00 INFO - 'NO_EM_RESTART': '1', 15:52:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:52:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:52:00 INFO - 'PWD': '/builds/slave/test', 15:52:00 INFO - 'SHELL': '/bin/bash', 15:52:00 INFO - 'SHLVL': '1', 15:52:00 INFO - 'TERM': 'linux', 15:52:00 INFO - 'TMOUT': '86400', 15:52:00 INFO - 'USER': 'cltbld', 15:52:00 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1476917498.461722-1957287578', 15:52:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:52:00 INFO - '_': '/tools/buildbot/bin/python'} 15:52:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:52:00 INFO - Downloading/unpacking jsonschema==2.5.1 15:52:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:52:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:52:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:52:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:52:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:52:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:52:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:52:02 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:52:02 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 15:52:02 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 15:52:02 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 15:52:02 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 15:52:02 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 15:52:02 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 15:52:02 INFO - Downloading functools32-3.2.3-2.tar.gz 15:52:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:52:02 INFO - warning: no files found matching '*.txt' 15:52:02 INFO - no previously-included directories found matching 'build' 15:52:02 INFO - no previously-included directories found matching 'dist' 15:52:02 INFO - no previously-included directories found matching '.git*' 15:52:02 INFO - Installing collected packages: jsonschema, functools32 15:52:02 INFO - Running setup.py install for functools32 15:52:02 INFO - warning: no files found matching '*.txt' 15:52:02 INFO - no previously-included directories found matching 'build' 15:52:02 INFO - no previously-included directories found matching 'dist' 15:52:02 INFO - no previously-included directories found matching '.git*' 15:52:02 INFO - Successfully installed jsonschema functools32 15:52:02 INFO - Cleaning up... 15:52:02 INFO - Return code: 0 15:52:02 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:52: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')]} 15:52:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:52:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52: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')]} 15:52:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:52:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f464570ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17907b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181f790>, '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 0x1820690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1820b20>, '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': '6d15e502d8e29d5d2676d664000001c3-1476917498.461722-1957287578', '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 15:52:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 15:52:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 15:52:02 INFO - Using env: {'DISPLAY': ':0', 15:52:02 INFO - 'HOME': '/home/cltbld', 15:52:02 INFO - 'LANG': 'en_US.UTF-8', 15:52:02 INFO - 'LANGUAGE': 'en_US:en', 15:52:02 INFO - 'LOGNAME': 'cltbld', 15:52:02 INFO - 'MAIL': '/var/mail/cltbld', 15:52:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:52:02 INFO - 'MOZ_NO_REMOTE': '1', 15:52:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:52:02 INFO - 'NO_EM_RESTART': '1', 15:52:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:52:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:52:02 INFO - 'PWD': '/builds/slave/test', 15:52:02 INFO - 'SHELL': '/bin/bash', 15:52:02 INFO - 'SHLVL': '1', 15:52:02 INFO - 'TERM': 'linux', 15:52:02 INFO - 'TMOUT': '86400', 15:52:02 INFO - 'USER': 'cltbld', 15:52:02 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1476917498.461722-1957287578', 15:52:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:52:02 INFO - '_': '/tools/buildbot/bin/python'} 15:52:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:52:02 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:52:02 INFO - Cleaning up... 15:52:02 INFO - Return code: 0 15:52:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:52: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')]} 15:52:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:52:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52: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')]} 15:52:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:52:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f464570ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17907b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181f790>, '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 0x1820690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1820b20>, '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': '6d15e502d8e29d5d2676d664000001c3-1476917498.461722-1957287578', '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 15:52:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:52:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:52:02 INFO - Using env: {'DISPLAY': ':0', 15:52:02 INFO - 'HOME': '/home/cltbld', 15:52:02 INFO - 'LANG': 'en_US.UTF-8', 15:52:02 INFO - 'LANGUAGE': 'en_US:en', 15:52:02 INFO - 'LOGNAME': 'cltbld', 15:52:02 INFO - 'MAIL': '/var/mail/cltbld', 15:52:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:52:02 INFO - 'MOZ_NO_REMOTE': '1', 15:52:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:52:02 INFO - 'NO_EM_RESTART': '1', 15:52:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:52:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:52:02 INFO - 'PWD': '/builds/slave/test', 15:52:02 INFO - 'SHELL': '/bin/bash', 15:52:02 INFO - 'SHLVL': '1', 15:52:02 INFO - 'TERM': 'linux', 15:52:02 INFO - 'TMOUT': '86400', 15:52:02 INFO - 'USER': 'cltbld', 15:52:02 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1476917498.461722-1957287578', 15:52:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:52:02 INFO - '_': '/tools/buildbot/bin/python'} 15:52:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:52:03 INFO - Downloading/unpacking blobuploader==1.2.4 15:52:03 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 15:52:03 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 15:52:03 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 15:52:03 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 15:52:03 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 15:52:03 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 15:52:05 INFO - Downloading blobuploader-1.2.4.tar.gz 15:52:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:52:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:52:05 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 15:52:05 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 15:52:05 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 15:52:05 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 15:52:05 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 15:52:05 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 15:52:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:52:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:52:05 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 15:52:05 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 15:52:05 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 15:52:05 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 15:52:05 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 15:52:05 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 15:52:05 INFO - Downloading docopt-0.6.1.tar.gz 15:52:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:52:05 INFO - Installing collected packages: blobuploader, requests, docopt 15:52:05 INFO - Running setup.py install for blobuploader 15:52:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:52:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:52:05 INFO - Running setup.py install for requests 15:52:06 INFO - Running setup.py install for docopt 15:52:06 INFO - Successfully installed blobuploader requests docopt 15:52:06 INFO - Cleaning up... 15:52:06 INFO - Return code: 0 15:52:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:52:06 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')]} 15:52:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:52:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:06 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')]} 15:52:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:52:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:06 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 0x7f464570ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17907b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181f790>, '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 0x1820690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1820b20>, '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': '6d15e502d8e29d5d2676d664000001c3-1476917498.461722-1957287578', '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 15:52:06 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 15:52:06 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 15:52:06 INFO - Using env: {'DISPLAY': ':0', 15:52:06 INFO - 'HOME': '/home/cltbld', 15:52:06 INFO - 'LANG': 'en_US.UTF-8', 15:52:06 INFO - 'LANGUAGE': 'en_US:en', 15:52:06 INFO - 'LOGNAME': 'cltbld', 15:52:06 INFO - 'MAIL': '/var/mail/cltbld', 15:52:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:52:06 INFO - 'MOZ_NO_REMOTE': '1', 15:52:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:52:06 INFO - 'NO_EM_RESTART': '1', 15:52:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:52:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:52:06 INFO - 'PWD': '/builds/slave/test', 15:52:06 INFO - 'SHELL': '/bin/bash', 15:52:06 INFO - 'SHLVL': '1', 15:52:06 INFO - 'TERM': 'linux', 15:52:06 INFO - 'TMOUT': '86400', 15:52:06 INFO - 'USER': 'cltbld', 15:52:06 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1476917498.461722-1957287578', 15:52:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:52:06 INFO - '_': '/tools/buildbot/bin/python'} 15:52:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:52:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:52:06 INFO - Running setup.py (path:/tmp/pip-XU0yXw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:52:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:52:06 INFO - Running setup.py (path:/tmp/pip-iqMeWk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:52:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:52:06 INFO - Running setup.py (path:/tmp/pip-jR7IfL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:52:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:52:06 INFO - Running setup.py (path:/tmp/pip-kEngnv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:52:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:52:06 INFO - Running setup.py (path:/tmp/pip-W96x51-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:52:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:52:07 INFO - Running setup.py (path:/tmp/pip-H4KbpP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:52:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:52:07 INFO - Running setup.py (path:/tmp/pip-G8jeOb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:52:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:52:07 INFO - Running setup.py (path:/tmp/pip-odz0ok-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:52:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:52:07 INFO - Running setup.py (path:/tmp/pip-Q1AdIa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:52:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:52:07 INFO - Running setup.py (path:/tmp/pip-FDrhPM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:52:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:52:07 INFO - Running setup.py (path:/tmp/pip-fCODFq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:52:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:52:07 INFO - Running setup.py (path:/tmp/pip-dgQ75M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:52:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:52:07 INFO - Running setup.py (path:/tmp/pip-YyCo3K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:52:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:52:07 INFO - Running setup.py (path:/tmp/pip-z8VY8c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:52:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:52:07 INFO - Running setup.py (path:/tmp/pip-xsfEtK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:52:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:52:07 INFO - Running setup.py (path:/tmp/pip-ekHAEy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:52:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:52:07 INFO - Running setup.py (path:/tmp/pip-59HnJh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:52:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:52:07 INFO - Running setup.py install for manifestparser 15:52:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:52:07 INFO - Running setup.py install for mozcrash 15:52:08 INFO - Running setup.py install for mozdebug 15:52:08 INFO - Running setup.py install for mozdevice 15:52:08 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:52:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:52:08 INFO - Running setup.py install for mozfile 15:52:08 INFO - Running setup.py install for mozhttpd 15:52:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:52:08 INFO - Running setup.py install for mozinfo 15:52:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:52:08 INFO - Running setup.py install for mozInstall 15:52:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:52:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:52:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:52:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:52:08 INFO - Running setup.py install for mozleak 15:52:08 INFO - Running setup.py install for mozlog 15:52:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:52:08 INFO - Running setup.py install for moznetwork 15:52:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:52:09 INFO - Running setup.py install for mozprocess 15:52:09 INFO - Running setup.py install for mozprofile 15:52:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:52:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:52:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:52:09 INFO - Running setup.py install for mozrunner 15:52:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:52:09 INFO - Running setup.py install for mozscreenshot 15:52:09 INFO - Running setup.py install for moztest 15:52:09 INFO - Running setup.py install for mozversion 15:52:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:52:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:52:09 INFO - Cleaning up... 15:52:09 INFO - Return code: 0 15:52:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:52: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')]} 15:52:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:52:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52: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')]} 15:52:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:52:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:09 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 0x7f464570ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17907b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181f790>, '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 0x1820690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1820b20>, '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': '6d15e502d8e29d5d2676d664000001c3-1476917498.461722-1957287578', '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 15:52:09 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 15:52:09 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 15:52:09 INFO - Using env: {'DISPLAY': ':0', 15:52:09 INFO - 'HOME': '/home/cltbld', 15:52:09 INFO - 'LANG': 'en_US.UTF-8', 15:52:09 INFO - 'LANGUAGE': 'en_US:en', 15:52:09 INFO - 'LOGNAME': 'cltbld', 15:52:09 INFO - 'MAIL': '/var/mail/cltbld', 15:52:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:52:09 INFO - 'MOZ_NO_REMOTE': '1', 15:52:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:52:09 INFO - 'NO_EM_RESTART': '1', 15:52:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:52:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:52:09 INFO - 'PWD': '/builds/slave/test', 15:52:09 INFO - 'SHELL': '/bin/bash', 15:52:09 INFO - 'SHLVL': '1', 15:52:09 INFO - 'TERM': 'linux', 15:52:09 INFO - 'TMOUT': '86400', 15:52:09 INFO - 'USER': 'cltbld', 15:52:09 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1476917498.461722-1957287578', 15:52:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:52:09 INFO - '_': '/tools/buildbot/bin/python'} 15:52:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:52:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:52:09 INFO - Running setup.py (path:/tmp/pip-m_BQTM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:52:09 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)) 15:52:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:52:09 INFO - Running setup.py (path:/tmp/pip-fnAGzX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:52:10 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)) 15:52:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:52:10 INFO - Running setup.py (path:/tmp/pip-aKYpAA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:52:10 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)) 15:52:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:52:10 INFO - Running setup.py (path:/tmp/pip-Xm_5FU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:52:10 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)) 15:52:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:52:10 INFO - Running setup.py (path:/tmp/pip-_6BF8H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:52:10 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)) 15:52:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:52:10 INFO - Running setup.py (path:/tmp/pip-enBjJu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:52:10 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)) 15:52:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:52:10 INFO - Running setup.py (path:/tmp/pip-63pq3s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:52:10 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)) 15:52:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:52:10 INFO - Running setup.py (path:/tmp/pip-h0Kht7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:52:10 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)) 15:52:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:52:10 INFO - Running setup.py (path:/tmp/pip-bo9nXa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:52:10 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)) 15:52:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:52:10 INFO - Running setup.py (path:/tmp/pip-h4FnYL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:52:10 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)) 15:52:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:52:10 INFO - Running setup.py (path:/tmp/pip-T0VKaK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:52:10 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)) 15:52:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:52:10 INFO - Running setup.py (path:/tmp/pip-fAAY5a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:52:10 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)) 15:52:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:52:10 INFO - Running setup.py (path:/tmp/pip-TSbOio-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:52:10 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)) 15:52:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:52:10 INFO - Running setup.py (path:/tmp/pip-2tgFP3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:52:10 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)) 15:52:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:52:10 INFO - Running setup.py (path:/tmp/pip-mh0DZO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:52:11 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)) 15:52:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:52:11 INFO - Running setup.py (path:/tmp/pip-Ux99dE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:52:11 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)) 15:52:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:52:11 INFO - Running setup.py (path:/tmp/pip-wjWxR8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:52:11 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)) 15:52:11 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)) 15:52:11 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)) 15:52:11 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)) 15:52:11 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)) 15:52:11 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)) 15:52:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:52:11 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 15:52:11 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 15:52:11 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 15:52:11 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 15:52:11 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 15:52:11 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 15:52:13 INFO - Downloading blessings-1.6.tar.gz 15:52:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:52:13 INFO - Installing collected packages: blessings 15:52:13 INFO - Running setup.py install for blessings 15:52:13 INFO - Successfully installed blessings 15:52:13 INFO - Cleaning up... 15:52:13 INFO - Return code: 0 15:52:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:52:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:52:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:52:13 INFO - Reading from file tmpfile_stdout 15:52:13 INFO - Current package versions: 15:52:13 INFO - argparse == 1.2.1 15:52:13 INFO - blessings == 1.6 15:52:13 INFO - blobuploader == 1.2.4 15:52:13 INFO - docopt == 0.6.1 15:52:13 INFO - functools32 == 3.2.3-2 15:52:13 INFO - jsonschema == 2.5.1 15:52:13 INFO - manifestparser == 1.1 15:52:13 INFO - mozInstall == 1.12 15:52:13 INFO - mozcrash == 0.17 15:52:13 INFO - mozdebug == 0.1 15:52:13 INFO - mozdevice == 0.48 15:52:13 INFO - mozfile == 1.2 15:52:13 INFO - mozhttpd == 0.7 15:52:13 INFO - mozinfo == 0.9 15:52:13 INFO - mozleak == 0.1 15:52:13 INFO - mozlog == 3.4 15:52:13 INFO - moznetwork == 0.27 15:52:13 INFO - mozprocess == 0.23 15:52:13 INFO - mozprofile == 0.28 15:52:13 INFO - mozrunner == 6.12 15:52:13 INFO - mozscreenshot == 0.1 15:52:13 INFO - mozsystemmonitor == 0.3 15:52:13 INFO - moztest == 0.7 15:52:13 INFO - mozversion == 1.4 15:52:13 INFO - psutil == 3.1.1 15:52:13 INFO - requests == 1.2.3 15:52:13 INFO - wsgiref == 0.1.2 15:52:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:52:13 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')]} 15:52:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:52:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:13 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')]} 15:52:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:52:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:13 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 0x7f464570ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17907b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181f790>, '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 0x1820690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1820b20>, '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': '6d15e502d8e29d5d2676d664000001c3-1476917498.461722-1957287578', '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 15:52:13 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 15:52:13 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 15:52:13 INFO - Using env: {'DISPLAY': ':0', 15:52:13 INFO - 'HOME': '/home/cltbld', 15:52:13 INFO - 'LANG': 'en_US.UTF-8', 15:52:13 INFO - 'LANGUAGE': 'en_US:en', 15:52:13 INFO - 'LOGNAME': 'cltbld', 15:52:13 INFO - 'MAIL': '/var/mail/cltbld', 15:52:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:52:13 INFO - 'MOZ_NO_REMOTE': '1', 15:52:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:52:13 INFO - 'NO_EM_RESTART': '1', 15:52:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:52:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:52:13 INFO - 'PWD': '/builds/slave/test', 15:52:13 INFO - 'SHELL': '/bin/bash', 15:52:13 INFO - 'SHLVL': '1', 15:52:13 INFO - 'TERM': 'linux', 15:52:13 INFO - 'TMOUT': '86400', 15:52:13 INFO - 'USER': 'cltbld', 15:52:13 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1476917498.461722-1957287578', 15:52:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:52:13 INFO - '_': '/tools/buildbot/bin/python'} 15:52:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:52:13 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)) 15:52:13 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)) 15:52:13 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)) 15:52:13 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)) 15:52:13 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)) 15:52:13 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)) 15:52:13 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)) 15:52:13 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)) 15:52:13 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)) 15:52:13 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)) 15:52:13 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)) 15:52:13 INFO - Cleaning up... 15:52:13 INFO - Return code: 0 15:52:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:52:13 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')]} 15:52:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:52:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:13 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')]} 15:52:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:52:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:13 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 0x7f464570ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17907b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181f790>, '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 0x1820690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1820b20>, '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': '6d15e502d8e29d5d2676d664000001c3-1476917498.461722-1957287578', '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 15:52:13 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 15:52:13 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 15:52:13 INFO - Using env: {'DISPLAY': ':0', 15:52:13 INFO - 'HOME': '/home/cltbld', 15:52:13 INFO - 'LANG': 'en_US.UTF-8', 15:52:13 INFO - 'LANGUAGE': 'en_US:en', 15:52:13 INFO - 'LOGNAME': 'cltbld', 15:52:13 INFO - 'MAIL': '/var/mail/cltbld', 15:52:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:52:13 INFO - 'MOZ_NO_REMOTE': '1', 15:52:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:52:13 INFO - 'NO_EM_RESTART': '1', 15:52:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:52:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:52:13 INFO - 'PWD': '/builds/slave/test', 15:52:13 INFO - 'SHELL': '/bin/bash', 15:52:13 INFO - 'SHLVL': '1', 15:52:13 INFO - 'TERM': 'linux', 15:52:13 INFO - 'TMOUT': '86400', 15:52:13 INFO - 'USER': 'cltbld', 15:52:13 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1476917498.461722-1957287578', 15:52:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:52:13 INFO - '_': '/tools/buildbot/bin/python'} 15:52:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:52:14 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:52:14 INFO - Cleaning up... 15:52:14 INFO - Return code: 0 15:52:14 INFO - Running post-action listener: _resource_record_post_action 15:52:14 INFO - Running post-action listener: _start_resource_monitoring 15:52:14 INFO - Starting resource monitoring. 15:52:14 INFO - [mozharness: 2016-10-19 22:52:14.095467Z] Finished create-virtualenv step (success) 15:52:14 INFO - [mozharness: 2016-10-19 22:52:14.095984Z] Running install step. 15:52:14 INFO - Running pre-action listener: _resource_record_pre_action 15:52:14 INFO - Running main action method: install 15:52:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:52:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:52:14 INFO - Reading from file tmpfile_stdout 15:52:14 INFO - Detecting whether we're running mozinstall >=1.0... 15:52:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:52:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:52:14 INFO - Reading from file tmpfile_stdout 15:52:14 INFO - Output received: 15:52:14 INFO - Usage: mozinstall [options] installer 15:52:14 INFO - Options: 15:52:14 INFO - -h, --help show this help message and exit 15:52:14 INFO - -d DEST, --destination=DEST 15:52:14 INFO - Directory to install application into. [default: 15:52:14 INFO - "/builds/slave/test"] 15:52:14 INFO - --app=APP Application being installed. [default: firefox] 15:52:14 INFO - mkdir: /builds/slave/test/build/application 15:52:14 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'] 15:52:14 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 15:52:31 INFO - Reading from file tmpfile_stdout 15:52:31 INFO - Output received: 15:52:31 INFO - /builds/slave/test/build/application/firefox/firefox 15:52:31 INFO - Running post-action listener: _resource_record_post_action 15:52:31 INFO - [mozharness: 2016-10-19 22:52:31.468360Z] Finished install step (success) 15:52:31 INFO - [mozharness: 2016-10-19 22:52:31.468636Z] Running run-tests step. 15:52:31 INFO - Running pre-action listener: _resource_record_pre_action 15:52:31 INFO - Running main action method: run_tests 15:52:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:52:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:52:31 INFO - Python 2.7.3 15:52:31 INFO - Return code: 0 15:52:31 INFO - grabbing minidump binary from tooltool 15:52:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:52:31 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 0x181f790>, '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 0x1820690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1820b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:52:31 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 15:52:31 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 15:52:31 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 15:52:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:52:31 INFO - Return code: 0 15:52:31 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:52:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:52:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:52:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:52:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:52:31 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/1476905443/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 15:52:31 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/1476905443/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-023 --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 15:52:31 INFO - Using env: {'DISPLAY': ':0', 15:52:31 INFO - 'HOME': '/home/cltbld', 15:52:31 INFO - 'LANG': 'en_US.UTF-8', 15:52:31 INFO - 'LANGUAGE': 'en_US:en', 15:52:31 INFO - 'LOGNAME': 'cltbld', 15:52:31 INFO - 'MAIL': '/var/mail/cltbld', 15:52:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:52:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:52:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:52:31 INFO - 'MOZ_NO_REMOTE': '1', 15:52:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:52:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:52:31 INFO - 'NO_EM_RESTART': '1', 15:52:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:52:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:52:31 INFO - 'PWD': '/builds/slave/test', 15:52:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:52:31 INFO - 'SHELL': '/bin/bash', 15:52:31 INFO - 'SHLVL': '1', 15:52:31 INFO - 'TERM': 'linux', 15:52:31 INFO - 'TMOUT': '86400', 15:52:31 INFO - 'USER': 'cltbld', 15:52:31 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1476917498.461722-1957287578', 15:52:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:52:31 INFO - '_': '/tools/buildbot/bin/python'} 15:52:31 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/1476905443/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 15:52:31 INFO - mozversion application_buildid: 20161019123043 15:52:31 INFO - mozversion application_changeset: 557c6a8209fe88525f3a061a9e250aa43962709a 15:52:31 INFO - mozversion application_display_name: Nightly 15:52:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:52:31 INFO - mozversion application_name: Firefox 15:52:31 INFO - mozversion application_remotingname: firefox 15:52:31 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 15:52:31 INFO - mozversion application_vendor: Mozilla 15:52:31 INFO - mozversion application_version: 52.0a1 15:52:31 INFO - mozversion platform_buildid: 20161019123043 15:52:31 INFO - mozversion platform_changeset: 557c6a8209fe88525f3a061a9e250aa43962709a 15:52:31 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 15:52:31 INFO - mozversion platform_version: 52.0a1 15:52:31 INFO - using testdate: 1476917551 15:52:31 INFO - actual date: 1476917551 15:52:31 INFO - starting webserver on 'localhost:41488' 15:52:31 INFO - SUITE-START | Running 2 tests 15:52:31 INFO - TEST-START | dromaeo_css 15:52:31 INFO - operating with platform_type : linux_ 15:52:31 INFO - Initialising browser for dromaeo_css test... 15:52:31 INFO - TEST-INFO | started process 10456 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVgZhag/profile http://localhost:41488/getInfo.html) 15:52:35 INFO - PROCESS | 10456 | __metrics Screen width/height:1600/1200 15:52:35 INFO - PROCESS | 10456 | colorDepth:24 15:52:35 INFO - PROCESS | 10456 | Browser inner width/height: 1024/697 15:52:35 INFO - PROCESS | 10456 | __metrics 15:52:36 INFO - PROCESS | 10456 | 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" 15:52:36 INFO - PROCESS | 10456 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:52:36 INFO - PROCESS | 10456 | console.error: PushService: 15:52:36 INFO - PROCESS | 10456 | stateChangeProcessEnqueue: Error transitioning state 15:52:36 INFO - PROCESS | 10456 | UnknownError 15:52:37 INFO - TEST-INFO | 10456: exit 0 15:52:37 INFO - Browser initialized. 15:52:37 INFO - Running cycle 1/1 for dromaeo_css test... 15:52:37 INFO - TEST-INFO | started process 10539 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVgZhag/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:52:49 INFO - PROCESS | 10539 | RSS: Main: 172314624 15:52:49 INFO - PROCESS | 10539 | 15:53:41 INFO - PROCESS | 10539 | 1476917621361 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] 15:55:51 INFO - PROCESS | 10539 | Cycle 1(1): loaded http://localhost:41488/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41488/tests/dromaeo/cssquery-ext.html) 15:55:54 INFO - PROCESS | 10539 | RSS: Main: 432443392 15:55:54 INFO - PROCESS | 10539 | 15:58:57 INFO - PROCESS | 10539 | Cycle 1(1): loaded http://localhost:41488/tests/dromaeo/cssquery-ext.html (next: http://localhost:41488/tests/dromaeo/cssquery-jquery.html) 15:58:57 INFO - PROCESS | 10539 | RSS: Main: 284209152 15:58:57 INFO - PROCESS | 10539 | 16:01:59 INFO - PROCESS | 10539 | Cycle 1(1): loaded http://localhost:41488/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41488/tests/dromaeo/cssquery-mootools.html) 16:02:00 INFO - PROCESS | 10539 | RSS: Main: 220536832 16:02:00 INFO - PROCESS | 10539 | 16:05:02 INFO - PROCESS | 10539 | Cycle 1(1): loaded http://localhost:41488/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41488/tests/dromaeo/cssquery-prototype.html) 16:05:02 INFO - PROCESS | 10539 | RSS: Main: 224833536 16:05:02 INFO - PROCESS | 10539 | 16:08:05 INFO - PROCESS | 10539 | Cycle 1(1): loaded http://localhost:41488/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41488/tests/dromaeo/cssquery-yui.html) 16:08:06 INFO - PROCESS | 10539 | RSS: Main: 221261824 16:08:06 INFO - PROCESS | 10539 | 16:11:08 INFO - PROCESS | 10539 | Cycle 1(1): loaded http://localhost:41488/tests/dromaeo/cssquery-yui.html (next: http://localhost:41488/tests/dromaeo/cssquery-dojo.html) 16:11:09 INFO - PROCESS | 10539 | RSS: Main: 314155008 16:11:09 INFO - PROCESS | 10539 | 16:11:09 INFO - PROCESS | 10539 | __start_tp_report 16:11:09 INFO - PROCESS | 10539 | _x_x_mozilla_page_load 16:11:09 INFO - PROCESS | 10539 | _x_x_mozilla_page_load_details 16:11:09 INFO - PROCESS | 10539 | |i|pagename|runs| 16:11:09 INFO - PROCESS | 10539 | |0;dojo.html;3067.7085676860697;3094.1491089950246;3124.7812653114283;3132.5457808617753;3135.6550779414274;5204.32343795307;5270.920936185956;5314.9468505314935;5371.7045562494095;5424.891502169954;5332.14685650296;5347.7058761768085;5413.675179489223;5423.240746295522;5463.508284254416;4848.6363522735755;4875.561199492045;4896.877578060559;4902.264660300948;4915.3364295819965;4932.457429682732;5007.098722229997;5028.145215313387;5031.195008798593;5094.770735316901;4939.185034469308;4956.925646115311;4998.375203099613;5010.749462526859;5050.671706339094;4764.571188593043;4791.808327666889;4794.712317260975;4818.686785358976;4830.951690483085;4767.332573439721;4869.586085182764;4882.170031094687;4894.070126675921;4899.779509922062;5241.240020197089;5333.866653333659;5335.733213339317;5336.30628018359;5345.465453454663;5695.487406133468;5700.629459085146;5708.115242137475;5711.343195532525;5787.739551720183;5537.861553461155;5592.5805564582815;5686.545076393879;5794.217780599607;5800.158976948361;5330.493603107738;5348.251244825728;5354.812581559627;5357;5422.105352616813;5828.213191219216;5829.47534721877;5845.444682755132;5847.298324201123;5847.356790753014;5428.212909128154;5459.317585301837;5579.358373786985;5616.522595579339;5619.353774316006;5696.743646535916;5729.512991395694;5738.713064346766;5782.855428614318;5797.913031304533;5715.771369145187;5717.971410142923;5724.570657200643;5726.656400615893;5751.338596061423;5536.778528858881;5553.222548843165;5598.776048957996;5714.914276285859;5715.485606295453;4357.172137293967;4394.934075988863;4413.293872980308;4420.646348292129;4472.195004899084;3941.1329507508303;3945.191235796655;3954.2486927483687;3986.242613903349;4003.079291762853;5208.479152084761;5446.91829622556;5447.4824891635235;5448.564114870801;5451.236826844245;5622.437756224344;5706.343770466367;5740.225069615549;5744.971275143597;5837;5443.319585051869;5449.128139497661;5450.345958485007;5453.018456677836;5453.672779633155;5003.174476211384;5011.646855349035;5012.04771093491;5012.1980483122525;5071.061853557104;5735.893483390516;5846.649201047951;5850.765969361263;5898.115282707457;5932;5756.338021127456;5760.423957604374;5767.365589785204;5770.826875193751;5771.653700777967;5915.171875937286;5918.822435326947;5925.733341999707;5927.347991720821;5928.970355148197;5634.211210430625;5679.233303503974;5687.1753595729215;5692.715364231689;5697.601167918206;5715;5754.827355179351;5764.625299355528;5793.9420605795085;5858.443447872445;5651.321841378896;5665.66006039639;5665.886682266414;5667.036603777286;5673.319201695823;5630.774769009194;5638.26702528685;5641;5645.548356131418;5652.660840349427;5413.53984911287;5449.373322067854;5499.312585926759;5529.032419326682;5548.722563871871;5660.29246344207;5664.0654292043;5669.603127781016;5676.801311954062;5680.943190568041;5427.348718153847;5436.456354364532;5471.589630777628;5471.9726401369335;5528.668279903219 16:11:09 INFO - PROCESS | 10539 | |1;ext.html;607.8875408049511;633.9936600633998;635.6885126288118;644.9097126402304;651.238051479769;31402.528962065586;41628;43199;43417.78291108548;46803.53196468034;44575.55424445755;44580.77709611456;44886.77556612212;45046.09907801842;45141.00314451265;7953.72161974331;8822.735317940473;8991.775205619879;9000.909990900105;9006.504642244674;7847.921520784805;8155.143709910463;8167.714130005451;10496.160307175407;10819.350838949687;10879;10928.672139835779;10934.671959841218;10939.617113401033;10946.288491248044;10746.78506429867;10750.408727519984;10799.784004319908;10856.565737370496;10856.837147442755;10516.579336826519;10617.41604211768;10625.309354891984;10630.521626526825;10632.30889992148;41261.79369103165;41344.37983430251;41406.585934140574;41495.37756933648;41641.791791041156;3267.526208699749;3271.9836400817844;3303.6861498157637;3312.850921708529;3369.22507823202;30602.84698576515;30860.38279234425;31161.22096947572;31339.216519587193;33550.664493355;4242.469691288589;4274.508431530352;4285.742855428684;4297.720648157891;4388.605025547684;345304;348121;350163;350391;350553;60767.69616151891;62251;62461.06308405378;62519;62605.93061450991;34866.65133348685;36052.639473604926;36307.64000340022;37955.81022094927;37977.24045519074;17051.91474042622;17216.913915430592;17228.310867565408;17232.655346892992;17234.91382543079;11725.296482211095;13014.479420823061;13210.207387556777;13219.537316194079;13220.074594778465;16892.817502774935;18927.14827832751;19400.57625474022;19608.509787255432;19649.607007859762;7296.489245752852;7415.2214017527385;7593;7624.237576242332;7690.73082442123;915.6337465013914;938.5563730363863;978.814025335184;996.0985308296003;1036.6630844975414;31141.8442907784;31608.525872111935;31757;31794.84102579472;31906.361872762416;1060.8939106089329;1095.0965453500894;1101.807183742858;1126.3129491010477;1165.2658824940233;16507.752383714254;16879.15604219784;16992.405265815636;17061.146942652817;17273.65452690939;481963;482782;483310;486112;486942;58081.70959145177;58554.12168817471;58680.41319586835;58977.70511147503;59032.40967590355;1208.238809549978;1254.8368712067372;1316.7827308494184;1319.4656164253493;1353.0461024977367;28924.42151157007;30591.847040764653;32736.181595460304;33227;33687.32625347529;51232.48767512277;52096.21855672244;52155.47844521506;52167.2174917369;52239.73880130575;422178.33859937004;432754;433507;433614;433718;42410.649761018474;43009.56990430181;43276.56723432851;43736.56263437325;43738.78130609327;45514.77242613766;46176.30735538902;46572;46598.30102548397;46960.76519617517;39842.2031559373;39853.20293594054;40352.79823600863;41323.1735365297;41608.58391416168;39307.213855722155;39469.80265098656;40760.184796303314;40803;41634.79182604067;39701.20597587974;40228.597714022486;40394.39408408818;40593.797031015834;41596.168076637696;33963.49054764131;35528.64471355357;36336.27327453489;36746;36892.63107368999;27087.72912270852;28050.57924131099;28067.29831754141;28079.57880631833;28089.297767555974 16:11:09 INFO - PROCESS | 10539 | |2;jquery.html;351.4341909525665;369.0312184495714;382.0849066485766;382.453092078328;401.3438028822874;13959.232242226673;17581.736273955885;17949.371771987982;18860.811391886076;19045.80954190458;17768.82231177688;18419.815801841978;18491.167897444615;18808.717869231972;19042.61914761704;5529.115341545354;5823.5341172706085;5826.854328641797;5828.184054232411;5832.650040997553;4183.267928112583;4270.4234928284595;4337.219300525904;5744.052231381817;5759.654420734749;6274.654893980852;6306;6438.613683179001;6442;6448.161738973927;5322.414534401193;5551.833444996657;5562.527185189264;6428.357164283581;6434.6782660867;5462.5083742462975;5478.698671573062;5481.451854814526;5482.23248745176;5485.149801780731;14586.708265834624;21081.46748449091;22092;22314.442138946495;22337;2129.1909074551572;2136.3484137338105;2148.1836901977304;2171.956560868774;2881.927951801201;9769.755756106084;9878.160356369717;9995.350302230405;10414.843777343345;10497.265191436603;1850.3893715073993;1964.8231659150745;1976.2786582897284;1977.149825575002;1988.0954165854646;83388.20712361604;84132.15867841305;84358;84708.15291847065;86060.70908936308;10510.579576816841;10626.787464250672;10684.465776711133;10741.355518668905;10819.67540973772;15132.394704211709;15145.394184232728;15170.848291517164;15232.847671523365;15254.771178432333;7572.4699271051595;7840.3335716464735;7930.6431210595665;7942.324902383362;8197.262246397733;7640.579768112696;7640.923590764132;7952.960235198787;7954.363650907913;7957.204279571996;4449.975261256121;4596.563326483979;4633.907321853611;4704.929426058612;4748.335233067304;1843.1200175820588;1885.9528511787314;1925.4416219296247;1938.331275709878;1941.213808407597;871.9258862996717;973.5757962672893;986.3095832916844;1004.0612027754073;1030.9175265978704;17650.5587360317;18208.45374638763;19267.614647707247;19304.806951930303;19708.901455492633;960.5053397500293;963.272729089533;976.3946353260882;1009.7828966772179;1032.6282538286212;10418.426986515815;10942.124630029579;10944.452777361259;10958.890411095947;11097.611583594535;437631;442456;449792;453576;455153;91386.54306728557;92965.53517232371;93382;94554.5272273648;95545.52227238819;1059.2003037706481;1067.1889364083509;1087.2769608210451;1092.3500517192258;1103.7902798468265;16253.349866005228;16274.67450651004;16707.49877503677;17106.657866842346;17184.742228866326;41504.58495415007;42768.78615606902;42848.78575607102;43738.78130609327;44310.03136675135;58158.4184158153;58354.7082264586;59239.70380148072;60014;60735.69632151811;8008.359331253602;8015.398845086758;8096.190380961857;8263.256306932404;8273.669053238043;10728.195385346286;12243.510259589517;12428.56500022495;13032.218066916015;13045.543405980745;10822;11182.776344472903;11224.607138750105;11303.604373846876;11776.941115294369;10885.727856803644;10968;11166.776664466828;11417.885821141683;11590;11090.112790976864;11263.324200547993;11413.201075924937;11452;11565.479553419947;8163.591820409075;8178.427510074475;8253.79365515867;8330.791730206793;8433.493990360597;10275;11305.660830175108;11342.489587968726;11432.14258930567;11875.287482751062 16:11:09 INFO - PROCESS | 10539 | |3;mootools.html;1308.6401239659099;1457.9125252484848;1493.2608358862362;1611.411834680342;1766.2758269109668;7512.399008079355;8512.106228845967;8797.86803197951;8801.823963520734;8978.416402933804;8794.6921857735;8856;8859.911400885989;8861.512616806072;8862.77843053924;2269.8524595901254;2273.227102785053;2299.8275129365366;2303.239930822833;2309.4688221709016;2226.053927080984;2288.439332363573;2296.9540609187807;2298.6322188449853;2307.1348244408346;2235.094786611417;2282.5206706591553;2291.9885400572975;2293.5183611441616;2293.575688497625;2205.3163519308987;2212.6570381590877;2214.9446263843533;2233.4416395901026;2233.4416395901026;2203.0857194264363;2217.401301648546;2220.555888822242;2226.421130506064;2229.141780414536;8678.175573320525;8822;8881.511516866569;8926.285897128279;8937.106289371011;5202.531772140488;5377.7311134443125;5378.924215156984;5388.488093631099;5404.054290499147;3167.952480712791;3176.952345714816;3182.403646091341;3237.983810080958;3238.951415728766;927.3030354451338;932.7854593443478;941.6092321686492;944.3531181140941;952.885653721551;12338;12419.31693756843;12424.130310878241;12434.564790232389;12455.75088498225;4392.494863090722;4467.061916997467;4500.279955207151;4518.796654150571;4572.154151481986;9800.460974646463;9815.312928094965;9817.656382026595;9823.803523929482;9827.4103553787;5257.7896884124975;5262.578993680497;5264.947350526522;5267.947320526746;5269.262303277545;4372.562743725602;4402.801873915681;4881.585065269492;4914.066327397783;4942.20924652054;3597.4963505109304;3717.182219911615;3751.793651349202;3766.4388216013376;3836.8848934532007;1109.4785450838094;1114.587602587048;1118.972025699364;1120.5181771838024;1123.1239633086207;770.2143813310392;839.5969934431507;878.5563290538365;889.4440974391006;899.0470101692227;5235.31940847695;5282.788688452496;5401.405845357008;5424.945750542444;5445.891082178334;426.88474111989586;428.7330937080918;428.78775006372047;428.95067067287664;429.7249760153504;3662.6337366263692;3668;3669.339518886626;3680.8343624536424;3783.319002579507;10798;11130.220884538005;11224.326540407601;11241.21311508203;11252.943735281271;11132.332060076422;11161.274517156358;11171.66485005451;11179.44102794857;11184.776304473866;7763.9223607764325;8249.587520624065;8254.05078415978;8380.240149568537;8391.832163356821;5600.131979543177;5624.971875140598;5677.687727175045;5743.942560574508;5881.147233651182;9590.472524011246;10053.346532475365;10148.340357876714;10228.64199753005;10241.129503992244;10199.28604997643;10311.690649280534;10335.22485813582;10430.843537347098;10435.582576696846;7107.857842843011;7358.484906056525;7677.347425468898;7884.448088633741;8000.119986801331;8587.398882078194;8698.43460175112;8699.13008699125;8710.47737135774;8721.869171962298;7606.695732170872;7642.885356719765;7762.184970578234;7836.764897053097;7876.369890408639;7359.4480413968095;7574.431917606092;7590.7722768317035;7634.50375725576;7735.071791385069;6609.834754130993;6731.966340168267;6737.326267373223;6738;6740.090087838079;4595;4635.304704294383;4729.432468103712;4745.715257084586;4779.784909679003;4577.404937358122;4596.6322694185055;4663.626909847272;4670.696404733681;4812.975935120442 16:11:09 INFO - PROCESS | 10539 | |4;prototype.html;303.5522604158866;306.19928885963196;310.41022058089635;316.4825510290674;318.13308733700654;5056.974715126428;5192.480751924811;5209.218617207421;5268.68387896726;5271.868203294919;5075.543201111899;5151.124308867502;5164.225366195073;5172.6379153459175;5235;4115.691323150761;4118.505779306487;4120.443740095079;4121.752694838305;4138.620293331339;3868.400397938324;4057.316213771296;4128.50457945047;4129.648979836717;4129.9174016519655;4036.374361973899;4046.5953404659595;4046.8178931947987;4047.7773722445254;4053.5946405359523;4023.6378725914515;4032.475778148822;4034.536028356747;4038.415414134971;4051.858184963512;3524.665156810099;3525.823708814549;3552.7335449841366;3562.287542491512;3563.3051554946796;4836.975815120937;5042.218456139304;5055.292259083732;5077.619178561586;5097.949020509822;4597.172508948388;4605.355250264965;4607.378003969455;4615.723056616614;4616.76916154191;5449.618526703132;5450.56395488364;5459.645123067027;5459.843361872078;5468.562514998791;3770.8868733938025;3824.9043773905596;3828.1960788234505;3828.693704503633;3845.711571632111;5559.552358113493;5596.888062238773;5602.702891814377;5625.915611265793;5630.352509461423;3927.5286965564314;3934.1738234970976;3940;3940.566537680853;3943.684505239574;3894.6300101490315;3982.203559288154;3985.2228815381304;3993.1249500359695;4011.859584914514;4616.976915115403;4622.249761391967;4623.468301145412;4641.814327426932;4650;5521.668699878021;5537.920105579374;5539.19681646159;5553.500184983371;5562.499375056264;1319.1689235781396;1348.9325533723274;1351.2635613590617;1371.9314034298245;1376.4287820554557;891.1088911088912;925.1904583489446;928.211020632457;932.4451951089092;935.9719208423758;5244.374243984377;5245.318108645852;5247.553957913544;5250.842474725764;5264.684118952875;5432.239486471897;5513.2005859151;5546.500814926676;5550.639208451437;5562.360328562268;5014.6740461870595;5191.506806853343;5235.293235413246;5249.842504724865;5252.133397989365;2608.4652646207483;2624.278323461025;2635.4465562231762;2643.035292118363;2669.27929459045;4990.554628232213;4997.950020499821;5011.749412529359;5018.644965859271;5047.04747722579;4686.6408741465275;4972.8173968660085;4989.727619457015;4995.400551933792;5013.997200559829;4960.553550180501;4994.775235114428;5037.926864612657;5039.571636410946;5046.21783623539;4835.274708793569;4869.860618474268;4880.048390563806;4926.940707747852;4932;4843.854684359475;4845.63657725665;5164.922526162186;5587.972060139836;5614.606977511535;5765.682887441063;5769.769209231584;5778.855528611818;5779.422057794187;5784.4504772046585;3936.4292177634657;3939.4878665773267;3940.625640564142;3963.900902477461;3968.8412463501136;5377.193420986883;5451.536619387238;5589.245451863946;5641.9435805641415;5651.802186923438;5377.838664840061;5424.864378390572;5562.41224410245;5572.913281909989;5577.27495425592;5518.2826232589505;5524;5540.418256083053;5540.833774986757;5547.2233887256625;5263.421023687468;5435.83692489226;5457.235986961908;5464.480874316933;5467;5513.173024046425;5559.861003474945;5560.138178582326;5575.77696892136;5600.747966341443;5469.644473109394;5470.398256191896;5471.261379713687;5473.890522189454;5482.205080263259 16:11:09 INFO - PROCESS | 10539 | |5;yui.html;613.3470297548108;621.260699767277;666.7999600119969;681.6216999565246;743.0785825576284;15475.61310967225;15534.922325388385;15541.378344866192;15585.844141558595;16077.276522556484;16323.59191020225;16526.586835329123;16544.66910661789;16622.58443538909;16694.666106677858;672.3243140643647;689;787.401574803148;799.8600244957124;817.2562967699395;804.2600807257309;806.5765473126626;806.7821688144197;807.1645846548823;807.2815194476921;845.6575087089708;846.6571038729325;856.6616186606287;857.1385757313922;857.9613917373733;697.4385619576265;715.4812760748416;820.729159377404;852.6972924611736;852.8336974290016;592.6888383598603;598.2641351138125;598.8143675460577;599.2958274028;614.5483069943632;15955.601109972344;16006.439774607948;16022.919885400615;16039.679206415807;16041.35834566616;13869.306534673327;14122.435102595884;14437.71124577513;14502.709945801025;14589.92705036468;13166.970585903422;13344.399502022336;13380;13478.663033424145;13829.377678004514;4259.91480170398;4340.782960851976;4448.088141930929;4470.9122271545575;4471.1728330259;76860.61569692116;77839.6108019462;77857.61071194608;78578.60710696467;78647.21352786514;10633.415162166155;10923.726906827234;11239.494222759995;11417.48621312043;11472.31166130035;20569.58860822775;20708.79291207099;20709.0680919359;20712.17151313961;21258.36224913255;7524.548527088392;7631.275028872248;7633.160352361236;7749.457537972288;7797.103333116651;4346.8043938022865;4448;4477.8208871644765;4514.074614703978;4535.7732113394195;3359.5800524934384;3465.8093804840473;3476.947845782315;3478.4434490481403;3478.617352091268;544.064209559557;545.5526468296039;549.8268045565634;565.2877374508149;621.9067139929047;637.1875858280637;650.7982525417136;655.429776094791;662.192125606759;684.5721424109931;9203.76990575241;9258.90741092594;9352.251819854395;9498.82051897163;9760.233830622457;555.7702023954569;628.5097623853402;632.1339764522634;652.3443938841434;663.4857985061616;4523.638108951276;4671.976640116778;4730.9763451182525;4761.857144285677;4820.4456487504385;113970.43014784873;118968;120511;122332;122363;99298;101465;103055.4847225759;104615;110632;91931.54034229786;92322;93100;93927.99999999863;94488.52755736315;8588.957055214683;8770.91229087701;8834.249088827264;8907.10928907104;8923.202924461475;52098.479015210876;52294.73852630713;52824;53154.73422632862;53758;65870;70892.29107708856;70996.29003709897;71690.28309717045;72374.27625723675;12978.480860765841;13010.609681709564;13043.739125217253;13392.665183370103;13438.865611343761;14287.57137285883;14453;14692.118472891661;14974.401023958919;15012.099274043592;13817.516386926409;13840.377183026989;13918.16491010502;13934.860651393356;14787.92606036963;13212.471501139848;13298.933505332412;13413.329333533089;13421.597352079454;14106.153630782186;12739.55411560628;13252.734945300846;13507.932460337635;13814.447422103405;14336.713265734836;10933.617323393642;11160.386178760245;11301.15241356885;11705.824412633647;11782.52869885195;11397.544148048784;11579.131565132817;11817.763644727229;11831.34927578957;11912.940435298115 16:11:09 INFO - PROCESS | 10539 | __end_tp_report 16:11:09 INFO - PROCESS | 10539 | __start_cc_report 16:11:09 INFO - PROCESS | 10539 | _x_x_mozilla_cycle_collect,2740 16:11:09 INFO - PROCESS | 10539 | __end_cc_report 16:11:09 INFO - PROCESS | 10539 | __startTimestamp1476918669178__endTimestamp 16:11:09 INFO - PROCESS | 10539 | 16:11:09 INFO - PROCESS | 10539 | ------- Summary: start ------- 16:11:09 INFO - PROCESS | 10539 | Number of tests: 6 16:11:09 INFO - PROCESS | 10539 | 16:11:09 INFO - PROCESS | 10539 | [#0] dojo.html Cycles:165 Average:5329.03 Median:5471.97 stddev:589.37 (10.8%) stddev-sans-first:563.85 16:11:09 INFO - PROCESS | 10539 | Values: 3067.7 3094.1 3124.8 3132.5 3135.7 5204.3 5270.9 5314.9 5371.7 5424.9 5332.1 5347.7 5413.7 5423.2 5463.5 4848.6 4875.6 4896.9 4902.3 4915.3 4932.5 5007.1 5028.1 5031.2 5094.8 4939.2 4956.9 4998.4 5010.7 5050.7 4764.6 4791.8 4794.7 4818.7 4831.0 4767.3 4869.6 4882.2 4894.1 4899.8 5241.2 5333.9 5335.7 5336.3 5345.5 5695.5 5700.6 5708.1 5711.3 5787.7 5537.9 5592.6 5686.5 5794.2 5800.2 5330.5 5348.3 5354.8 5357.0 5422.1 5828.2 5829.5 5845.4 5847.3 5847.4 5428.2 5459.3 5579.4 5616.5 5619.4 5696.7 5729.5 5738.7 5782.9 5797.9 5715.8 5718.0 5724.6 5726.7 5751.3 5536.8 5553.2 5598.8 5714.9 5715.5 4357.2 4394.9 4413.3 4420.6 4472.2 3941.1 3945.2 3954.2 3986.2 4003.1 5208.5 5446.9 5447.5 5448.6 5451.2 5622.4 5706.3 5740.2 5745.0 5837.0 5443.3 5449.1 5450.3 5453.0 5453.7 5003.2 5011.6 5012.0 5012.2 5071.1 5735.9 5846.6 5850.8 5898.1 5932.0 5756.3 5760.4 5767.4 5770.8 5771.7 5915.2 5918.8 5925.7 5927.3 5929.0 5634.2 5679.2 5687.2 5692.7 5697.6 5715.0 5754.8 5764.6 5793.9 5858.4 5651.3 5665.7 5665.9 5667.0 5673.3 5630.8 5638.3 5641.0 5645.5 5652.7 5413.5 5449.4 5499.3 5529.0 5548.7 5660.3 5664.1 5669.6 5676.8 5680.9 5427.3 5436.5 5471.6 5472.0 5528.7 16:11:09 INFO - PROCESS | 10539 | 16:11:09 INFO - PROCESS | 10539 | [#1] ext.html Cycles:180 Average:58508.69 Median:39585.50 stddev:112292.47 (283.7%) stddev-sans-first:112523.33 16:11:09 INFO - PROCESS | 10539 | Values: 607.9 634.0 635.7 644.9 651.2 31402.5 41628.0 43199.0 43417.8 46803.5 44575.6 44580.8 44886.8 45046.1 45141.0 7953.7 8822.7 8991.8 9000.9 9006.5 7847.9 8155.1 8167.7 10496.2 10819.4 10879.0 10928.7 10934.7 10939.6 10946.3 10746.8 10750.4 10799.8 10856.6 10856.8 10516.6 10617.4 10625.3 10630.5 10632.3 41261.8 41344.4 41406.6 41495.4 41641.8 3267.5 3272.0 3303.7 3312.9 3369.2 30602.8 30860.4 31161.2 31339.2 33550.7 4242.5 4274.5 4285.7 4297.7 4388.6 345304.0 348121.0 350163.0 350391.0 350553.0 60767.7 62251.0 62461.1 62519.0 62605.9 34866.7 36052.6 36307.6 37955.8 37977.2 17051.9 17216.9 17228.3 17232.7 17234.9 11725.3 13014.5 13210.2 13219.5 13220.1 16892.8 18927.1 19400.6 19608.5 19649.6 7296.5 7415.2 7593.0 7624.2 7690.7 915.6 938.6 978.8 996.1 1036.7 31141.8 31608.5 31757.0 31794.8 31906.4 1060.9 1095.1 1101.8 1126.3 1165.3 16507.8 16879.2 16992.4 17061.1 17273.7 481963.0 482782.0 483310.0 486112.0 486942.0 58081.7 58554.1 58680.4 58977.7 59032.4 1208.2 1254.8 1316.8 1319.5 1353.0 28924.4 30591.8 32736.2 33227.0 33687.3 51232.5 52096.2 52155.5 52167.2 52239.7 422178.3 432754.0 433507.0 433614.0 433718.0 42410.6 43009.6 43276.6 43736.6 43738.8 45514.8 46176.3 46572.0 46598.3 46960.8 39842.2 39853.2 40352.8 41323.2 41608.6 39307.2 39469.8 40760.2 40803.0 41634.8 39701.2 40228.6 40394.4 40593.8 41596.2 33963.5 35528.6 36336.3 36746.0 36892.6 27087.7 28050.6 28067.3 28079.6 28089.3 16:11:09 INFO - PROCESS | 10539 | 16:11:09 INFO - PROCESS | 10539 | [#2] jquery.html Cycles:180 Average:27751.19 Median:1616.68 stddev:74264.75 (4593.7%) stddev-sans-first:74444.58 16:11:09 INFO - PROCESS | 10539 | Values: 351.4 369.0 382.1 382.5 401.3 13959.2 17581.7 17949.4 18860.8 19045.8 17768.8 18419.8 18491.2 18808.7 19042.6 5529.1 5823.5 5826.9 5828.2 5832.7 4183.3 4270.4 4337.2 5744.1 5759.7 6274.7 6306.0 6438.6 6442.0 6448.2 5322.4 5551.8 5562.5 6428.4 6434.7 5462.5 5478.7 5481.5 5482.2 5485.1 14586.7 21081.5 22092.0 22314.4 22337.0 2129.2 2136.3 2148.2 2172.0 2881.9 9769.8 9878.2 9995.4 10414.8 10497.3 1850.4 1964.8 1976.3 1977.1 1988.1 83388.2 84132.2 84358.0 84708.2 86060.7 10510.6 10626.8 10684.5 10741.4 10819.7 15132.4 15145.4 15170.8 15232.8 15254.8 7572.5 7840.3 7930.6 7942.3 8197.3 7640.6 7640.9 7953.0 7954.4 7957.2 4450.0 4596.6 4633.9 4704.9 4748.3 1843.1 1886.0 1925.4 1938.3 1941.2 871.9 973.6 986.3 1004.1 1030.9 17650.6 18208.5 19267.6 19304.8 19708.9 960.5 963.3 976.4 1009.8 1032.6 10418.4 10942.1 10944.5 10958.9 11097.6 437631.0 442456.0 449792.0 453576.0 455153.0 91386.5 92965.5 93382.0 94554.5 95545.5 1059.2 1067.2 1087.3 1092.4 1103.8 16253.3 16274.7 16707.5 17106.7 17184.7 41504.6 42768.8 42848.8 43738.8 44310.0 58158.4 58354.7 59239.7 60014.0 60735.7 8008.4 8015.4 8096.2 8263.3 8273.7 10728.2 12243.5 12428.6 13032.2 13045.5 10822.0 11182.8 11224.6 11303.6 11776.9 10885.7 10968.0 11166.8 11417.9 11590.0 11090.1 11263.3 11413.2 11452.0 11565.5 8163.6 8178.4 8253.8 8330.8 8433.5 10275.0 11305.7 11342.5 11432.1 11875.3 16:11:09 INFO - PROCESS | 10539 | 16:11:09 INFO - PROCESS | 10539 | [#3] mootools.html Cycles:180 Average:5685.90 Median:4667.16 stddev:3378.29 (72.4%) stddev-sans-first:3371.75 16:11:09 INFO - PROCESS | 10539 | Values: 1308.6 1457.9 1493.3 1611.4 1766.3 7512.4 8512.1 8797.9 8801.8 8978.4 8794.7 8856.0 8859.9 8861.5 8862.8 2269.9 2273.2 2299.8 2303.2 2309.5 2226.1 2288.4 2297.0 2298.6 2307.1 2235.1 2282.5 2292.0 2293.5 2293.6 2205.3 2212.7 2214.9 2233.4 2233.4 2203.1 2217.4 2220.6 2226.4 2229.1 8678.2 8822.0 8881.5 8926.3 8937.1 5202.5 5377.7 5378.9 5388.5 5404.1 3168.0 3177.0 3182.4 3238.0 3239.0 927.3 932.8 941.6 944.4 952.9 12338.0 12419.3 12424.1 12434.6 12455.8 4392.5 4467.1 4500.3 4518.8 4572.2 9800.5 9815.3 9817.7 9823.8 9827.4 5257.8 5262.6 5264.9 5267.9 5269.3 4372.6 4402.8 4881.6 4914.1 4942.2 3597.5 3717.2 3751.8 3766.4 3836.9 1109.5 1114.6 1119.0 1120.5 1123.1 770.2 839.6 878.6 889.4 899.0 5235.3 5282.8 5401.4 5424.9 5445.9 426.9 428.7 428.8 429.0 429.7 3662.6 3668.0 3669.3 3680.8 3783.3 10798.0 11130.2 11224.3 11241.2 11252.9 11132.3 11161.3 11171.7 11179.4 11184.8 7763.9 8249.6 8254.1 8380.2 8391.8 5600.1 5625.0 5677.7 5743.9 5881.1 9590.5 10053.3 10148.3 10228.6 10241.1 10199.3 10311.7 10335.2 10430.8 10435.6 7107.9 7358.5 7677.3 7884.4 8000.1 8587.4 8698.4 8699.1 8710.5 8721.9 7606.7 7642.9 7762.2 7836.8 7876.4 7359.4 7574.4 7590.8 7634.5 7735.1 6609.8 6732.0 6737.3 6738.0 6740.1 4595.0 4635.3 4729.4 4745.7 4779.8 4577.4 4596.6 4663.6 4670.7 4813.0 16:11:09 INFO - PROCESS | 10539 | 16:11:09 INFO - PROCESS | 10539 | [#4] prototype.html Cycles:180 Average:4493.65 Median:5038.75 stddev:1321.86 (26.2%) stddev-sans-first:1287.61 16:11:09 INFO - PROCESS | 10539 | Values: 303.6 306.2 310.4 316.5 318.1 5057.0 5192.5 5209.2 5268.7 5271.9 5075.5 5151.1 5164.2 5172.6 5235.0 4115.7 4118.5 4120.4 4121.8 4138.6 3868.4 4057.3 4128.5 4129.6 4129.9 4036.4 4046.6 4046.8 4047.8 4053.6 4023.6 4032.5 4034.5 4038.4 4051.9 3524.7 3525.8 3552.7 3562.3 3563.3 4837.0 5042.2 5055.3 5077.6 5097.9 4597.2 4605.4 4607.4 4615.7 4616.8 5449.6 5450.6 5459.6 5459.8 5468.6 3770.9 3824.9 3828.2 3828.7 3845.7 5559.6 5596.9 5602.7 5625.9 5630.4 3927.5 3934.2 3940.0 3940.6 3943.7 3894.6 3982.2 3985.2 3993.1 4011.9 4617.0 4622.2 4623.5 4641.8 4650.0 5521.7 5537.9 5539.2 5553.5 5562.5 1319.2 1348.9 1351.3 1371.9 1376.4 891.1 925.2 928.2 932.4 936.0 5244.4 5245.3 5247.6 5250.8 5264.7 5432.2 5513.2 5546.5 5550.6 5562.4 5014.7 5191.5 5235.3 5249.8 5252.1 2608.5 2624.3 2635.4 2643.0 2669.3 4990.6 4998.0 5011.7 5018.6 5047.0 4686.6 4972.8 4989.7 4995.4 5014.0 4960.6 4994.8 5037.9 5039.6 5046.2 4835.3 4869.9 4880.0 4926.9 4932.0 4843.9 4845.6 5164.9 5588.0 5614.6 5765.7 5769.8 5778.9 5779.4 5784.5 3936.4 3939.5 3940.6 3963.9 3968.8 5377.2 5451.5 5589.2 5641.9 5651.8 5377.8 5424.9 5562.4 5572.9 5577.3 5518.3 5524.0 5540.4 5540.8 5547.2 5263.4 5435.8 5457.2 5464.5 5467.0 5513.2 5559.9 5560.1 5575.8 5600.7 5469.6 5470.4 5471.3 5473.9 5482.2 16:11:09 INFO - PROCESS | 10539 | 16:11:09 INFO - PROCESS | 10539 | [#5] yui.html Cycles:180 Average:21301.55 Median:4474.50 stddev:31052.20 (694.0%) stddev-sans-first:31100.46 16:11:09 INFO - PROCESS | 10539 | Values: 613.3 621.3 666.8 681.6 743.1 15475.6 15534.9 15541.4 15585.8 16077.3 16323.6 16526.6 16544.7 16622.6 16694.7 672.3 689.0 787.4 799.9 817.3 804.3 806.6 806.8 807.2 807.3 845.7 846.7 856.7 857.1 858.0 697.4 715.5 820.7 852.7 852.8 592.7 598.3 598.8 599.3 614.5 15955.6 16006.4 16022.9 16039.7 16041.4 13869.3 14122.4 14437.7 14502.7 14589.9 13167.0 13344.4 13380.0 13478.7 13829.4 4259.9 4340.8 4448.1 4470.9 4471.2 76860.6 77839.6 77857.6 78578.6 78647.2 10633.4 10923.7 11239.5 11417.5 11472.3 20569.6 20708.8 20709.1 20712.2 21258.4 7524.5 7631.3 7633.2 7749.5 7797.1 4346.8 4448.0 4477.8 4514.1 4535.8 3359.6 3465.8 3476.9 3478.4 3478.6 544.1 545.6 549.8 565.3 621.9 637.2 650.8 655.4 662.2 684.6 9203.8 9258.9 9352.3 9498.8 9760.2 555.8 628.5 632.1 652.3 663.5 4523.6 4672.0 4731.0 4761.9 4820.4 113970.4 118968.0 120511.0 122332.0 122363.0 99298.0 101465.0 103055.5 104615.0 110632.0 91931.5 92322.0 93100.0 93928.0 94488.5 8589.0 8770.9 8834.2 8907.1 8923.2 52098.5 52294.7 52824.0 53154.7 53758.0 65870.0 70892.3 70996.3 71690.3 72374.3 12978.5 13010.6 13043.7 13392.7 13438.9 14287.6 14453.0 14692.1 14974.4 15012.1 13817.5 13840.4 13918.2 13934.9 14787.9 13212.5 13298.9 13413.3 13421.6 14106.2 12739.6 13252.7 13507.9 13814.4 14336.7 10933.6 11160.4 11301.2 11705.8 11782.5 11397.5 11579.1 11817.8 11831.3 11912.9 16:11:09 INFO - PROCESS | 10539 | -------- Summary: end -------- 16:11:09 INFO - PROCESS | 10539 | 16:11:10 INFO - TEST-INFO | 10539: exit 0 16:11:10 INFO - TEST-OK | dromaeo_css | took 1118286ms 16:11:10 INFO - TEST-START | kraken 16:11:10 INFO - operating with platform_type : linux_ 16:11:10 INFO - Initialising browser for kraken test... 16:11:10 INFO - TEST-INFO | started process 10847 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphKYSiY/profile http://localhost:41488/getInfo.html) 16:11:13 INFO - PROCESS | 10847 | __metrics Screen width/height:1600/1200 16:11:13 INFO - PROCESS | 10847 | colorDepth:24 16:11:13 INFO - PROCESS | 10847 | Browser inner width/height: 1024/697 16:11:13 INFO - PROCESS | 10847 | __metrics 16:11:14 INFO - PROCESS | 10847 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 16:11:14 INFO - PROCESS | 10847 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:11:15 INFO - PROCESS | 10847 | console.error: PushService: 16:11:15 INFO - PROCESS | 10847 | stateChangeProcessEnqueue: Error transitioning state 16:11:15 INFO - PROCESS | 10847 | UnknownError 16:11:15 INFO - TEST-INFO | 10847: exit 0 16:11:15 INFO - Browser initialized. 16:11:15 INFO - Running cycle 1/1 for kraken test... 16:11:15 INFO - TEST-INFO | started process 10930 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphKYSiY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:11:27 INFO - PROCESS | 10930 | RSS: Main: 172027904 16:11:27 INFO - PROCESS | 10930 | 16:11:30 INFO - PROCESS | 10930 | Cycle 1(1): loaded http://localhost:41488/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41488/tests/kraken/driver.html?testName=audio-beat-detection) 16:11:31 INFO - PROCESS | 10930 | RSS: Main: 229482496 16:11:31 INFO - PROCESS | 10930 | 16:11:33 INFO - PROCESS | 10930 | Cycle 1(1): loaded http://localhost:41488/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41488/tests/kraken/driver.html?testName=audio-dft) 16:11:34 INFO - PROCESS | 10930 | RSS: Main: 216154112 16:11:34 INFO - PROCESS | 10930 | 16:11:37 INFO - PROCESS | 10930 | Cycle 1(1): loaded http://localhost:41488/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41488/tests/kraken/driver.html?testName=audio-fft) 16:11:38 INFO - PROCESS | 10930 | RSS: Main: 298250240 16:11:38 INFO - PROCESS | 10930 | 16:11:40 INFO - PROCESS | 10930 | Cycle 1(1): loaded http://localhost:41488/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41488/tests/kraken/driver.html?testName=audio-oscillator) 16:11:40 INFO - PROCESS | 10930 | RSS: Main: 209289216 16:11:40 INFO - PROCESS | 10930 | 16:11:43 INFO - PROCESS | 10930 | Cycle 1(1): loaded http://localhost:41488/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41488/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:11:43 INFO - PROCESS | 10930 | RSS: Main: 212369408 16:11:43 INFO - PROCESS | 10930 | 16:11:46 INFO - PROCESS | 10930 | Cycle 1(1): loaded http://localhost:41488/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41488/tests/kraken/driver.html?testName=imaging-darkroom) 16:11:47 INFO - PROCESS | 10930 | RSS: Main: 248619008 16:11:47 INFO - PROCESS | 10930 | 16:11:50 INFO - PROCESS | 10930 | Cycle 1(1): loaded http://localhost:41488/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41488/tests/kraken/driver.html?testName=imaging-desaturate) 16:11:51 INFO - PROCESS | 10930 | RSS: Main: 247001088 16:11:51 INFO - PROCESS | 10930 | 16:11:53 INFO - PROCESS | 10930 | Cycle 1(1): loaded http://localhost:41488/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41488/tests/kraken/driver.html?testName=json-parse-financial) 16:11:54 INFO - PROCESS | 10930 | RSS: Main: 247156736 16:11:54 INFO - PROCESS | 10930 | 16:11:55 INFO - PROCESS | 10930 | Cycle 1(1): loaded http://localhost:41488/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41488/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:11:56 INFO - PROCESS | 10930 | RSS: Main: 209522688 16:11:56 INFO - PROCESS | 10930 | 16:11:58 INFO - PROCESS | 10930 | Cycle 1(1): loaded http://localhost:41488/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41488/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:11:58 INFO - PROCESS | 10930 | RSS: Main: 216797184 16:11:58 INFO - PROCESS | 10930 | 16:12:00 INFO - PROCESS | 10930 | Cycle 1(1): loaded http://localhost:41488/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41488/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:12:01 INFO - PROCESS | 10930 | RSS: Main: 226029568 16:12:01 INFO - PROCESS | 10930 | 16:12:04 INFO - PROCESS | 10930 | Cycle 1(1): loaded http://localhost:41488/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41488/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:12:04 INFO - PROCESS | 10930 | RSS: Main: 234971136 16:12:04 INFO - PROCESS | 10930 | 16:12:07 INFO - PROCESS | 10930 | Cycle 1(1): loaded http://localhost:41488/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41488/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:12:08 INFO - PROCESS | 10930 | RSS: Main: 231735296 16:12:08 INFO - PROCESS | 10930 | 16:12:09 INFO - PROCESS | 10930 | Cycle 1(1): loaded http://localhost:41488/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41488/tests/kraken/driver.html?testName=ai-astar) 16:12:10 INFO - PROCESS | 10930 | RSS: Main: 282427392 16:12:10 INFO - PROCESS | 10930 | 16:12:10 INFO - PROCESS | 10930 | __start_tp_report 16:12:10 INFO - PROCESS | 10930 | _x_x_mozilla_page_load 16:12:10 INFO - PROCESS | 10930 | _x_x_mozilla_page_load_details 16:12:10 INFO - PROCESS | 10930 | |i|pagename|runs| 16:12:10 INFO - PROCESS | 10930 | |0;ai-astar;103;111;114;114;111;111;111;113;111;112 16:12:10 INFO - PROCESS | 10930 | |1;audio-beat-detection;142;125;128;162;125;120;123;122;150;121 16:12:10 INFO - PROCESS | 10930 | |2;audio-dft;163;161;161;163;160;161;164;162;162;161 16:12:10 INFO - PROCESS | 10930 | |3;audio-fft;74;74;75;116;76;76;75;75;103;76 16:12:10 INFO - PROCESS | 10930 | |4;audio-oscillator;81;82;123;83;83;83;104;82;82;118 16:12:10 INFO - PROCESS | 10930 | |5;imaging-gaussian-blur;116;116;116;118;117;117;117;117;117;116 16:12:10 INFO - PROCESS | 10930 | |6;imaging-darkroom;147;148;146;147;147;147;147;147;146;146 16:12:10 INFO - PROCESS | 10930 | |7;imaging-desaturate;86;86;86;84;84;84;85;84;85;84 16:12:10 INFO - PROCESS | 10930 | |8;json-parse-financial;53;55;56;55;55;55;56;55;56;56 16:12:10 INFO - PROCESS | 10930 | |9;json-stringify-tinderbox;59;59;59;59;60;58;58;59;58;60 16:12:10 INFO - PROCESS | 10930 | |10;stanford-crypto-aes;79;83;80;83;89;83;79;86;79;79 16:12:10 INFO - PROCESS | 10930 | |11;stanford-crypto-ccm;135;139;131;133;140;129;133;134;168;133 16:12:10 INFO - PROCESS | 10930 | |12;stanford-crypto-pbkdf2;166;175;167;164;170;165;165;172;165;165 16:12:10 INFO - PROCESS | 10930 | |13;stanford-crypto-sha256-iterative;72;66;65;68;69;66;66;65;65;71 16:12:10 INFO - PROCESS | 10930 | __end_tp_report 16:12:10 INFO - PROCESS | 10930 | __start_cc_report 16:12:10 INFO - PROCESS | 10930 | _x_x_mozilla_cycle_collect,1665 16:12:10 INFO - PROCESS | 10930 | __end_cc_report 16:12:10 INFO - PROCESS | 10930 | __startTimestamp1476918730070__endTimestamp 16:12:10 INFO - PROCESS | 10930 | 16:12:10 INFO - PROCESS | 10930 | ------- Summary: start ------- 16:12:10 INFO - PROCESS | 10930 | Number of tests: 14 16:12:10 INFO - PROCESS | 10930 | 16:12:10 INFO - PROCESS | 10930 | [#0] ai-astar Cycles:10 Average:111.10 Median:111.50 stddev:3.11 (2.8%) stddev-sans-first:1.32 16:12:10 INFO - PROCESS | 10930 | Values: 103.0 111.0 114.0 114.0 111.0 111.0 111.0 113.0 111.0 112.0 16:12:10 INFO - PROCESS | 10930 | 16:12:10 INFO - PROCESS | 10930 | [#1] audio-beat-detection Cycles:10 Average:131.80 Median:126.50 stddev:14.47 (11.4%) stddev-sans-first:14.87 16:12:10 INFO - PROCESS | 10930 | Values: 142.0 125.0 128.0 162.0 125.0 120.0 123.0 122.0 150.0 121.0 16:12:10 INFO - PROCESS | 10930 | 16:12:10 INFO - PROCESS | 10930 | [#2] audio-dft Cycles:10 Average:161.80 Median:162.00 stddev:1.23 (0.8%) stddev-sans-first:1.22 16:12:10 INFO - PROCESS | 10930 | Values: 163.0 161.0 161.0 163.0 160.0 161.0 164.0 162.0 162.0 161.0 16:12:10 INFO - PROCESS | 10930 | 16:12:10 INFO - PROCESS | 10930 | [#3] audio-fft Cycles:10 Average:82.00 Median:75.00 stddev:14.83 (19.8%) stddev-sans-first:15.45 16:12:10 INFO - PROCESS | 10930 | Values: 74.0 74.0 75.0 116.0 76.0 76.0 75.0 75.0 103.0 76.0 16:12:10 INFO - PROCESS | 10930 | 16:12:10 INFO - PROCESS | 10930 | [#4] audio-oscillator Cycles:10 Average:92.10 Median:82.00 stddev:16.48 (20.1%) stddev-sans-first:16.99 16:12:10 INFO - PROCESS | 10930 | Values: 81.0 82.0 123.0 83.0 83.0 83.0 104.0 82.0 82.0 118.0 16:12:10 INFO - PROCESS | 10930 | 16:12:10 INFO - PROCESS | 10930 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.67 16:12:10 INFO - PROCESS | 10930 | Values: 116.0 116.0 116.0 118.0 117.0 117.0 117.0 117.0 117.0 116.0 16:12:10 INFO - PROCESS | 10930 | 16:12:10 INFO - PROCESS | 10930 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 16:12:10 INFO - PROCESS | 10930 | Values: 147.0 148.0 146.0 147.0 147.0 147.0 147.0 147.0 146.0 146.0 16:12:10 INFO - PROCESS | 10930 | 16:12:10 INFO - PROCESS | 10930 | [#7] imaging-desaturate Cycles:10 Average:84.80 Median:85.00 stddev:0.92 (1.1%) stddev-sans-first:0.87 16:12:10 INFO - PROCESS | 10930 | Values: 86.0 86.0 86.0 84.0 84.0 84.0 85.0 84.0 85.0 84.0 16:12:10 INFO - PROCESS | 10930 | 16:12:10 INFO - PROCESS | 10930 | [#8] json-parse-financial Cycles:10 Average:55.20 Median:55.50 stddev:0.92 (1.7%) stddev-sans-first:0.53 16:12:10 INFO - PROCESS | 10930 | Values: 53.0 55.0 56.0 55.0 55.0 55.0 56.0 55.0 56.0 56.0 16:12:10 INFO - PROCESS | 10930 | 16:12:10 INFO - PROCESS | 10930 | [#9] json-stringify-tinderbox Cycles:10 Average:58.90 Median:59.00 stddev:0.74 (1.3%) stddev-sans-first:0.78 16:12:10 INFO - PROCESS | 10930 | Values: 59.0 59.0 59.0 59.0 60.0 58.0 58.0 59.0 58.0 60.0 16:12:10 INFO - PROCESS | 10930 | 16:12:10 INFO - PROCESS | 10930 | [#10] stanford-crypto-aes Cycles:10 Average:82.00 Median:83.00 stddev:3.46 (4.2%) stddev-sans-first:3.50 16:12:10 INFO - PROCESS | 10930 | Values: 79.0 83.0 80.0 83.0 89.0 83.0 79.0 86.0 79.0 79.0 16:12:10 INFO - PROCESS | 10930 | 16:12:10 INFO - PROCESS | 10930 | [#11] stanford-crypto-ccm Cycles:10 Average:137.50 Median:134.50 stddev:11.22 (8.3%) stddev-sans-first:11.86 16:12:10 INFO - PROCESS | 10930 | Values: 135.0 139.0 131.0 133.0 140.0 129.0 133.0 134.0 168.0 133.0 16:12:10 INFO - PROCESS | 10930 | 16:12:10 INFO - PROCESS | 10930 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.40 Median:166.50 stddev:3.69 (2.2%) stddev-sans-first:3.88 16:12:10 INFO - PROCESS | 10930 | Values: 166.0 175.0 167.0 164.0 170.0 165.0 165.0 172.0 165.0 165.0 16:12:10 INFO - PROCESS | 10930 | 16:12:10 INFO - PROCESS | 10930 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:67.00 stddev:2.58 (3.9%) stddev-sans-first:2.11 16:12:10 INFO - PROCESS | 10930 | Values: 72.0 66.0 65.0 68.0 69.0 66.0 66.0 65.0 65.0 71.0 16:12:10 INFO - PROCESS | 10930 | -------- Summary: end -------- 16:12:10 INFO - PROCESS | 10930 | 16:12:11 INFO - TEST-INFO | 10930: exit 0 16:12:11 INFO - TEST-OK | kraken | took 61266ms 16:12:11 INFO - SUITE-END | took 1179s 16:12:11 INFO - Completed test suite (00:19:39) 16:12:11 INFO - javascript benchmark 16:12:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3067.7085676860697, 3094.1491089950246, 3124.7812653114283, 3132.5457808617753, 3135.6550779414274, 5204.32343795307, 5270.920936185956, 5314.9468505314935, 5371.7045562494095, 5424.891502169954, 5332.14685650296, 5347.7058761768085, 5413.675179489223, 5423.240746295522, 5463.508284254416, 4848.6363522735755, 4875.561199492045, 4896.877578060559, 4902.264660300948, 4915.3364295819965, 4932.457429682732, 5007.098722229997, 5028.145215313387, 5031.195008798593, 5094.770735316901, 4939.185034469308, 4956.925646115311, 4998.375203099613, 5010.749462526859, 5050.671706339094, 4764.571188593043, 4791.808327666889, 4794.712317260975, 4818.686785358976, 4830.951690483085, 4767.332573439721, 4869.586085182764, 4882.170031094687, 4894.070126675921, 4899.779509922062, 5241.240020197089, 5333.866653333659, 5335.733213339317, 5336.30628018359, 5345.465453454663, 5695.487406133468, 5700.629459085146, 5708.115242137475, 5711.343195532525, 5787.739551720183, 5537.861553461155, 5592.5805564582815, 5686.545076393879, 5794.217780599607, 5800.158976948361, 5330.493603107738, 5348.251244825728, 5354.812581559627, 5357.0, 5422.105352616813, 5828.213191219216, 5829.47534721877, 5845.444682755132, 5847.298324201123, 5847.356790753014, 5428.212909128154, 5459.317585301837, 5579.358373786985, 5616.522595579339, 5619.353774316006, 5696.743646535916, 5729.512991395694, 5738.713064346766, 5782.855428614318, 5797.913031304533, 5715.771369145187, 5717.971410142923, 5724.570657200643, 5726.656400615893, 5751.338596061423, 5536.778528858881, 5553.222548843165, 5598.776048957996, 5714.914276285859, 5715.485606295453, 4357.172137293967, 4394.934075988863, 4413.293872980308, 4420.646348292129, 4472.195004899084, 3941.1329507508303, 3945.191235796655, 3954.2486927483687, 3986.242613903349, 4003.079291762853, 5208.479152084761, 5446.91829622556, 5447.4824891635235, 5448.564114870801, 5451.236826844245, 5622.437756224344, 5706.343770466367, 5740.225069615549, 5744.971275143597, 5837.0, 5443.319585051869, 5449.128139497661, 5450.345958485007, 5453.018456677836, 5453.672779633155, 5003.174476211384, 5011.646855349035, 5012.04771093491, 5012.1980483122525, 5071.061853557104, 5735.893483390516, 5846.649201047951, 5850.765969361263, 5898.115282707457, 5932.0, 5756.338021127456, 5760.423957604374, 5767.365589785204, 5770.826875193751, 5771.653700777967, 5915.171875937286, 5918.822435326947, 5925.733341999707, 5927.347991720821, 5928.970355148197, 5634.211210430625, 5679.233303503974, 5687.1753595729215, 5692.715364231689, 5697.601167918206, 5715.0, 5754.827355179351, 5764.625299355528, 5793.9420605795085, 5858.443447872445, 5651.321841378896, 5665.66006039639, 5665.886682266414, 5667.036603777286, 5673.319201695823, 5630.774769009194, 5638.26702528685, 5641.0, 5645.548356131418, 5652.660840349427, 5413.53984911287, 5449.373322067854, 5499.312585926759, 5529.032419326682, 5548.722563871871, 5660.29246344207, 5664.0654292043, 5669.603127781016, 5676.801311954062, 5680.943190568041, 5427.348718153847, 5436.456354364532, 5471.589630777628, 5471.9726401369335, 5528.668279903219], "value": 5290.0722008825005, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [607.8875408049511, 633.9936600633998, 635.6885126288118, 644.9097126402304, 651.238051479769, 31402.528962065586, 41628.0, 43199.0, 43417.78291108548, 46803.53196468034, 44575.55424445755, 44580.77709611456, 44886.77556612212, 45046.09907801842, 45141.00314451265, 7953.72161974331, 8822.735317940473, 8991.775205619879, 9000.909990900105, 9006.504642244674, 7847.921520784805, 8155.143709910463, 8167.714130005451, 10496.160307175407, 10819.350838949687, 10879.0, 10928.672139835779, 10934.671959841218, 10939.617113401033, 10946.288491248044, 10746.78506429867, 10750.408727519984, 10799.784004319908, 10856.565737370496, 10856.837147442755, 10516.579336826519, 10617.41604211768, 10625.309354891984, 10630.521626526825, 10632.30889992148, 41261.79369103165, 41344.37983430251, 41406.585934140574, 41495.37756933648, 41641.791791041156, 3267.526208699749, 3271.9836400817844, 3303.6861498157637, 3312.850921708529, 3369.22507823202, 30602.84698576515, 30860.38279234425, 31161.22096947572, 31339.216519587193, 33550.664493355, 4242.469691288589, 4274.508431530352, 4285.742855428684, 4297.720648157891, 4388.605025547684, 345304.0, 348121.0, 350163.0, 350391.0, 350553.0, 60767.69616151891, 62251.0, 62461.06308405378, 62519.0, 62605.93061450991, 34866.65133348685, 36052.639473604926, 36307.64000340022, 37955.81022094927, 37977.24045519074, 17051.91474042622, 17216.913915430592, 17228.310867565408, 17232.655346892992, 17234.91382543079, 11725.296482211095, 13014.479420823061, 13210.207387556777, 13219.537316194079, 13220.074594778465, 16892.817502774935, 18927.14827832751, 19400.57625474022, 19608.509787255432, 19649.607007859762, 7296.489245752852, 7415.2214017527385, 7593.0, 7624.237576242332, 7690.73082442123, 915.6337465013914, 938.5563730363863, 978.814025335184, 996.0985308296003, 1036.6630844975414, 31141.8442907784, 31608.525872111935, 31757.0, 31794.84102579472, 31906.361872762416, 1060.8939106089329, 1095.0965453500894, 1101.807183742858, 1126.3129491010477, 1165.2658824940233, 16507.752383714254, 16879.15604219784, 16992.405265815636, 17061.146942652817, 17273.65452690939, 481963.0, 482782.0, 483310.0, 486112.0, 486942.0, 58081.70959145177, 58554.12168817471, 58680.41319586835, 58977.70511147503, 59032.40967590355, 1208.238809549978, 1254.8368712067372, 1316.7827308494184, 1319.4656164253493, 1353.0461024977367, 28924.42151157007, 30591.847040764653, 32736.181595460304, 33227.0, 33687.32625347529, 51232.48767512277, 52096.21855672244, 52155.47844521506, 52167.2174917369, 52239.73880130575, 422178.33859937004, 432754.0, 433507.0, 433614.0, 433718.0, 42410.649761018474, 43009.56990430181, 43276.56723432851, 43736.56263437325, 43738.78130609327, 45514.77242613766, 46176.30735538902, 46572.0, 46598.30102548397, 46960.76519617517, 39842.2031559373, 39853.20293594054, 40352.79823600863, 41323.1735365297, 41608.58391416168, 39307.213855722155, 39469.80265098656, 40760.184796303314, 40803.0, 41634.79182604067, 39701.20597587974, 40228.597714022486, 40394.39408408818, 40593.797031015834, 41596.168076637696, 33963.49054764131, 35528.64471355357, 36336.27327453489, 36746.0, 36892.63107368999, 27087.72912270852, 28050.57924131099, 28067.29831754141, 28079.57880631833, 28089.297767555974], "value": 20262.991625208986, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [351.4341909525665, 369.0312184495714, 382.0849066485766, 382.453092078328, 401.3438028822874, 13959.232242226673, 17581.736273955885, 17949.371771987982, 18860.811391886076, 19045.80954190458, 17768.82231177688, 18419.815801841978, 18491.167897444615, 18808.717869231972, 19042.61914761704, 5529.115341545354, 5823.5341172706085, 5826.854328641797, 5828.184054232411, 5832.650040997553, 4183.267928112583, 4270.4234928284595, 4337.219300525904, 5744.052231381817, 5759.654420734749, 6274.654893980852, 6306.0, 6438.613683179001, 6442.0, 6448.161738973927, 5322.414534401193, 5551.833444996657, 5562.527185189264, 6428.357164283581, 6434.6782660867, 5462.5083742462975, 5478.698671573062, 5481.451854814526, 5482.23248745176, 5485.149801780731, 14586.708265834624, 21081.46748449091, 22092.0, 22314.442138946495, 22337.0, 2129.1909074551572, 2136.3484137338105, 2148.1836901977304, 2171.956560868774, 2881.927951801201, 9769.755756106084, 9878.160356369717, 9995.350302230405, 10414.843777343345, 10497.265191436603, 1850.3893715073993, 1964.8231659150745, 1976.2786582897284, 1977.149825575002, 1988.0954165854646, 83388.20712361604, 84132.15867841305, 84358.0, 84708.15291847065, 86060.70908936308, 10510.579576816841, 10626.787464250672, 10684.465776711133, 10741.355518668905, 10819.67540973772, 15132.394704211709, 15145.394184232728, 15170.848291517164, 15232.847671523365, 15254.771178432333, 7572.4699271051595, 7840.3335716464735, 7930.6431210595665, 7942.324902383362, 8197.262246397733, 7640.579768112696, 7640.923590764132, 7952.960235198787, 7954.363650907913, 7957.204279571996, 4449.975261256121, 4596.563326483979, 4633.907321853611, 4704.929426058612, 4748.335233067304, 1843.1200175820588, 1885.9528511787314, 1925.4416219296247, 1938.331275709878, 1941.213808407597, 871.9258862996717, 973.5757962672893, 986.3095832916844, 1004.0612027754073, 1030.9175265978704, 17650.5587360317, 18208.45374638763, 19267.614647707247, 19304.806951930303, 19708.901455492633, 960.5053397500293, 963.272729089533, 976.3946353260882, 1009.7828966772179, 1032.6282538286212, 10418.426986515815, 10942.124630029579, 10944.452777361259, 10958.890411095947, 11097.611583594535, 437631.0, 442456.0, 449792.0, 453576.0, 455153.0, 91386.54306728557, 92965.53517232371, 93382.0, 94554.5272273648, 95545.52227238819, 1059.2003037706481, 1067.1889364083509, 1087.2769608210451, 1092.3500517192258, 1103.7902798468265, 16253.349866005228, 16274.67450651004, 16707.49877503677, 17106.657866842346, 17184.742228866326, 41504.58495415007, 42768.78615606902, 42848.78575607102, 43738.78130609327, 44310.03136675135, 58158.4184158153, 58354.7082264586, 59239.70380148072, 60014.0, 60735.69632151811, 8008.359331253602, 8015.398845086758, 8096.190380961857, 8263.256306932404, 8273.669053238043, 10728.195385346286, 12243.510259589517, 12428.56500022495, 13032.218066916015, 13045.543405980745, 10822.0, 11182.776344472903, 11224.607138750105, 11303.604373846876, 11776.941115294369, 10885.727856803644, 10968.0, 11166.776664466828, 11417.885821141683, 11590.0, 11090.112790976864, 11263.324200547993, 11413.201075924937, 11452.0, 11565.479553419947, 8163.591820409075, 8178.427510074475, 8253.79365515867, 8330.791730206793, 8433.493990360597, 10275.0, 11305.660830175108, 11342.489587968726, 11432.14258930567, 11875.287482751062], "value": 9023.803679271647, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1308.6401239659099, 1457.9125252484848, 1493.2608358862362, 1611.411834680342, 1766.2758269109668, 7512.399008079355, 8512.106228845967, 8797.86803197951, 8801.823963520734, 8978.416402933804, 8794.6921857735, 8856.0, 8859.911400885989, 8861.512616806072, 8862.77843053924, 2269.8524595901254, 2273.227102785053, 2299.8275129365366, 2303.239930822833, 2309.4688221709016, 2226.053927080984, 2288.439332363573, 2296.9540609187807, 2298.6322188449853, 2307.1348244408346, 2235.094786611417, 2282.5206706591553, 2291.9885400572975, 2293.5183611441616, 2293.575688497625, 2205.3163519308987, 2212.6570381590877, 2214.9446263843533, 2233.4416395901026, 2233.4416395901026, 2203.0857194264363, 2217.401301648546, 2220.555888822242, 2226.421130506064, 2229.141780414536, 8678.175573320525, 8822.0, 8881.511516866569, 8926.285897128279, 8937.106289371011, 5202.531772140488, 5377.7311134443125, 5378.924215156984, 5388.488093631099, 5404.054290499147, 3167.952480712791, 3176.952345714816, 3182.403646091341, 3237.983810080958, 3238.951415728766, 927.3030354451338, 932.7854593443478, 941.6092321686492, 944.3531181140941, 952.885653721551, 12338.0, 12419.31693756843, 12424.130310878241, 12434.564790232389, 12455.75088498225, 4392.494863090722, 4467.061916997467, 4500.279955207151, 4518.796654150571, 4572.154151481986, 9800.460974646463, 9815.312928094965, 9817.656382026595, 9823.803523929482, 9827.4103553787, 5257.7896884124975, 5262.578993680497, 5264.947350526522, 5267.947320526746, 5269.262303277545, 4372.562743725602, 4402.801873915681, 4881.585065269492, 4914.066327397783, 4942.20924652054, 3597.4963505109304, 3717.182219911615, 3751.793651349202, 3766.4388216013376, 3836.8848934532007, 1109.4785450838094, 1114.587602587048, 1118.972025699364, 1120.5181771838024, 1123.1239633086207, 770.2143813310392, 839.5969934431507, 878.5563290538365, 889.4440974391006, 899.0470101692227, 5235.31940847695, 5282.788688452496, 5401.405845357008, 5424.945750542444, 5445.891082178334, 426.88474111989586, 428.7330937080918, 428.78775006372047, 428.95067067287664, 429.7249760153504, 3662.6337366263692, 3668.0, 3669.339518886626, 3680.8343624536424, 3783.319002579507, 10798.0, 11130.220884538005, 11224.326540407601, 11241.21311508203, 11252.943735281271, 11132.332060076422, 11161.274517156358, 11171.66485005451, 11179.44102794857, 11184.776304473866, 7763.9223607764325, 8249.587520624065, 8254.05078415978, 8380.240149568537, 8391.832163356821, 5600.131979543177, 5624.971875140598, 5677.687727175045, 5743.942560574508, 5881.147233651182, 9590.472524011246, 10053.346532475365, 10148.340357876714, 10228.64199753005, 10241.129503992244, 10199.28604997643, 10311.690649280534, 10335.22485813582, 10430.843537347098, 10435.582576696846, 7107.857842843011, 7358.484906056525, 7677.347425468898, 7884.448088633741, 8000.119986801331, 8587.398882078194, 8698.43460175112, 8699.13008699125, 8710.47737135774, 8721.869171962298, 7606.695732170872, 7642.885356719765, 7762.184970578234, 7836.764897053097, 7876.369890408639, 7359.4480413968095, 7574.431917606092, 7590.7722768317035, 7634.50375725576, 7735.071791385069, 6609.834754130993, 6731.966340168267, 6737.326267373223, 6738.0, 6740.090087838079, 4595.0, 4635.304704294383, 4729.432468103712, 4745.715257084586, 4779.784909679003, 4577.404937358122, 4596.6322694185055, 4663.626909847272, 4670.696404733681, 4812.975935120442], "value": 4392.086464571415, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [303.5522604158866, 306.19928885963196, 310.41022058089635, 316.4825510290674, 318.13308733700654, 5056.974715126428, 5192.480751924811, 5209.218617207421, 5268.68387896726, 5271.868203294919, 5075.543201111899, 5151.124308867502, 5164.225366195073, 5172.6379153459175, 5235.0, 4115.691323150761, 4118.505779306487, 4120.443740095079, 4121.752694838305, 4138.620293331339, 3868.400397938324, 4057.316213771296, 4128.50457945047, 4129.648979836717, 4129.9174016519655, 4036.374361973899, 4046.5953404659595, 4046.8178931947987, 4047.7773722445254, 4053.5946405359523, 4023.6378725914515, 4032.475778148822, 4034.536028356747, 4038.415414134971, 4051.858184963512, 3524.665156810099, 3525.823708814549, 3552.7335449841366, 3562.287542491512, 3563.3051554946796, 4836.975815120937, 5042.218456139304, 5055.292259083732, 5077.619178561586, 5097.949020509822, 4597.172508948388, 4605.355250264965, 4607.378003969455, 4615.723056616614, 4616.76916154191, 5449.618526703132, 5450.56395488364, 5459.645123067027, 5459.843361872078, 5468.562514998791, 3770.8868733938025, 3824.9043773905596, 3828.1960788234505, 3828.693704503633, 3845.711571632111, 5559.552358113493, 5596.888062238773, 5602.702891814377, 5625.915611265793, 5630.352509461423, 3927.5286965564314, 3934.1738234970976, 3940.0, 3940.566537680853, 3943.684505239574, 3894.6300101490315, 3982.203559288154, 3985.2228815381304, 3993.1249500359695, 4011.859584914514, 4616.976915115403, 4622.249761391967, 4623.468301145412, 4641.814327426932, 4650.0, 5521.668699878021, 5537.920105579374, 5539.19681646159, 5553.500184983371, 5562.499375056264, 1319.1689235781396, 1348.9325533723274, 1351.2635613590617, 1371.9314034298245, 1376.4287820554557, 891.1088911088912, 925.1904583489446, 928.211020632457, 932.4451951089092, 935.9719208423758, 5244.374243984377, 5245.318108645852, 5247.553957913544, 5250.842474725764, 5264.684118952875, 5432.239486471897, 5513.2005859151, 5546.500814926676, 5550.639208451437, 5562.360328562268, 5014.6740461870595, 5191.506806853343, 5235.293235413246, 5249.842504724865, 5252.133397989365, 2608.4652646207483, 2624.278323461025, 2635.4465562231762, 2643.035292118363, 2669.27929459045, 4990.554628232213, 4997.950020499821, 5011.749412529359, 5018.644965859271, 5047.04747722579, 4686.6408741465275, 4972.8173968660085, 4989.727619457015, 4995.400551933792, 5013.997200559829, 4960.553550180501, 4994.775235114428, 5037.926864612657, 5039.571636410946, 5046.21783623539, 4835.274708793569, 4869.860618474268, 4880.048390563806, 4926.940707747852, 4932.0, 4843.854684359475, 4845.63657725665, 5164.922526162186, 5587.972060139836, 5614.606977511535, 5765.682887441063, 5769.769209231584, 5778.855528611818, 5779.422057794187, 5784.4504772046585, 3936.4292177634657, 3939.4878665773267, 3940.625640564142, 3963.900902477461, 3968.8412463501136, 5377.193420986883, 5451.536619387238, 5589.245451863946, 5641.9435805641415, 5651.802186923438, 5377.838664840061, 5424.864378390572, 5562.41224410245, 5572.913281909989, 5577.27495425592, 5518.2826232589505, 5524.0, 5540.418256083053, 5540.833774986757, 5547.2233887256625, 5263.421023687468, 5435.83692489226, 5457.235986961908, 5464.480874316933, 5467.0, 5513.173024046425, 5559.861003474945, 5560.138178582326, 5575.77696892136, 5600.747966341443, 5469.644473109394, 5470.398256191896, 5471.261379713687, 5473.890522189454, 5482.205080263259], "value": 4069.192445334142, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [613.3470297548108, 621.260699767277, 666.7999600119969, 681.6216999565246, 743.0785825576284, 15475.61310967225, 15534.922325388385, 15541.378344866192, 15585.844141558595, 16077.276522556484, 16323.59191020225, 16526.586835329123, 16544.66910661789, 16622.58443538909, 16694.666106677858, 672.3243140643647, 689.0, 787.401574803148, 799.8600244957124, 817.2562967699395, 804.2600807257309, 806.5765473126626, 806.7821688144197, 807.1645846548823, 807.2815194476921, 845.6575087089708, 846.6571038729325, 856.6616186606287, 857.1385757313922, 857.9613917373733, 697.4385619576265, 715.4812760748416, 820.729159377404, 852.6972924611736, 852.8336974290016, 592.6888383598603, 598.2641351138125, 598.8143675460577, 599.2958274028, 614.5483069943632, 15955.601109972344, 16006.439774607948, 16022.919885400615, 16039.679206415807, 16041.35834566616, 13869.306534673327, 14122.435102595884, 14437.71124577513, 14502.709945801025, 14589.92705036468, 13166.970585903422, 13344.399502022336, 13380.0, 13478.663033424145, 13829.377678004514, 4259.91480170398, 4340.782960851976, 4448.088141930929, 4470.9122271545575, 4471.1728330259, 76860.61569692116, 77839.6108019462, 77857.61071194608, 78578.60710696467, 78647.21352786514, 10633.415162166155, 10923.726906827234, 11239.494222759995, 11417.48621312043, 11472.31166130035, 20569.58860822775, 20708.79291207099, 20709.0680919359, 20712.17151313961, 21258.36224913255, 7524.548527088392, 7631.275028872248, 7633.160352361236, 7749.457537972288, 7797.103333116651, 4346.8043938022865, 4448.0, 4477.8208871644765, 4514.074614703978, 4535.7732113394195, 3359.5800524934384, 3465.8093804840473, 3476.947845782315, 3478.4434490481403, 3478.617352091268, 544.064209559557, 545.5526468296039, 549.8268045565634, 565.2877374508149, 621.9067139929047, 637.1875858280637, 650.7982525417136, 655.429776094791, 662.192125606759, 684.5721424109931, 9203.76990575241, 9258.90741092594, 9352.251819854395, 9498.82051897163, 9760.233830622457, 555.7702023954569, 628.5097623853402, 632.1339764522634, 652.3443938841434, 663.4857985061616, 4523.638108951276, 4671.976640116778, 4730.9763451182525, 4761.857144285677, 4820.4456487504385, 113970.43014784873, 118968.0, 120511.0, 122332.0, 122363.0, 99298.0, 101465.0, 103055.4847225759, 104615.0, 110632.0, 91931.54034229786, 92322.0, 93100.0, 93927.99999999863, 94488.52755736315, 8588.957055214683, 8770.91229087701, 8834.249088827264, 8907.10928907104, 8923.202924461475, 52098.479015210876, 52294.73852630713, 52824.0, 53154.73422632862, 53758.0, 65870.0, 70892.29107708856, 70996.29003709897, 71690.28309717045, 72374.27625723675, 12978.480860765841, 13010.609681709564, 13043.739125217253, 13392.665183370103, 13438.865611343761, 14287.57137285883, 14453.0, 14692.118472891661, 14974.401023958919, 15012.099274043592, 13817.516386926409, 13840.377183026989, 13918.16491010502, 13934.860651393356, 14787.92606036963, 13212.471501139848, 13298.933505332412, 13413.329333533089, 13421.597352079454, 14106.153630782186, 12739.55411560628, 13252.734945300846, 13507.932460337635, 13814.447422103405, 14336.713265734836, 10933.617323393642, 11160.386178760245, 11301.15241356885, 11705.824412633647, 11782.52869885195, 11397.544148048784, 11579.131565132817, 11817.763644727229, 11831.34927578957, 11912.940435298115], "value": 7500.171394797363, "unit": "score"}], "name": "dromaeo_css", "value": 7114.466397180133, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 111.0, 114.0, 114.0, 111.0, 111.0, 111.0, 113.0, 111.0, 112.0], "value": 111.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 125.0, 128.0, 162.0, 125.0, 120.0, 123.0, 122.0, 150.0, 121.0], "value": 131.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 161.0, 163.0, 160.0, 161.0, 164.0, 162.0, 162.0, 161.0], "value": 161.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 75.0, 116.0, 76.0, 76.0, 75.0, 75.0, 103.0, 76.0], "value": 82.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 123.0, 83.0, 83.0, 83.0, 104.0, 82.0, 82.0, 118.0], "value": 92.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 116.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 146.0, 147.0, 147.0, 147.0, 147.0, 147.0, 146.0, 146.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 86.0, 84.0, 84.0, 84.0, 85.0, 84.0, 85.0, 84.0], "value": 84.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 55.0, 56.0, 55.0, 55.0, 55.0, 56.0, 55.0, 56.0, 56.0], "value": 55.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 59.0, 59.0, 60.0, 58.0, 58.0, 59.0, 58.0, 60.0], "value": 58.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 83.0, 80.0, 83.0, 89.0, 83.0, 79.0, 86.0, 79.0, 79.0], "value": 82.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 139.0, 131.0, 133.0, 140.0, 129.0, 133.0, 134.0, 168.0, 133.0], "value": 137.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 175.0, 167.0, 164.0, 170.0, 165.0, 165.0, 172.0, 165.0, 165.0], "value": 167.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 66.0, 65.0, 68.0, 69.0, 66.0, 66.0, 65.0, 65.0, 71.0], "value": 67.3, "unit": "score"}], "name": "kraken", "value": 1495.4000000000003, "alertThreshold": 2.0}]} 16:12:11 INFO - Return code: 0 16:12:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:12:11 INFO - # TBPL SUCCESS # 16:12:11 INFO - Running post-action listener: _resource_record_post_action 16:12:11 INFO - [mozharness: 2016-10-19 23:12:11.863898Z] Finished run-tests step (success) 16:12:11 INFO - Running post-run listener: _resource_record_post_run 16:12:11 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 425984; Write bytes: 395333632; Read time: 56; Write time: 259504 16:12:11 INFO - TinderboxPrint: CPU usage
13.1% 16:12:11 INFO - TinderboxPrint: I/O read bytes / time
425,984 / 56 16:12:11 INFO - TinderboxPrint: I/O write bytes / time
395,333,632 / 259,504 16:12:11 INFO - TinderboxPrint: CPU idle
8,300.6 (86.9%) 16:12:11 INFO - TinderboxPrint: CPU user
1,200.2 (12.6%) 16:12:11 INFO - TinderboxPrint: Swap in / out
0 / 0 16:12:11 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 103829504; Read time: 0; Write time: 84836 16:12:11 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 421888; Write bytes: 287920128; Read time: 40; Write time: 173912 16:12:12 INFO - Running post-run listener: _upload_blobber_files 16:12:12 INFO - Blob upload gear active. 16:12:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:12:12 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 16:12:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:12:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:12:12 INFO - (blobuploader) - INFO - Open directory for files ... 16:12:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:12:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:12:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:12:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:12:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:12:13 INFO - (blobuploader) - INFO - Done attempting. 16:12:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:12:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:12:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:12:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:12:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:12:14 INFO - (blobuploader) - INFO - Done attempting. 16:12:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:12:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:12:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:12:17 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:12:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:12:17 INFO - (blobuploader) - INFO - Done attempting. 16:12:17 INFO - (blobuploader) - INFO - Iteration through files over. 16:12:17 INFO - Return code: 0 16:12:17 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:12:17 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:12:17 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b6e4e930c94eb7c577b1d1087b5ab0ce573e169ae97cc67868abb3f5ff6e81a735e6888ea2ee93370f948656afb2d8035461b233dd1332632a10307880a56199", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7ef8f8bd2fbf9657b6e636ad4928dcc255cbf595eb55c9c84421b0a68ff1646083537a8eb80e0a876427a9abe5c0a0cd72460c33002def3881cbfdce66fbb72e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1dc0d52d03f40820116838764f4a71add0268f7cfbdf976ea64f1b758bb66829fdfff8d45a09ad13038873c8caf2e756d76b98ee208e9a246f782c7534a2ddc1"} 16:12:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:12:17 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:12:17 INFO - Contents: 16:12:17 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b6e4e930c94eb7c577b1d1087b5ab0ce573e169ae97cc67868abb3f5ff6e81a735e6888ea2ee93370f948656afb2d8035461b233dd1332632a10307880a56199", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7ef8f8bd2fbf9657b6e636ad4928dcc255cbf595eb55c9c84421b0a68ff1646083537a8eb80e0a876427a9abe5c0a0cd72460c33002def3881cbfdce66fbb72e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1dc0d52d03f40820116838764f4a71add0268f7cfbdf976ea64f1b758bb66829fdfff8d45a09ad13038873c8caf2e756d76b98ee208e9a246f782c7534a2ddc1"} 16:12:17 INFO - Running post-run listener: copy_logs_to_upload_dir 16:12:17 INFO - Copying logs to upload dir... 16:12:17 INFO - mkdir: /builds/slave/test/build/upload/logs 16:12:17 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.027018 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-10-19 16:12:17.681548) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-19 16:12:17.685128) ========= 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=6d15e502d8e29d5d2676d664000001c3-1476917498.461722-1957287578 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/b6e4e930c94eb7c577b1d1087b5ab0ce573e169ae97cc67868abb3f5ff6e81a735e6888ea2ee93370f948656afb2d8035461b233dd1332632a10307880a56199", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7ef8f8bd2fbf9657b6e636ad4928dcc255cbf595eb55c9c84421b0a68ff1646083537a8eb80e0a876427a9abe5c0a0cd72460c33002def3881cbfdce66fbb72e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1dc0d52d03f40820116838764f4a71add0268f7cfbdf976ea64f1b758bb66829fdfff8d45a09ad13038873c8caf2e756d76b98ee208e9a246f782c7534a2ddc1"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476905443/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011559 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476905443/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/b6e4e930c94eb7c577b1d1087b5ab0ce573e169ae97cc67868abb3f5ff6e81a735e6888ea2ee93370f948656afb2d8035461b233dd1332632a10307880a56199", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7ef8f8bd2fbf9657b6e636ad4928dcc255cbf595eb55c9c84421b0a68ff1646083537a8eb80e0a876427a9abe5c0a0cd72460c33002def3881cbfdce66fbb72e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1dc0d52d03f40820116838764f4a71add0268f7cfbdf976ea64f1b758bb66829fdfff8d45a09ad13038873c8caf2e756d76b98ee208e9a246f782c7534a2ddc1"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-19 16:12:17.715146) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 16:12:17.715955) ========= 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=6d15e502d8e29d5d2676d664000001c3-1476917498.461722-1957287578 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004737 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 16:12:17.798321) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-19 16:12:17.799066) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-19 16:12:17.799723) ========= ========= Total master_lag: 0.17 =========