builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-043 starttime: 1477859543.96 results: success (0) buildid: 20161030130419 builduid: ba807d31f7614f9ab488ba93749e73b9 revision: 1b170b39ed6bdbde366233ab84594bdaaa960a5a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-30 13:32:23.962764) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-30 13:32:23.963200) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-30 13:32:23.963484) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-30 13:32:23.978188) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-30 13:32:23.978502) ========= 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=d2a8c569965ab8367867b893000001a1-1477859543.255758-352965245 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-30 13:32:24-- 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% 47.8K=0.2s 2016-10-30 13:32:24 (47.8 KB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.336419 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-30 13:32:24.328821) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-30 13:32:24.329207) ========= 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=d2a8c569965ab8367867b893000001a1-1477859543.255758-352965245 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015183 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-30 13:32:24.379278) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-30 13:32:24.379634) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 1b170b39ed6bdbde366233ab84594bdaaa960a5a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 1b170b39ed6bdbde366233ab84594bdaaa960a5a --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=d2a8c569965ab8367867b893000001a1-1477859543.255758-352965245 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-30 13:32:24,574 truncating revision to first 12 chars 2016-10-30 13:32:24,574 Setting DEBUG logging. 2016-10-30 13:32:24,574 attempt 1/10 2016-10-30 13:32:24,574 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/1b170b39ed6b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-30 13:32:25,231 unpacking tar archive at: fx-team-1b170b39ed6b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.986028 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-30 13:32:25.378954) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-30 13:32:25.379252) ========= script_repo_revision: 1b170b39ed6bdbde366233ab84594bdaaa960a5a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-30 13:32:25.379654) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-30 13:32:25.379913) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-30 13:32:25.389344) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-10-30 13:32:25.389726) ========= /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=d2a8c569965ab8367867b893000001a1-1477859543.255758-352965245 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:32:25 INFO - MultiFileLogger online at 20161030 13:32:25 in /builds/slave/test 13:32:25 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 13:32:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:32:25 INFO - {'append_to_log': False, 13:32:25 INFO - 'base_work_dir': '/builds/slave/test', 13:32:25 INFO - 'blob_upload_branch': 'Fx-Team', 13:32:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:32:25 INFO - 'branch': 'Fx-Team', 13:32:25 INFO - 'buildbot_json_path': 'buildprops.json', 13:32:25 INFO - 'config_files': ('talos/linux_config.py',), 13:32:25 INFO - 'default_actions': ('clobber', 13:32:25 INFO - 'read-buildbot-config', 13:32:25 INFO - 'download-and-extract', 13:32:25 INFO - 'populate-webroot', 13:32:25 INFO - 'create-virtualenv', 13:32:25 INFO - 'install', 13:32:25 INFO - 'run-tests'), 13:32:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:32:25 INFO - 'download_minidump_stackwalk': True, 13:32:25 INFO - 'download_symbols': 'ondemand', 13:32:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:32:25 INFO - 'tooltool.py': '/tools/tooltool.py', 13:32:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:32:25 INFO - '/tools/misc-python/virtualenv.py')}, 13:32:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:32:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:32:25 INFO - 'installer_path': 'installer.exe', 13:32:25 INFO - 'log_level': 'info', 13:32:25 INFO - 'log_name': 'talos', 13:32:25 INFO - 'log_to_console': True, 13:32:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:32:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:32:25 INFO - 'opt_config_files': (), 13:32:25 INFO - 'pip_index': False, 13:32:25 INFO - 'sps_profile': False, 13:32:25 INFO - 'sps_profile_interval': 0, 13:32:25 INFO - 'suite': 'dromaeojs', 13:32:25 INFO - 'system_bits': '32', 13:32:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:32:25 INFO - 'title': 'talos-linux64-ix-043', 13:32:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:32:25 INFO - 'use_talos_json': True, 13:32:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:32:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:32:25 INFO - 'work_dir': 'build'} 13:32:25 INFO - [mozharness: 2016-10-30 20:32:25.683509Z] Running clobber step. 13:32:25 INFO - Running pre-action listener: _resource_record_pre_action 13:32:25 INFO - Running main action method: clobber 13:32:25 INFO - rmtree: /builds/slave/test/build 13:32:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:32:26 INFO - Running post-action listener: _resource_record_post_action 13:32:26 INFO - [mozharness: 2016-10-30 20:32:26.139014Z] Finished clobber step (success) 13:32:26 INFO - [mozharness: 2016-10-30 20:32:26.139113Z] Running read-buildbot-config step. 13:32:26 INFO - Running pre-action listener: _resource_record_pre_action 13:32:26 INFO - Running main action method: read_buildbot_config 13:32:26 INFO - Using buildbot properties: 13:32:26 INFO - { 13:32:26 INFO - "project": "", 13:32:26 INFO - "product": "firefox", 13:32:26 INFO - "script_repo_revision": "production", 13:32:26 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 13:32:26 INFO - "repository": "", 13:32:26 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 13:32:26 INFO - "buildid": "20161030130419", 13:32:26 INFO - "stage_platform": "linux64-pgo", 13:32:26 INFO - "basedir": "/builds/slave/test", 13:32:26 INFO - "buildnumber": 1174, 13:32:26 INFO - "platform": "ubuntu64_hw", 13:32:26 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 13:32:26 INFO - "slavebuilddir": "test", 13:32:26 INFO - "branch": "fx-team", 13:32:26 INFO - "revision": "1b170b39ed6bdbde366233ab84594bdaaa960a5a", 13:32:26 INFO - "slavename": "talos-linux64-ix-043", 13:32:26 INFO - "builduid": "ba807d31f7614f9ab488ba93749e73b9", 13:32:26 INFO - "repo_path": "integration/fx-team" 13:32:26 INFO - } 13:32:26 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477747962/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 13:32:26 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477747962/firefox-52.0a1.en-US.linux-x86_64.test_packages.json. 13:32:26 INFO - Running post-action listener: _resource_record_post_action 13:32:26 INFO - [mozharness: 2016-10-30 20:32:26.141482Z] Finished read-buildbot-config step (success) 13:32:26 INFO - [mozharness: 2016-10-30 20:32:26.141569Z] Running download-and-extract step. 13:32:26 INFO - Running pre-action listener: _resource_record_pre_action 13:32:26 INFO - Running main action method: download_and_extract 13:32:26 INFO - mkdir: /builds/slave/test/build/tests 13:32:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:32:26 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477747962/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 13:32:26 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477747962/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 13:32:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477747962/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 13:32:26 INFO - Downloaded 1361 bytes. 13:32:26 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 13:32:26 INFO - Using the following test package requirements: 13:32:26 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 13:32:26 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:32:26 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:32:26 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:32:26 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:32:26 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:32:26 INFO - u'jsshell-linux-x86_64.zip'], 13:32:26 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:32:26 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:32:26 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 13:32:26 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:32:26 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:32:26 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:32:26 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:32:26 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:32:26 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:32:26 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:32:26 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:32:26 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:32:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477747962/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 13:32:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477747962/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:32:26 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477747962/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 13:32:26 INFO - Http code: 200 13:32:26 INFO - via: 1.1 032d42677fbf05c24a4bb71369581429.cloudfront.net (CloudFront) 13:32:26 INFO - x-amz-cf-id: p7YFsNPB7cgQ0kAoY2KQptaapeyLpLGI1V1FsuY781Vy4dd28ZlTbg== 13:32:26 INFO - x-amz-replication-status: PENDING 13:32:26 INFO - x-amz-version-id: osZ4AQHSLmYHTnKNoyV3cZDRYrTso.BD 13:32:26 INFO - Expected file size: 22006612 13:32:26 INFO - Obtained file size: 22006612 13:32:30 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 13:32:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477747962/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 13:32:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477747962/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:32:30 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477747962/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 13:32:30 INFO - Http code: 200 13:32:30 INFO - via: 1.1 20f1c35f343f4b271ae8dcacfd7ea0e9.cloudfront.net (CloudFront) 13:32:30 INFO - x-amz-cf-id: _KINB38zgkf0KZl0-bO8DNcQmciuGL19IQWtQiACnGLXtJD2YjXg2Q== 13:32:30 INFO - x-amz-replication-status: PENDING 13:32:30 INFO - x-amz-version-id: osZ4AQHSLmYHTnKNoyV3cZDRYrTso.BD 13:32:31 INFO - Expected file size: 22006612 13:32:31 INFO - Obtained file size: 22006612 13:32:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477747962/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 13:32:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477747962/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 13:32:35 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477747962/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 13:32:35 INFO - Http code: 200 13:32:35 INFO - via: 1.1 bb8a7ff26b131d51953dc2d3e19a2751.cloudfront.net (CloudFront) 13:32:35 INFO - x-amz-cf-id: gbDvwfhrz95vYOnf194YTpOF2SUz57JkYYzwMdNtR2dH9I2Bjlsgug== 13:32:35 INFO - x-amz-replication-status: PENDING 13:32:35 INFO - x-amz-version-id: OEkE0NHKtrItDByKteAlalVk7PCLvBv7 13:32:35 INFO - Expected file size: 14409038 13:32:35 INFO - Obtained file size: 14409038 13:32:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:32:36 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477747962/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 13:32:36 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477747962/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 13:32:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477747962/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 13:32:36 INFO - Downloaded 59632139 bytes. 13:32:36 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477747962/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 13:32:36 INFO - mkdir: /builds/slave/test/properties 13:32:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:32:36 INFO - Writing to file /builds/slave/test/properties/build_url 13:32:36 INFO - Contents: 13:32:36 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477747962/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 13:32:37 INFO - Running post-action listener: _resource_record_post_action 13:32:37 INFO - Running post-action listener: set_extra_try_arguments 13:32:37 INFO - [mozharness: 2016-10-30 20:32:37.151438Z] Finished download-and-extract step (success) 13:32:37 INFO - [mozharness: 2016-10-30 20:32:37.151664Z] Running populate-webroot step. 13:32:37 INFO - Running pre-action listener: _resource_record_pre_action 13:32:37 INFO - Running main action method: populate_webroot 13:32:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:32:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:32:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:32:37 INFO - '--tppagecycles', 13:32:37 INFO - '7'], 13:32:37 INFO - 'tests': ['tsvgm']}}, 13:32:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:32:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:32:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:32:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:32:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:32:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:32:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:32:37 INFO - 'talos_options': ['--disable-e10s'], 13:32:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:32:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:32:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:32:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:32:37 INFO - 'talos_options': ['--disable-e10s'], 13:32:37 INFO - 'tests': ['damp', 'tps']}, 13:32:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:32:37 INFO - 'tests': ['damp', 'tps']}, 13:32:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:32:37 INFO - 'tests': ['dromaeo_dom']}, 13:32:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:32:37 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:32:37 INFO - 'tests': ['basic_compositor_video']}, 13:32:37 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:32:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:32:37 INFO - 'tests': ['a11yr', 13:32:37 INFO - 'ts_paint', 13:32:37 INFO - 'tpaint', 13:32:37 INFO - 'sessionrestore', 13:32:37 INFO - 'sessionrestore_no_auto_restore', 13:32:37 INFO - 'tabpaint']}, 13:32:37 INFO - 'other-e10s': {'tests': ['a11yr', 13:32:37 INFO - 'ts_paint', 13:32:37 INFO - 'tpaint', 13:32:37 INFO - 'sessionrestore', 13:32:37 INFO - 'sessionrestore_no_auto_restore', 13:32:37 INFO - 'tabpaint']}, 13:32:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:32:37 INFO - 'ts_paint', 13:32:37 INFO - 'tpaint', 13:32:37 INFO - 'sessionrestore', 13:32:37 INFO - 'sessionrestore_no_auto_restore', 13:32:37 INFO - 'tabpaint']}, 13:32:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:32:37 INFO - 'ts_paint', 13:32:37 INFO - 'tpaint', 13:32:37 INFO - 'sessionrestore', 13:32:37 INFO - 'sessionrestore_no_auto_restore', 13:32:37 INFO - 'tabpaint']}, 13:32:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:32:37 INFO - 'tests': ['a11yr', 13:32:37 INFO - 'ts_paint', 13:32:37 INFO - 'tpaint', 13:32:37 INFO - 'sessionrestore', 13:32:37 INFO - 'sessionrestore_no_auto_restore', 13:32:37 INFO - 'tabpaint']}, 13:32:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:32:37 INFO - 'tests': ['a11yr', 13:32:37 INFO - 'ts_paint', 13:32:37 INFO - 'tpaint', 13:32:37 INFO - 'sessionrestore', 13:32:37 INFO - 'sessionrestore_no_auto_restore', 13:32:37 INFO - 'tabpaint']}, 13:32:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:32:37 INFO - 'tests': ['tsvgx', 13:32:37 INFO - 'tsvgr_opacity', 13:32:37 INFO - 'tart', 13:32:37 INFO - 'tscrollx', 13:32:37 INFO - 'cart']}, 13:32:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:32:37 INFO - 'tsvgr_opacity', 13:32:37 INFO - 'tart', 13:32:37 INFO - 'tscrollx', 13:32:37 INFO - 'cart']}, 13:32:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:32:37 INFO - 'talos_options': ['--disable-e10s'], 13:32:37 INFO - 'tests': ['tp5o']}, 13:32:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:32:37 INFO - 'tests': ['tp5o']}, 13:32:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:32:37 INFO - 'talos_options': ['--disable-e10s', 13:32:37 INFO - '--xperf_path', 13:32:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:32:37 INFO - 'tests': ['tp5n']}, 13:32:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:32:37 INFO - 'talos_options': ['--xperf_path', 13:32:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:32:37 INFO - 'tests': ['tp5n']}}, 13:32:37 INFO - 'talos.zip': {'path': '', 13:32:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:32:37 INFO - Running post-action listener: _resource_record_post_action 13:32:37 INFO - [mozharness: 2016-10-30 20:32:37.173053Z] Finished populate-webroot step (success) 13:32:37 INFO - [mozharness: 2016-10-30 20:32:37.173140Z] Running create-virtualenv step. 13:32:37 INFO - Running pre-action listener: _resource_record_pre_action 13:32:37 INFO - Running main action method: create_virtualenv 13:32:37 INFO - Creating virtualenv /builds/slave/test/build/venv 13:32:37 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 13:32:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:32:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:32:37 INFO - Using real prefix '/usr' 13:32:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:32:37 INFO - Installing distribute.............................................................................................................................................................................................done. 13:32:39 INFO - Installing pip.................done. 13:32:39 INFO - Return code: 0 13:32:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 13:32:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 13:32:39 INFO - Reading from file tmpfile_stdout 13:32:39 INFO - Output received: 13:32:39 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) 13:32:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:32:39 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')]} 13:32:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:32:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:39 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')]} 13:32:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:32:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:39 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 0x7f41e8daff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x204c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21187b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a7790>, '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 0x21a8690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a8b20>, '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': 'd2a8c569965ab8367867b893000001a1-1477859543.255758-352965245', '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 13:32:39 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 13:32:39 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 13:32:39 INFO - Using env: {'DISPLAY': ':0', 13:32:39 INFO - 'HOME': '/home/cltbld', 13:32:39 INFO - 'LANG': 'en_US.UTF-8', 13:32:39 INFO - 'LANGUAGE': 'en_US:en', 13:32:39 INFO - 'LOGNAME': 'cltbld', 13:32:39 INFO - 'MAIL': '/var/mail/cltbld', 13:32:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:32:39 INFO - 'MOZ_NO_REMOTE': '1', 13:32:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:32:39 INFO - 'NO_EM_RESTART': '1', 13:32:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:32:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:32:39 INFO - 'PWD': '/builds/slave/test', 13:32:39 INFO - 'SHELL': '/bin/bash', 13:32:39 INFO - 'SHLVL': '1', 13:32:39 INFO - 'TERM': 'linux', 13:32:39 INFO - 'TMOUT': '86400', 13:32:39 INFO - 'USER': 'cltbld', 13:32:39 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1477859543.255758-352965245', 13:32:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:32:39 INFO - '_': '/tools/buildbot/bin/python'} 13:32:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:32:40 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 13:32:40 INFO - Cleaning up... 13:32:40 INFO - Return code: 0 13:32:40 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:32:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:32:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:32:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:32:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:32:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:40 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 0x7f41e8daff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x204c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21187b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a7790>, '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 0x21a8690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a8b20>, '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': 'd2a8c569965ab8367867b893000001a1-1477859543.255758-352965245', '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 13:32:40 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 13:32:40 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 13:32:40 INFO - Using env: {'DISPLAY': ':0', 13:32:40 INFO - 'HOME': '/home/cltbld', 13:32:40 INFO - 'LANG': 'en_US.UTF-8', 13:32:40 INFO - 'LANGUAGE': 'en_US:en', 13:32:40 INFO - 'LOGNAME': 'cltbld', 13:32:40 INFO - 'MAIL': '/var/mail/cltbld', 13:32:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:32:40 INFO - 'MOZ_NO_REMOTE': '1', 13:32:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:32:40 INFO - 'NO_EM_RESTART': '1', 13:32:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:32:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:32:40 INFO - 'PWD': '/builds/slave/test', 13:32:40 INFO - 'SHELL': '/bin/bash', 13:32:40 INFO - 'SHLVL': '1', 13:32:40 INFO - 'TERM': 'linux', 13:32:40 INFO - 'TMOUT': '86400', 13:32:40 INFO - 'USER': 'cltbld', 13:32:40 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1477859543.255758-352965245', 13:32:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:32:40 INFO - '_': '/tools/buildbot/bin/python'} 13:32:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:32:40 INFO - Downloading/unpacking psutil>=3.1.1 13:32:40 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 13:32:40 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 13:32:40 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 13:32:40 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 13:32:40 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 13:32:40 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 13:32:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:32:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:32:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:32:42 INFO - Installing collected packages: psutil 13:32:42 INFO - Running setup.py install for psutil 13:32:42 INFO - building 'psutil._psutil_linux' extension 13:32:42 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 13:32:42 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 13:32:42 INFO - building 'psutil._psutil_posix' extension 13:32:42 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 13:32:42 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 13:32:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:32:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:32:42 INFO - Successfully installed psutil 13:32:42 INFO - Cleaning up... 13:32:42 INFO - Return code: 0 13:32:42 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:32:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:32:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:32:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:32:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:32:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:42 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 0x7f41e8daff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x204c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21187b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a7790>, '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 0x21a8690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a8b20>, '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': 'd2a8c569965ab8367867b893000001a1-1477859543.255758-352965245', '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 13:32:42 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 13:32:42 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 13:32:42 INFO - Using env: {'DISPLAY': ':0', 13:32:42 INFO - 'HOME': '/home/cltbld', 13:32:42 INFO - 'LANG': 'en_US.UTF-8', 13:32:42 INFO - 'LANGUAGE': 'en_US:en', 13:32:42 INFO - 'LOGNAME': 'cltbld', 13:32:42 INFO - 'MAIL': '/var/mail/cltbld', 13:32:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:32:42 INFO - 'MOZ_NO_REMOTE': '1', 13:32:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:32:42 INFO - 'NO_EM_RESTART': '1', 13:32:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:32:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:32:42 INFO - 'PWD': '/builds/slave/test', 13:32:42 INFO - 'SHELL': '/bin/bash', 13:32:42 INFO - 'SHLVL': '1', 13:32:42 INFO - 'TERM': 'linux', 13:32:42 INFO - 'TMOUT': '86400', 13:32:42 INFO - 'USER': 'cltbld', 13:32:42 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1477859543.255758-352965245', 13:32:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:32:43 INFO - '_': '/tools/buildbot/bin/python'} 13:32:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:32:43 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:32:43 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 13:32:43 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 13:32:43 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 13:32:43 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 13:32:43 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 13:32:43 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 13:32:45 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:32:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:32:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:32:45 INFO - Installing collected packages: mozsystemmonitor 13:32:45 INFO - Running setup.py install for mozsystemmonitor 13:32:45 INFO - Successfully installed mozsystemmonitor 13:32:45 INFO - Cleaning up... 13:32:45 INFO - Return code: 0 13:32:45 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:32:45 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')]} 13:32:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:32:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:45 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')]} 13:32:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:32:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:45 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 0x7f41e8daff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x204c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21187b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a7790>, '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 0x21a8690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a8b20>, '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': 'd2a8c569965ab8367867b893000001a1-1477859543.255758-352965245', '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 13:32:45 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 13:32:45 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 13:32:45 INFO - Using env: {'DISPLAY': ':0', 13:32:45 INFO - 'HOME': '/home/cltbld', 13:32:45 INFO - 'LANG': 'en_US.UTF-8', 13:32:45 INFO - 'LANGUAGE': 'en_US:en', 13:32:45 INFO - 'LOGNAME': 'cltbld', 13:32:45 INFO - 'MAIL': '/var/mail/cltbld', 13:32:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:32:45 INFO - 'MOZ_NO_REMOTE': '1', 13:32:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:32:45 INFO - 'NO_EM_RESTART': '1', 13:32:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:32:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:32:45 INFO - 'PWD': '/builds/slave/test', 13:32:45 INFO - 'SHELL': '/bin/bash', 13:32:45 INFO - 'SHLVL': '1', 13:32:45 INFO - 'TERM': 'linux', 13:32:45 INFO - 'TMOUT': '86400', 13:32:45 INFO - 'USER': 'cltbld', 13:32:45 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1477859543.255758-352965245', 13:32:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:32:45 INFO - '_': '/tools/buildbot/bin/python'} 13:32:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:32:45 INFO - Downloading/unpacking jsonschema==2.5.1 13:32:45 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 13:32:45 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 13:32:45 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 13:32:45 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 13:32:45 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 13:32:45 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 13:32:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:32:47 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:32:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:32:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:32:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:32:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:32:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:32:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:32:47 INFO - Downloading functools32-3.2.3-2.tar.gz 13:32:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:32:47 INFO - warning: no files found matching '*.txt' 13:32:47 INFO - no previously-included directories found matching 'build' 13:32:47 INFO - no previously-included directories found matching 'dist' 13:32:47 INFO - no previously-included directories found matching '.git*' 13:32:47 INFO - Installing collected packages: jsonschema, functools32 13:32:47 INFO - Running setup.py install for functools32 13:32:47 INFO - warning: no files found matching '*.txt' 13:32:47 INFO - no previously-included directories found matching 'build' 13:32:47 INFO - no previously-included directories found matching 'dist' 13:32:47 INFO - no previously-included directories found matching '.git*' 13:32:47 INFO - Successfully installed jsonschema functools32 13:32:47 INFO - Cleaning up... 13:32:47 INFO - Return code: 0 13:32:47 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:32:47 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')]} 13:32:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:32:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:47 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')]} 13:32:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:32:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:47 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 0x7f41e8daff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x204c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21187b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a7790>, '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 0x21a8690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a8b20>, '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': 'd2a8c569965ab8367867b893000001a1-1477859543.255758-352965245', '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 13:32:47 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 13:32:47 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 13:32:47 INFO - Using env: {'DISPLAY': ':0', 13:32:47 INFO - 'HOME': '/home/cltbld', 13:32:47 INFO - 'LANG': 'en_US.UTF-8', 13:32:47 INFO - 'LANGUAGE': 'en_US:en', 13:32:47 INFO - 'LOGNAME': 'cltbld', 13:32:47 INFO - 'MAIL': '/var/mail/cltbld', 13:32:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:32:47 INFO - 'MOZ_NO_REMOTE': '1', 13:32:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:32:47 INFO - 'NO_EM_RESTART': '1', 13:32:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:32:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:32:47 INFO - 'PWD': '/builds/slave/test', 13:32:47 INFO - 'SHELL': '/bin/bash', 13:32:47 INFO - 'SHLVL': '1', 13:32:47 INFO - 'TERM': 'linux', 13:32:47 INFO - 'TMOUT': '86400', 13:32:47 INFO - 'USER': 'cltbld', 13:32:47 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1477859543.255758-352965245', 13:32:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:32:47 INFO - '_': '/tools/buildbot/bin/python'} 13:32:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:32:48 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:32:48 INFO - Cleaning up... 13:32:48 INFO - Return code: 0 13:32:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:32:48 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')]} 13:32:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:32:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:48 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')]} 13:32:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:32:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:48 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 0x7f41e8daff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x204c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21187b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a7790>, '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 0x21a8690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a8b20>, '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': 'd2a8c569965ab8367867b893000001a1-1477859543.255758-352965245', '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 13:32:48 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 13:32:48 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 13:32:48 INFO - Using env: {'DISPLAY': ':0', 13:32:48 INFO - 'HOME': '/home/cltbld', 13:32:48 INFO - 'LANG': 'en_US.UTF-8', 13:32:48 INFO - 'LANGUAGE': 'en_US:en', 13:32:48 INFO - 'LOGNAME': 'cltbld', 13:32:48 INFO - 'MAIL': '/var/mail/cltbld', 13:32:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:32:48 INFO - 'MOZ_NO_REMOTE': '1', 13:32:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:32:48 INFO - 'NO_EM_RESTART': '1', 13:32:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:32:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:32:48 INFO - 'PWD': '/builds/slave/test', 13:32:48 INFO - 'SHELL': '/bin/bash', 13:32:48 INFO - 'SHLVL': '1', 13:32:48 INFO - 'TERM': 'linux', 13:32:48 INFO - 'TMOUT': '86400', 13:32:48 INFO - 'USER': 'cltbld', 13:32:48 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1477859543.255758-352965245', 13:32:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:32:48 INFO - '_': '/tools/buildbot/bin/python'} 13:32:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:32:48 INFO - Downloading/unpacking blobuploader==1.2.4 13:32:48 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 13:32:48 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 13:32:48 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 13:32:48 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 13:32:48 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 13:32:48 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 13:32:50 INFO - Downloading blobuploader-1.2.4.tar.gz 13:32:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:32:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:32:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:32:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:32:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:32:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:32:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:32:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:32:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:32:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:32:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:32:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:32:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:32:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:32:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:32:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:32:51 INFO - Downloading docopt-0.6.1.tar.gz 13:32:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:32:51 INFO - Installing collected packages: blobuploader, requests, docopt 13:32:51 INFO - Running setup.py install for blobuploader 13:32:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:32:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:32:51 INFO - Running setup.py install for requests 13:32:51 INFO - Running setup.py install for docopt 13:32:51 INFO - Successfully installed blobuploader requests docopt 13:32:51 INFO - Cleaning up... 13:32:51 INFO - Return code: 0 13:32:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:32: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')]} 13:32:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:32:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32: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')]} 13:32:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:32:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:51 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 0x7f41e8daff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x204c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21187b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a7790>, '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 0x21a8690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a8b20>, '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': 'd2a8c569965ab8367867b893000001a1-1477859543.255758-352965245', '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 13:32:51 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 13:32:51 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 13:32:51 INFO - Using env: {'DISPLAY': ':0', 13:32:51 INFO - 'HOME': '/home/cltbld', 13:32:51 INFO - 'LANG': 'en_US.UTF-8', 13:32:51 INFO - 'LANGUAGE': 'en_US:en', 13:32:51 INFO - 'LOGNAME': 'cltbld', 13:32:51 INFO - 'MAIL': '/var/mail/cltbld', 13:32:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:32:51 INFO - 'MOZ_NO_REMOTE': '1', 13:32:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:32:51 INFO - 'NO_EM_RESTART': '1', 13:32:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:32:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:32:51 INFO - 'PWD': '/builds/slave/test', 13:32:51 INFO - 'SHELL': '/bin/bash', 13:32:51 INFO - 'SHLVL': '1', 13:32:51 INFO - 'TERM': 'linux', 13:32:51 INFO - 'TMOUT': '86400', 13:32:51 INFO - 'USER': 'cltbld', 13:32:51 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1477859543.255758-352965245', 13:32:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:32:51 INFO - '_': '/tools/buildbot/bin/python'} 13:32:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:32:51 INFO - Running setup.py (path:/tmp/pip-Aju96B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:32:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:32:52 INFO - Running setup.py (path:/tmp/pip-YSvh9Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:32:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:32:52 INFO - Running setup.py (path:/tmp/pip-F8Brf0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:32:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:32:52 INFO - Running setup.py (path:/tmp/pip-n6db9t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:32:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:32:52 INFO - Running setup.py (path:/tmp/pip-skOTbm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:32:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:32:52 INFO - Running setup.py (path:/tmp/pip-ZVp14j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:32:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:32:52 INFO - Running setup.py (path:/tmp/pip-WgLbRl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:32:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:32:52 INFO - Running setup.py (path:/tmp/pip-dqjT16-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:32:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:32:52 INFO - Running setup.py (path:/tmp/pip-nZ3Cx3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:32:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:32:52 INFO - Running setup.py (path:/tmp/pip-RGplqD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:32:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:32:52 INFO - Running setup.py (path:/tmp/pip-X3kqHl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:32:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:32:52 INFO - Running setup.py (path:/tmp/pip-IHxDK8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:32:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:32:52 INFO - Running setup.py (path:/tmp/pip-Af_qSP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:32:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:32:52 INFO - Running setup.py (path:/tmp/pip-1tyZt9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:32:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:32:53 INFO - Running setup.py (path:/tmp/pip-5zenqW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:32:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:32:53 INFO - Running setup.py (path:/tmp/pip-xCPIQ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:32:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:32:53 INFO - Running setup.py (path:/tmp/pip-JDTyoA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:32:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:32:53 INFO - Running setup.py install for manifestparser 13:32:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:32:53 INFO - Running setup.py install for mozcrash 13:32:53 INFO - Running setup.py install for mozdebug 13:32:53 INFO - Running setup.py install for mozdevice 13:32:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:32:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:32:53 INFO - Running setup.py install for mozfile 13:32:53 INFO - Running setup.py install for mozhttpd 13:32:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:32:53 INFO - Running setup.py install for mozinfo 13:32:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:32:53 INFO - Running setup.py install for mozInstall 13:32:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:32:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:32:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:32:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:32:54 INFO - Running setup.py install for mozleak 13:32:54 INFO - Running setup.py install for mozlog 13:32:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:32:54 INFO - Running setup.py install for moznetwork 13:32:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:32:54 INFO - Running setup.py install for mozprocess 13:32:54 INFO - Running setup.py install for mozprofile 13:32:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:32:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:32:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:32:54 INFO - Running setup.py install for mozrunner 13:32:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:32:54 INFO - Running setup.py install for mozscreenshot 13:32:54 INFO - Running setup.py install for moztest 13:32:54 INFO - Running setup.py install for mozversion 13:32:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:32:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:32:55 INFO - Cleaning up... 13:32:55 INFO - Return code: 0 13:32:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:32:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:32:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:32:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:32:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:32:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:55 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 0x7f41e8daff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x204c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21187b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a7790>, '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 0x21a8690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a8b20>, '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': 'd2a8c569965ab8367867b893000001a1-1477859543.255758-352965245', '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 13:32:55 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 13:32:55 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 13:32:55 INFO - Using env: {'DISPLAY': ':0', 13:32:55 INFO - 'HOME': '/home/cltbld', 13:32:55 INFO - 'LANG': 'en_US.UTF-8', 13:32:55 INFO - 'LANGUAGE': 'en_US:en', 13:32:55 INFO - 'LOGNAME': 'cltbld', 13:32:55 INFO - 'MAIL': '/var/mail/cltbld', 13:32:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:32:55 INFO - 'MOZ_NO_REMOTE': '1', 13:32:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:32:55 INFO - 'NO_EM_RESTART': '1', 13:32:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:32:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:32:55 INFO - 'PWD': '/builds/slave/test', 13:32:55 INFO - 'SHELL': '/bin/bash', 13:32:55 INFO - 'SHLVL': '1', 13:32:55 INFO - 'TERM': 'linux', 13:32:55 INFO - 'TMOUT': '86400', 13:32:55 INFO - 'USER': 'cltbld', 13:32:55 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1477859543.255758-352965245', 13:32:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:32:55 INFO - '_': '/tools/buildbot/bin/python'} 13:32:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:32:55 INFO - Running setup.py (path:/tmp/pip-e9Kn_6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:32:55 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)) 13:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:32:55 INFO - Running setup.py (path:/tmp/pip-nlmtFF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:32:55 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)) 13:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:32:55 INFO - Running setup.py (path:/tmp/pip-xe2OOs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:32:55 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)) 13:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:32:55 INFO - Running setup.py (path:/tmp/pip-p3C0iE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:32:55 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)) 13:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:32:55 INFO - Running setup.py (path:/tmp/pip-TG5L6A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:32:55 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)) 13:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:32:55 INFO - Running setup.py (path:/tmp/pip-0NoqAK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:32:55 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)) 13:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:32:55 INFO - Running setup.py (path:/tmp/pip-MzWUvN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:32:55 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)) 13:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:32:55 INFO - Running setup.py (path:/tmp/pip-SDltMP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:32:55 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)) 13:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:32:55 INFO - Running setup.py (path:/tmp/pip-Z08DJ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:32:55 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)) 13:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:32:55 INFO - Running setup.py (path:/tmp/pip-MBJXZR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:32:55 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)) 13:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:32:55 INFO - Running setup.py (path:/tmp/pip-jnlo_b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:32:56 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)) 13:32:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:32:56 INFO - Running setup.py (path:/tmp/pip-o_zG5Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:32:56 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)) 13:32:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:32:56 INFO - Running setup.py (path:/tmp/pip-D68TYL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:32:56 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)) 13:32:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:32:56 INFO - Running setup.py (path:/tmp/pip-HIFasU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:32:56 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)) 13:32:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:32:56 INFO - Running setup.py (path:/tmp/pip-IyBz32-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:32:56 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)) 13:32:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:32:56 INFO - Running setup.py (path:/tmp/pip-ztL60y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:32:56 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)) 13:32:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:32:56 INFO - Running setup.py (path:/tmp/pip-RMYcyN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:32:56 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)) 13:32:56 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)) 13:32:56 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)) 13:32:56 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)) 13:32:56 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)) 13:32:56 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)) 13:32:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:32:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:32:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:32:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:32:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:32:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:32:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:32:58 INFO - Downloading blessings-1.6.tar.gz 13:32:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:32:58 INFO - Installing collected packages: blessings 13:32:58 INFO - Running setup.py install for blessings 13:32:58 INFO - Successfully installed blessings 13:32:58 INFO - Cleaning up... 13:32:58 INFO - Return code: 0 13:32:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:32:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:32:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:32:58 INFO - Reading from file tmpfile_stdout 13:32:58 INFO - Current package versions: 13:32:58 INFO - argparse == 1.2.1 13:32:58 INFO - blessings == 1.6 13:32:58 INFO - blobuploader == 1.2.4 13:32:58 INFO - docopt == 0.6.1 13:32:58 INFO - functools32 == 3.2.3-2 13:32:58 INFO - jsonschema == 2.5.1 13:32:58 INFO - manifestparser == 1.1 13:32:58 INFO - mozInstall == 1.12 13:32:58 INFO - mozcrash == 0.17 13:32:58 INFO - mozdebug == 0.1 13:32:58 INFO - mozdevice == 0.48 13:32:58 INFO - mozfile == 1.2 13:32:58 INFO - mozhttpd == 0.7 13:32:58 INFO - mozinfo == 0.9 13:32:58 INFO - mozleak == 0.1 13:32:58 INFO - mozlog == 3.4 13:32:58 INFO - moznetwork == 0.27 13:32:58 INFO - mozprocess == 0.23 13:32:58 INFO - mozprofile == 0.28 13:32:58 INFO - mozrunner == 6.12 13:32:58 INFO - mozscreenshot == 0.1 13:32:58 INFO - mozsystemmonitor == 0.3 13:32:58 INFO - moztest == 0.7 13:32:58 INFO - mozversion == 1.4 13:32:58 INFO - psutil == 3.1.1 13:32:58 INFO - requests == 1.2.3 13:32:58 INFO - wsgiref == 0.1.2 13:32:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:32:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:32:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:32:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:32:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:32:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:58 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 0x7f41e8daff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x204c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21187b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a7790>, '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 0x21a8690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a8b20>, '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': 'd2a8c569965ab8367867b893000001a1-1477859543.255758-352965245', '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 13:32:58 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 13:32:58 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 13:32:58 INFO - Using env: {'DISPLAY': ':0', 13:32:58 INFO - 'HOME': '/home/cltbld', 13:32:58 INFO - 'LANG': 'en_US.UTF-8', 13:32:58 INFO - 'LANGUAGE': 'en_US:en', 13:32:58 INFO - 'LOGNAME': 'cltbld', 13:32:58 INFO - 'MAIL': '/var/mail/cltbld', 13:32:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:32:58 INFO - 'MOZ_NO_REMOTE': '1', 13:32:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:32:58 INFO - 'NO_EM_RESTART': '1', 13:32:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:32:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:32:58 INFO - 'PWD': '/builds/slave/test', 13:32:58 INFO - 'SHELL': '/bin/bash', 13:32:58 INFO - 'SHLVL': '1', 13:32:58 INFO - 'TERM': 'linux', 13:32:58 INFO - 'TMOUT': '86400', 13:32:58 INFO - 'USER': 'cltbld', 13:32:58 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1477859543.255758-352965245', 13:32:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:32:58 INFO - '_': '/tools/buildbot/bin/python'} 13:32:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:32:59 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)) 13:32:59 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)) 13:32:59 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)) 13:32:59 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)) 13:32:59 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)) 13:32:59 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)) 13:32:59 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)) 13:32:59 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)) 13:32:59 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)) 13:32:59 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)) 13:32:59 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)) 13:32:59 INFO - Cleaning up... 13:32:59 INFO - Return code: 0 13:32:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:32:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:32:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:32:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:32:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:32:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f41e8daff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x204c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21187b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a7790>, '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 0x21a8690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a8b20>, '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': 'd2a8c569965ab8367867b893000001a1-1477859543.255758-352965245', '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 13:32:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 13:32:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 13:32:59 INFO - Using env: {'DISPLAY': ':0', 13:32:59 INFO - 'HOME': '/home/cltbld', 13:32:59 INFO - 'LANG': 'en_US.UTF-8', 13:32:59 INFO - 'LANGUAGE': 'en_US:en', 13:32:59 INFO - 'LOGNAME': 'cltbld', 13:32:59 INFO - 'MAIL': '/var/mail/cltbld', 13:32:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:32:59 INFO - 'MOZ_NO_REMOTE': '1', 13:32:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:32:59 INFO - 'NO_EM_RESTART': '1', 13:32:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:32:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:32:59 INFO - 'PWD': '/builds/slave/test', 13:32:59 INFO - 'SHELL': '/bin/bash', 13:32:59 INFO - 'SHLVL': '1', 13:32:59 INFO - 'TERM': 'linux', 13:32:59 INFO - 'TMOUT': '86400', 13:32:59 INFO - 'USER': 'cltbld', 13:32:59 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1477859543.255758-352965245', 13:32:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:32:59 INFO - '_': '/tools/buildbot/bin/python'} 13:32:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:32:59 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:32:59 INFO - Cleaning up... 13:32:59 INFO - Return code: 0 13:32:59 INFO - Running post-action listener: _resource_record_post_action 13:32:59 INFO - Running post-action listener: _start_resource_monitoring 13:32:59 INFO - Starting resource monitoring. 13:32:59 INFO - [mozharness: 2016-10-30 20:32:59.404491Z] Finished create-virtualenv step (success) 13:32:59 INFO - [mozharness: 2016-10-30 20:32:59.405070Z] Running install step. 13:32:59 INFO - Running pre-action listener: _resource_record_pre_action 13:32:59 INFO - Running main action method: install 13:32:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:32:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:32:59 INFO - Reading from file tmpfile_stdout 13:32:59 INFO - Detecting whether we're running mozinstall >=1.0... 13:32:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:32:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:32:59 INFO - Reading from file tmpfile_stdout 13:32:59 INFO - Output received: 13:32:59 INFO - Usage: mozinstall [options] installer 13:32:59 INFO - Options: 13:32:59 INFO - -h, --help show this help message and exit 13:32:59 INFO - -d DEST, --destination=DEST 13:32:59 INFO - Directory to install application into. [default: 13:32:59 INFO - "/builds/slave/test"] 13:32:59 INFO - --app=APP Application being installed. [default: firefox] 13:32:59 INFO - mkdir: /builds/slave/test/build/application 13:32:59 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'] 13:32:59 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 13:33:16 INFO - Reading from file tmpfile_stdout 13:33:16 INFO - Output received: 13:33:16 INFO - /builds/slave/test/build/application/firefox/firefox 13:33:16 INFO - Running post-action listener: _resource_record_post_action 13:33:16 INFO - [mozharness: 2016-10-30 20:33:16.645782Z] Finished install step (success) 13:33:16 INFO - [mozharness: 2016-10-30 20:33:16.646052Z] Running run-tests step. 13:33:16 INFO - Running pre-action listener: _resource_record_pre_action 13:33:16 INFO - Running main action method: run_tests 13:33:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:33:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:33:16 INFO - Python 2.7.3 13:33:16 INFO - Return code: 0 13:33:16 INFO - grabbing minidump binary from tooltool 13:33:16 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')]} 13:33:16 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 0x21a7790>, '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 0x21a8690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a8b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:33:16 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 13:33:16 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 13:33:16 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 13:33:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:33:16 INFO - Return code: 0 13:33:16 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:33:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:33:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:33:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:33:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:33:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477747962/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--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 13:33:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477747962/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-043 --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 13:33:16 INFO - Using env: {'DISPLAY': ':0', 13:33:16 INFO - 'HOME': '/home/cltbld', 13:33:16 INFO - 'LANG': 'en_US.UTF-8', 13:33:16 INFO - 'LANGUAGE': 'en_US:en', 13:33:16 INFO - 'LOGNAME': 'cltbld', 13:33:16 INFO - 'MAIL': '/var/mail/cltbld', 13:33:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:33:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:33:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:33:16 INFO - 'MOZ_NO_REMOTE': '1', 13:33:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:33:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:33:16 INFO - 'NO_EM_RESTART': '1', 13:33:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:33:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:33:16 INFO - 'PWD': '/builds/slave/test', 13:33:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:33:16 INFO - 'SHELL': '/bin/bash', 13:33:16 INFO - 'SHLVL': '1', 13:33:16 INFO - 'TERM': 'linux', 13:33:16 INFO - 'TMOUT': '86400', 13:33:16 INFO - 'USER': 'cltbld', 13:33:16 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1477859543.255758-352965245', 13:33:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:33:16 INFO - '_': '/tools/buildbot/bin/python'} 13:33:16 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477747962/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--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 13:33:16 INFO - mozversion application_buildid: 20161029063242 13:33:16 INFO - mozversion application_changeset: 1b170b39ed6bdbde366233ab84594bdaaa960a5a 13:33:16 INFO - mozversion application_display_name: Nightly 13:33:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:33:16 INFO - mozversion application_name: Firefox 13:33:16 INFO - mozversion application_remotingname: firefox 13:33:16 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 13:33:16 INFO - mozversion application_vendor: Mozilla 13:33:16 INFO - mozversion application_version: 52.0a1 13:33:16 INFO - mozversion platform_buildid: 20161029063242 13:33:16 INFO - mozversion platform_changeset: 1b170b39ed6bdbde366233ab84594bdaaa960a5a 13:33:16 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 13:33:16 INFO - mozversion platform_version: 52.0a1 13:33:16 INFO - using testdate: 1477859596 13:33:16 INFO - actual date: 1477859596 13:33:16 INFO - starting webserver on 'localhost:56071' 13:33:16 INFO - SUITE-START | Running 2 tests 13:33:16 INFO - TEST-START | dromaeo_css 13:33:16 INFO - operating with platform_type : linux_ 13:33:16 INFO - Initialising browser for dromaeo_css test... 13:33:16 INFO - TEST-INFO | started process 31635 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1ZEkiU/profile http://localhost:56071/getInfo.html) 13:33:21 INFO - PROCESS | 31635 | __metrics Screen width/height:1600/1200 13:33:21 INFO - PROCESS | 31635 | colorDepth:24 13:33:21 INFO - PROCESS | 31635 | Browser inner width/height: 1024/697 13:33:21 INFO - PROCESS | 31635 | __metrics 13:33:22 INFO - PROCESS | 31635 | 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" 13:33:22 INFO - PROCESS | 31635 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 205: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:33:23 INFO - TEST-INFO | 31635: exit 0 13:33:23 INFO - Browser initialized. 13:33:23 INFO - Running cycle 1/1 for dromaeo_css test... 13:33:23 INFO - TEST-INFO | started process 31717 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1ZEkiU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:33:35 INFO - PROCESS | 31717 | RSS: Main: 174796800 13:33:35 INFO - PROCESS | 31717 | 13:34:27 INFO - PROCESS | 31717 | 1477859667293 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] 13:36:38 INFO - PROCESS | 31717 | Cycle 1(1): loaded http://localhost:56071/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56071/tests/dromaeo/cssquery-ext.html) 13:36:39 INFO - PROCESS | 31717 | RSS: Main: 308781056 13:36:39 INFO - PROCESS | 31717 | 13:39:42 INFO - PROCESS | 31717 | Cycle 1(1): loaded http://localhost:56071/tests/dromaeo/cssquery-ext.html (next: http://localhost:56071/tests/dromaeo/cssquery-jquery.html) 13:39:42 INFO - PROCESS | 31717 | RSS: Main: 277274624 13:39:42 INFO - PROCESS | 31717 | 13:42:44 INFO - PROCESS | 31717 | Cycle 1(1): loaded http://localhost:56071/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56071/tests/dromaeo/cssquery-mootools.html) 13:42:45 INFO - PROCESS | 31717 | RSS: Main: 218611712 13:42:45 INFO - PROCESS | 31717 | 13:45:47 INFO - PROCESS | 31717 | Cycle 1(1): loaded http://localhost:56071/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56071/tests/dromaeo/cssquery-prototype.html) 13:45:48 INFO - PROCESS | 31717 | RSS: Main: 249782272 13:45:48 INFO - PROCESS | 31717 | 13:48:50 INFO - PROCESS | 31717 | Cycle 1(1): loaded http://localhost:56071/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56071/tests/dromaeo/cssquery-yui.html) 13:48:51 INFO - PROCESS | 31717 | RSS: Main: 217538560 13:48:51 INFO - PROCESS | 31717 | 13:51:53 INFO - PROCESS | 31717 | Cycle 1(1): loaded http://localhost:56071/tests/dromaeo/cssquery-yui.html (next: http://localhost:56071/tests/dromaeo/cssquery-dojo.html) 13:51:54 INFO - PROCESS | 31717 | RSS: Main: 313536512 13:51:54 INFO - PROCESS | 31717 | 13:51:54 INFO - PROCESS | 31717 | __start_tp_report 13:51:54 INFO - PROCESS | 31717 | _x_x_mozilla_page_load 13:51:54 INFO - PROCESS | 31717 | _x_x_mozilla_page_load_details 13:51:54 INFO - PROCESS | 31717 | |i|pagename|runs| 13:51:54 INFO - PROCESS | 31717 | |0;dojo.html;2918.460084884296;2935.5303151495764;2974.2564358910267;2983.388405376898;2998.775091868109;5052.6210534209895;5125.436202017775;5217.269582258482;5245.527902488775;5401.243825864382;5144.09978253805;5159.303494028305;5170;5176.352955880515;5177.870553236171;4688.179568575494;4716.90566188676;4727.81088756451;4767.404074490689;4787.353707249512;4773.307870358796;4856.514348565133;4897.338859254009;4948.802047918079;4959.404871415417;4937.827176048839;4957.281194226835;4963.726995015273;4964.106460837048;5029.47190544993;4851.3450684157715;4921.8523444296725;5023.171176755831;5024.899502009976;5024.9748751256375;4611.26219804833;4829.420469543677;4840.903181936377;4885.8778530536665;4887.315775791392;5067.417247016567;5111.667741596784;5164.302819119408;5164.948350516522;5165.535101840815;5441.129419292934;5449.56403487724;5453.400125986138;5462.617616766828;5463.31708536433;5471.835844924659;5492.093804522249;5495.6427832191175;5497.120460726264;5503.862403439906;5112.309838171836;5113.974430127862;5122;5124;5129.9230511542355;5621.915671264935;5624.943750562524;5627.352854421794;5628.831135065954;5630.5495560355075;5385.865353366197;5415.48552887475;5415.5938304626525;5420.430854760272;5424.213489044146;5576.33084029919;5587.357453892854;5588.972055139699;5589.552835773128;5599.580031497572;5596.188552659842;5606.495415412633;5613.691246981455;5620.1288800236025;5634.239377684042;5388.595855310868;5428.104362780097;5525.668459892419;5561.610687251934;5628.915566266509;4280.785960701953;4301.075268817157;4320.870373888725;4348.434703488526;4412.029353542215;3805.353089974711;3827.559830619459;3834.405667121601;3849.942250866239;3881.7088718346236;5129.12804823181;5182.455842136596;5301.098813201765;5313.495217954288;5323.254744335796;5586.1062230043;5602.159676048544;5616.1014237721765;5645.604807663424;5679.744411501492;5284.048871203144;5307.150855863043;5326.174442961347;5330.093884039723;5390.946090539122;4717.599004084623;4768.880777980578;4844.660873738875;4847.151748444008;4903.754812259444;5934.554908381802;5940.910886336795;5979.252593425822;5981.641101533922;5989.041753319448;5688.77244910199;5689.8620275945805;5691.516221121251;5696.515796157208;5710.628809127394;5603.551715862803;5657.32112146545;5882.117682347682;5882.882342353215;5902.822915312548;5398.217258497574;5407.864803379947;5471.480209380103;5493.890122197454;5540.418256083053;5521.365043020104;5547.389787123332;5572.526335261548;5573;5575.972120139373;5378.381486128988;5442.945570544244;5452.727363631882;5453.454654534515;5508.669479831223;5365.248865158959;5416.133418653154;5514.91727624094;5522.502974732293;5535.39110697831;5516.393196748274;5536.7231638418725;5542.75057622416;5559.24950131727;5579.609427340048;5393.325834270716;5438.619296649196;5452.5365343946205;5602.047651899105;5624.662520248635;5331.200319952039;5355.116405793001;5368.8389348319615;5370.03339398912;5408.080626293461 13:51:54 INFO - PROCESS | 31717 | |1;ext.html;553.899616494113;584.5644994479112;586.7066466766616;590.6397097770362;605.5851741557033;29656;30562;40581.188376232494;41304.79347603258;41400.17199656005;39369.21261574767;43536;43618.78190609042;43627.3455898161;43665.7816710916;7798.2981531662135;8643.438176518523;8790.956045219766;8805.95597022014;8809.03100658927;7838.529688218697;10246.231532635082;10445.634402795904;10457.79084418315;10795.946020269888;10573.524191411367;10616.150707943347;10639.414832184228;10643.04212620864;10645.14838812897;10421.531031103581;10472.790544189074;10492.16062714981;10553.102986246178;10561.471926403648;10508.422036787973;10568.471576421149;10575.259731818776;10589.205809564313;10590.152787776959;40703.7964810177;41154.79422602868;41185.1762964742;41206.1758764823;41208.1758364834;3352;3367.5453813735076;3371.2077661749468;3372.140104273419;3424.7088997435;30463.23841903948;30649.540256896165;30740;30943.535846962313;32401.83799081013;4353.673474489395;4375.343698445226;4380.912381752379;4387.824487020547;4461.888452788674;310061;310538.99999999773;310932;311188;312197;53156.468435315925;53434.73282633562;53476;53543.19685204725;53564.73217633965;34100.82949585236;34532.82733586316;34677;37305;57228.42771572314;15572.143532105616;15720.21398930049;15728.528144155694;15742.68514629701;15749.370025199092;10852.67441976742;11057.612983545538;11672.94163529194;12057.638270851712;12140.817887731691;17323;18088.186031628607;18160.364387246384;18173.54566135831;18362.173702183434;6772.729090836311;6896.2069362023;6898.792386436393;7027.367536921702;7190.928090719026;871.329076611006;974.1281553010016;1014.1734486393566;1027.4503140819625;1135.1543100390097;30984.22539436532;31925.361492770015;32059;32098.67901320957;32166.678333216838;1080.6055789636725;1088.515610553312;1116.0346300450053;1147.002108165901;1157.7047852797482;16135.354585816436;16639;16765.32938682439;16873.746893796604;17048.06235657026;529978;532578;532864;532948;541122;37473.43789843155;55838.16242756362;56020.15969760457;56114;56194.438055619736;1185.6146752305535;1233.0690328801697;1281.7052078022107;1296.3323888197585;1313.5665230473921;28519.572206417335;31988.840055799574;32171.356572867942;32274.158876168764;32878.34243315073;47244.527554724016;48005.51994480011;48059.75970120127;48107.518924810305;48155;396717;396846;398963;400080;401092;26056.73943260543;26922.730772692023;26993;28430.715692843634;28626.28434289076;44614.3307850376;45365;45370.773146135376;45773.54226457693;46779.29831052469;39191.41212881752;39244.80377598094;39600.60399395969;39694.60305396909;41210;38858;39754.602453976244;39785.40321895232;39932.80033599814;41066.58933410628;39085.2182956345;39634.603653964245;40065;40606;41063.794681026404;32435;34657.30685386329;35297;36139;36267.81866090652;26895;26948;27058.72941270562;27696.72303277022;29219.561706573993 13:51:54 INFO - PROCESS | 31717 | |2;jquery.html;348.84999450236387;371.4947671167212;383.63554623108047;388.07444245474534;404.7571457125725;14007.789883151761;17646.294148234072;18054.548636284082;18925.905370473127;20313.18747250112;16240.918795406036;18309.542261443472;18724.344647937323;18743.15655795489;19051.809481905213;4973.676711013782;5248.8687782805355;5249.921251181236;5250.264962905197;5272.683638981654;3880.3985382265796;4067.0849058961644;5130.281760553526;5209;5215.71313577755;3969.0474286171257;6209;6232;6301.1808464899495;6302.338254483282;5591.496765291103;5683.801066962677;6196.008638617845;6273.3412991635905;6276.623402595836;5509.47659972302;5524.889502209973;5529.060059789846;5532.917006244909;5534.833954981316;13451.932740336235;13579.86420135796;13671.384787684578;13689.931550342184;13706.725865482635;2125.011869480699;2331.1724337859987;2348.835581509295;2365.6333268343433;2395.988020059906;9705.854412183753;9721.562529686182;9821.950890245575;10119.949400253025;10253.897461025368;1783.179737320834;1828.5977085041402;1874.9156287967073;1875.1561797191318;1894.2612381171355;73050.36706856411;73306.63346683286;74569;74669;77031.614841926;10649.148068154529;10787.946060269649;10824.621138260123;10825.079868211133;10873.891261087447;13959.79060314096;14419.206943617992;14688.485902993343;14715.247611858907;14758.704825903422;5864.70676466175;5981.252343457068;6697.6986035628515;7802.960985195038;7942.126366099725;7340.265973402617;7457.776266712007;7631.618419079024;7671.846563068819;7683.654235559413;4505.932411013838;4570.405847239837;4576.153411618861;4601.930971035437;4694.36626055485;1898.6297671953837;1919.9616007679767;1934.6517626827306;1937.3800383877306;1952.3264473756815;856.9571521423904;1028.2339656955467;1048.2662136504478;1049.150188347441;1073.6993641780314;18600.348987785634;18988.810111898703;19101.2359505621;19464.416067517996;19552.90223548873;942.844430668932;944.8866136063579;948.5684013773716;962.4177372689422;994.6071301835734;9524;10871.619493317696;10874.510647020903;10899.29154604948;10936.56253749857;417377;418883;429125;437049;438529;52503.73748131311;84722.78892947051;85971.14028859757;87602;88465.55767221123;966.6036924860773;979.9755006124761;985.5023213277249;991.0535438656066;994.721477986165;16297.918510407371;16372.590685232964;16818.309070548654;17003.829961700223;17188.914055430145;38555;39854.40218396668;40051;40328;42782.358264625436;51412.74293628508;52188.739056304476;55121.724391377786;56502.502212246116;56565.71717141388;8369.623366948625;8392;8545.957270213608;8573.61418736146;8582.399232053696;11883.643490695293;12761.744765104831;12967.157134786208;13052.869471305165;13281.867181328449;10784.622538211439;11288.096952243965;11292.491837867152;11514.76970460603;11832.230904991147;10953.83569246446;11010.339379637247;11050.502727377127;11372.090232781193;11558.364289964133;11286.153538484483;11392.25950313227;11464.598739044093;11468.655940321803;11851.585194518151;7876.448648594544;8171.79570510742;8316.875246871423;8438.83122337562;8506.319494440306;10416.635417760343;10647.574097036031;11164;11212.775744484901;11542.365169915734 13:51:54 INFO - PROCESS | 31717 | |3;mootools.html;1348.6898013456898;1446.8914831387644;1483.110133919648;1591.586187591226;1750.6411185706932;7403.370713489353;8097.352211823055;8379.790505237357;8388.161183881617;8583.27042201412;8476.872846907301;8539.316854651628;8548.871766923485;8550.315974722023;8556.016058153315;2323.4191452136965;2342.7071616047992;2347.978629296253;2351.600227961242;2351.6002279612508;2247.1123906057096;2317.154238702878;2364.798992085675;2365.7989070928993;2368.3131891751373;2285.954280914389;2299.5515874404496;2323.384303159664;2336.9649455258186;2341.8126549876056;2258.9435264118365;2272.8068114210314;2294.300238427279;2303.965440518402;2308.9307320780404;2275.5107651854764;2292.3123063081175;2292.79364857162;2295.3343530376337;2295.91964281251;8364.539950302731;8396.916030839675;8505.149485051506;8515.489070655718;8627;5226.7909283628605;5352.143657014898;5359.705216213107;5361.624686271963;5363.597730170253;3360.6135294441206;3446.4141096013486;3547.822608869546;3619.0228638267786;3623.547056617923;1089.515165751241;1119.641714651312;1137.6530158301714;1169.1060482019184;1181.5982565927625;11580.420978951019;11611.883881161164;11640.883591164065;11702.122340824388;11702.53189872404;4147.149834283965;4440.444944381952;4507.6168525675685;4519;4542.500324964251;9207.861882071775;9271.814563708824;9277.675281365255;9282.953585232031;9287.396319239228;5038.571721403649;5048.368953880765;5052.065367906949;5053.267276244924;5060.84817455477;4217.072244106353;4378.64970802335;4729.716217026989;4804.663673542818;4808.0624278266105;3548.574171099433;3562.5012498250267;3596.5684117906017;3600.4419315006216;3649.7627654202392;1085.56577369053;1090.2204923479592;1101.8512500812449;1103.0734183286079;1104.6133853151493;784.8822676598442;824.8102936324678;856.3662889461754;943.9150476457152;958.2094771813282;5580.776768929198;5608.803691870765;5777.653340799481;5837.94162058374;5989.670568118708;882.2148288023664;938.558877327655;945.3760518058049;981.1513041219293;986.0927946289431;3854.49891514107;3897.7661340319673;3928.587498312636;4017.5580686124504;4034.798260086984;10326;10608.416537090534;10657.680269591925;10671.519781609846;10681.305715128492;10402.427866467266;10517.52671129801;10612.57549698019;10620.522076506575;10632.840507392395;7860.528368297921;7935.841283174304;8040.437169398086;8046.718364857202;8060.395470339748;5308.681479111266;5596.552275817843;5616.803411880564;5725;5741.885162296814;9154.771130721785;9452.338336316392;9478.620855165716;9595.856062158933;9595.952020239854;9749.220062395134;9751.219902407649;9782;9839.557219925264;9850.113489785954;6306.9950581380235;6482.773102941374;6992.1259842519685;7042.260562641054;7160.57036577807;8232.423730338818;8251.917480825115;8266.917330826614;8283.83432331338;8284.50292982423;7131.358177764027;7270.382017528569;7303.415726741954;7307.3423391894985;7328.633568321456;7314.817129571803;7346.449016323691;7357;7443.441741869273;7633.313001829862;6697;6842.349976752201;6845.657717114224;6847.520673552804;6850.9314906850295;4948.208286674115;5061.6962982221185;5116.513931176532;5160.225966105114;5181.611379146504;5043.319151914445;5050.646454748133;5108.565771909281;5167.199084141964;5175.4565770593545 13:51:54 INFO - PROCESS | 31717 | |4;prototype.html;319.56858241374147;330.2981165024323;331.55737090983536;336.46837995966376;337.35901786605433;5049.949500504994;5177.482251774821;5208;5230.29391032211;5277.208418737191;5034.395872495296;5090.567301779353;5103.728840665905;5125.2312153177045;5139.6893792082965;4096.262672718909;4099.528554216258;4106.140228185511;4110.239605672945;4119;3959.227950549644;4112.609302116294;4124.793760311973;4128.02991297045;4136.193442278757;4062.8577999770014;4068.8982775430554;4073.87778366648;4097.242010228102;4100.835966561334;4070.4911886014247;4073.5519092899904;4078.3474644057105;4080.775557344345;4089.44792453018;3657.8719744808805;3681.4845921571;3691.464737613031;3702.5927148013698;3721.702263818915;4825.155597770411;5032.471590482984;5055.848324550269;5057.2666963290485;5059.7097740076415;4641.839540114971;4648.674592778507;4652;4671.11248862715;4676.883077923045;5423.2136340230445;5441.211024401479;5441.755121019563;5454.672719636835;5477.3427188737205;3928.5482169550583;3974.3044967130636;3991.1818077294083;4027.2280196713355;4028.3353246714255;5545.72271386429;5619.8595035124445;5630.662160270397;5645.745941432604;5659.462351076641;4075.347944328893;4082.81627326771;4092.46797916269;4096.0508433927525;4098.282800509899;3964.801759911993;4073.572274911151;4180.456540649696;4185.121124563876;4190.748555086705;4680.3447517347595;4681.742504162304;4692.41344831896;4696.178168820443;4702.506236845151;5448.809291674773;5457.144570845931;5464.23500709901;5502.9174562381595;5523.613347065667;1337.7592033434075;1380.2270728392132;1401.1733077484332;1405.620482469748;1437.8490258522913;922.2477293142948;923.2244914272044;954.7565370830393;957.2724729205854;964.4695417520476;4670.976645116821;4679.532046795293;4692.671512994058;4693.319468677023;4705.223638099744;4895.241237608177;4900.583450406684;4901.852944411673;4956.628252881048;4960.90078198434;4711.327478745065;4728.1252968201;4734.183161019188;4746.406699162605;4761.714297142183;2857.9142625720847;2984.2241017335214;3002.4745669507747;3005.9398812023637;3012.201766531871;5856.180134781134;5860.413958604106;5862.303340463434;5873.353931067579;5889.911651325234;5408.269883565668;5594.804181853616;5614.214010038598;5654.858628534237;5691.946989806899;5725.883452726678;5792.580817699691;5802.506786923074;5817.44734250254;5819.73811178498;5557.722113894209;5571.4428557143965;5585.5531557476115;5594.832155035356;5598.944010560005;5308.628396012242;5515.531179849758;5527.894421115873;5537.667739935617;5547.722613869371;5751.511121554715;5771.105478650816;5846.883062338815;5848.561357898089;5861.853453663522;3929.528456585228;3951.4863067802153;3973.165635216637;3983.92032159361;4050.7569545827346;5351.785928562814;5530.806421775219;5541.473560011793;5544.944550554443;5558.555315574825;5296.602754793329;5337.706426146599;5404.918926216032;5412.539934105487;5422.430644782241;5386.353637563518;5401.729913504388;5405.486478784509;5420;5421.701806400686;5208.8437346879655;5404.83785486436;5412.485813847678;5414.377346605191;5454.618176727591;5477.780888764405;5483.99834060573;5492.533134683436;5492.5331346835965;5493.670379777226;5342.8931421372135;5348.786048558014;5349.170878513836;5350.652207606493;5378.677279363251 13:51:54 INFO - PROCESS | 31717 | |5;yui.html;708.2846325211535;738.6417587470077;739.4269441183086;796.9521828690279;826.7602395305364;14141.575752727422;14713.558593242193;14737;14762;14860;13350.0654954153;13449.327533623304;13451.730965380686;13462.663433414169;13466.797998030037;783.9490433121844;798.1938242375185;799.6721344248859;799.9120096789349;800.4196957206037;792.3265224559136;796.3549524884833;796.7052190689424;796.8725003999361;796.8884356190138;833.2875391540207;834.7829564313262;835.0563862834988;836.6611522333434;837.9371547133959;830.7881490220016;832.0597724571226;832.0597724571226;832.5753865528563;833.1418638802013;577.2466930655493;594.168164569606;595.7795615622248;600.7626987339976;601.5067644531485;13675.247861367621;13694.863051369459;13710.794338084937;13730;13735.45058197671;12212.694682632917;12250.693732656666;12840.357982100857;12936.28850413227;13025.478980840755;10262.486875656263;12065.577704780291;12190.39048047603;12449.875501244962;12976.351182440934;4373.846915357947;4395.340698895159;4446.844360447401;4475.865724028285;4492.573205545468;60460.69769651123;62644;62659;62854.68572657153;64397.67801161011;10403.739906502247;10451.68644940653;10573.418461984666;10713.142948564097;10857.728556786144;18046;18209.63580728378;18247.908760456114;18304.450866474028;18308.359207427944;7685.500442471333;7776;7943.682252709827;8008.239217274349;8157.632906519102;4452.443444569429;4537.6143027842345;4541.250693635513;4568.725876447424;4608.2166031774;3100.3179300553843;3192.2817366092445;3193.5209718542405;3196.6164060312913;3198.648148703641;564.4750382144563;585.1486087742325;585.9033259512217;592.6977241606811;593.4095574902913;663.7643636509066;671.7917445591883;689.8965155226756;724.9311315425026;728.6101935464501;8772.649094036295;8886.60010299538;8958.328125390492;9082.18260356558;9227.815443691223;560.3360018378235;571.3971759793458;580.8576898659855;592.5703864698146;726.8727972604773;4086.892672863753;4262.403263543107;4275.1663425631705;4280.422143010716;4299.1831552005015;69392;80252.19747802564;81337.59331203306;81876.59061704653;83128.58435707903;45585.54414455879;70914.64542677253;71645;71852.64073679598;72041.27958720346;63251.68374158192;63645;64033;64041.67979160074;64484.35515644877;7949.8410031797885;8147.837043258983;8200.138985406445;8212.917870821215;8288.129746376544;43976;44824;45479;45521;47555.28667069927;58280;61034.694826525585;61135;61639.38360616336;62201.06698399437;9073.410228335137;9987;10026.248031397528;10041.648542300984;10320.587176513156;10869.836952445878;10923.726906827393;11122.221444498808;11299.830502542303;11330.660080197607;10815.188860835311;10850.78298434011;10984.176186785864;10986.066184374098;11219.990200881959;10143.492825358555;10171.847422288523;10268.537915793957;10362.430066346424;11070.059044980944;10244.53899574506;10599.205059620404;10826.40454774995;11024.393658348547;11101.5559377624;8697.608607612547;8839.558022098998;8935.955320223356;9181.77045573866;9391.577379017825;9313.696082548584;9404.955868976405;9571.28215383835;9591.9040809591;9772.558346960124 13:51:54 INFO - PROCESS | 31717 | __end_tp_report 13:51:54 INFO - PROCESS | 31717 | __start_cc_report 13:51:54 INFO - PROCESS | 31717 | _x_x_mozilla_cycle_collect,1280 13:51:54 INFO - PROCESS | 31717 | __end_cc_report 13:51:54 INFO - PROCESS | 31717 | __startTimestamp1477860714103__endTimestamp 13:51:54 INFO - PROCESS | 31717 | 13:51:54 INFO - PROCESS | 31717 | ------- Summary: start ------- 13:51:54 INFO - PROCESS | 31717 | Number of tests: 6 13:51:54 INFO - PROCESS | 31717 | 13:51:54 INFO - PROCESS | 31717 | [#0] dojo.html Cycles:165 Average:5201.63 Median:5393.33 stddev:583.74 (10.8%) stddev-sans-first:557.37 13:51:54 INFO - PROCESS | 31717 | Values: 2918.5 2935.5 2974.3 2983.4 2998.8 5052.6 5125.4 5217.3 5245.5 5401.2 5144.1 5159.3 5170.0 5176.4 5177.9 4688.2 4716.9 4727.8 4767.4 4787.4 4773.3 4856.5 4897.3 4948.8 4959.4 4937.8 4957.3 4963.7 4964.1 5029.5 4851.3 4921.9 5023.2 5024.9 5025.0 4611.3 4829.4 4840.9 4885.9 4887.3 5067.4 5111.7 5164.3 5164.9 5165.5 5441.1 5449.6 5453.4 5462.6 5463.3 5471.8 5492.1 5495.6 5497.1 5503.9 5112.3 5114.0 5122.0 5124.0 5129.9 5621.9 5624.9 5627.4 5628.8 5630.5 5385.9 5415.5 5415.6 5420.4 5424.2 5576.3 5587.4 5589.0 5589.6 5599.6 5596.2 5606.5 5613.7 5620.1 5634.2 5388.6 5428.1 5525.7 5561.6 5628.9 4280.8 4301.1 4320.9 4348.4 4412.0 3805.4 3827.6 3834.4 3849.9 3881.7 5129.1 5182.5 5301.1 5313.5 5323.3 5586.1 5602.2 5616.1 5645.6 5679.7 5284.0 5307.2 5326.2 5330.1 5390.9 4717.6 4768.9 4844.7 4847.2 4903.8 5934.6 5940.9 5979.3 5981.6 5989.0 5688.8 5689.9 5691.5 5696.5 5710.6 5603.6 5657.3 5882.1 5882.9 5902.8 5398.2 5407.9 5471.5 5493.9 5540.4 5521.4 5547.4 5572.5 5573.0 5576.0 5378.4 5442.9 5452.7 5453.5 5508.7 5365.2 5416.1 5514.9 5522.5 5535.4 5516.4 5536.7 5542.8 5559.2 5579.6 5393.3 5438.6 5452.5 5602.0 5624.7 5331.2 5355.1 5368.8 5370.0 5408.1 13:51:54 INFO - PROCESS | 31717 | 13:51:54 INFO - PROCESS | 31717 | [#1] ext.html Cycles:180 Average:56611.90 Median:18978.77 stddev:112615.94 (593.4%) stddev-sans-first:112853.21 13:51:54 INFO - PROCESS | 31717 | Values: 553.9 584.6 586.7 590.6 605.6 29656.0 30562.0 40581.2 41304.8 41400.2 39369.2 43536.0 43618.8 43627.3 43665.8 7798.3 8643.4 8791.0 8806.0 8809.0 7838.5 10246.2 10445.6 10457.8 10795.9 10573.5 10616.2 10639.4 10643.0 10645.1 10421.5 10472.8 10492.2 10553.1 10561.5 10508.4 10568.5 10575.3 10589.2 10590.2 40703.8 41154.8 41185.2 41206.2 41208.2 3352.0 3367.5 3371.2 3372.1 3424.7 30463.2 30649.5 30740.0 30943.5 32401.8 4353.7 4375.3 4380.9 4387.8 4461.9 310061.0 310539.0 310932.0 311188.0 312197.0 53156.5 53434.7 53476.0 53543.2 53564.7 34100.8 34532.8 34677.0 37305.0 57228.4 15572.1 15720.2 15728.5 15742.7 15749.4 10852.7 11057.6 11672.9 12057.6 12140.8 17323.0 18088.2 18160.4 18173.5 18362.2 6772.7 6896.2 6898.8 7027.4 7190.9 871.3 974.1 1014.2 1027.5 1135.2 30984.2 31925.4 32059.0 32098.7 32166.7 1080.6 1088.5 1116.0 1147.0 1157.7 16135.4 16639.0 16765.3 16873.7 17048.1 529978.0 532578.0 532864.0 532948.0 541122.0 37473.4 55838.2 56020.2 56114.0 56194.4 1185.6 1233.1 1281.7 1296.3 1313.6 28519.6 31988.8 32171.4 32274.2 32878.3 47244.5 48005.5 48059.8 48107.5 48155.0 396717.0 396846.0 398963.0 400080.0 401092.0 26056.7 26922.7 26993.0 28430.7 28626.3 44614.3 45365.0 45370.8 45773.5 46779.3 39191.4 39244.8 39600.6 39694.6 41210.0 38858.0 39754.6 39785.4 39932.8 41066.6 39085.2 39634.6 40065.0 40606.0 41063.8 32435.0 34657.3 35297.0 36139.0 36267.8 26895.0 26948.0 27058.7 27696.7 29219.6 13:51:54 INFO - PROCESS | 31717 | 13:51:54 INFO - PROCESS | 31717 | [#2] jquery.html Cycles:180 Average:26078.31 Median:3924.72 stddev:70667.26 (1800.6%) stddev-sans-first:70839.09 13:51:54 INFO - PROCESS | 31717 | Values: 348.8 371.5 383.6 388.1 404.8 14007.8 17646.3 18054.5 18925.9 20313.2 16240.9 18309.5 18724.3 18743.2 19051.8 4973.7 5248.9 5249.9 5250.3 5272.7 3880.4 4067.1 5130.3 5209.0 5215.7 3969.0 6209.0 6232.0 6301.2 6302.3 5591.5 5683.8 6196.0 6273.3 6276.6 5509.5 5524.9 5529.1 5532.9 5534.8 13451.9 13579.9 13671.4 13689.9 13706.7 2125.0 2331.2 2348.8 2365.6 2396.0 9705.9 9721.6 9822.0 10119.9 10253.9 1783.2 1828.6 1874.9 1875.2 1894.3 73050.4 73306.6 74569.0 74669.0 77031.6 10649.1 10787.9 10824.6 10825.1 10873.9 13959.8 14419.2 14688.5 14715.2 14758.7 5864.7 5981.3 6697.7 7803.0 7942.1 7340.3 7457.8 7631.6 7671.8 7683.7 4505.9 4570.4 4576.2 4601.9 4694.4 1898.6 1920.0 1934.7 1937.4 1952.3 857.0 1028.2 1048.3 1049.2 1073.7 18600.3 18988.8 19101.2 19464.4 19552.9 942.8 944.9 948.6 962.4 994.6 9524.0 10871.6 10874.5 10899.3 10936.6 417377.0 418883.0 429125.0 437049.0 438529.0 52503.7 84722.8 85971.1 87602.0 88465.6 966.6 980.0 985.5 991.1 994.7 16297.9 16372.6 16818.3 17003.8 17188.9 38555.0 39854.4 40051.0 40328.0 42782.4 51412.7 52188.7 55121.7 56502.5 56565.7 8369.6 8392.0 8546.0 8573.6 8582.4 11883.6 12761.7 12967.2 13052.9 13281.9 10784.6 11288.1 11292.5 11514.8 11832.2 10953.8 11010.3 11050.5 11372.1 11558.4 11286.2 11392.3 11464.6 11468.7 11851.6 7876.4 8171.8 8316.9 8438.8 8506.3 10416.6 10647.6 11164.0 11212.8 11542.4 13:51:54 INFO - PROCESS | 31717 | 13:51:54 INFO - PROCESS | 31717 | [#3] mootools.html Cycles:180 Average:5561.71 Median:5138.37 stddev:3112.92 (60.6%) stddev-sans-first:3105.55 13:51:54 INFO - PROCESS | 31717 | Values: 1348.7 1446.9 1483.1 1591.6 1750.6 7403.4 8097.4 8379.8 8388.2 8583.3 8476.9 8539.3 8548.9 8550.3 8556.0 2323.4 2342.7 2348.0 2351.6 2351.6 2247.1 2317.2 2364.8 2365.8 2368.3 2286.0 2299.6 2323.4 2337.0 2341.8 2258.9 2272.8 2294.3 2304.0 2308.9 2275.5 2292.3 2292.8 2295.3 2295.9 8364.5 8396.9 8505.1 8515.5 8627.0 5226.8 5352.1 5359.7 5361.6 5363.6 3360.6 3446.4 3547.8 3619.0 3623.5 1089.5 1119.6 1137.7 1169.1 1181.6 11580.4 11611.9 11640.9 11702.1 11702.5 4147.1 4440.4 4507.6 4519.0 4542.5 9207.9 9271.8 9277.7 9283.0 9287.4 5038.6 5048.4 5052.1 5053.3 5060.8 4217.1 4378.6 4729.7 4804.7 4808.1 3548.6 3562.5 3596.6 3600.4 3649.8 1085.6 1090.2 1101.9 1103.1 1104.6 784.9 824.8 856.4 943.9 958.2 5580.8 5608.8 5777.7 5837.9 5989.7 882.2 938.6 945.4 981.2 986.1 3854.5 3897.8 3928.6 4017.6 4034.8 10326.0 10608.4 10657.7 10671.5 10681.3 10402.4 10517.5 10612.6 10620.5 10632.8 7860.5 7935.8 8040.4 8046.7 8060.4 5308.7 5596.6 5616.8 5725.0 5741.9 9154.8 9452.3 9478.6 9595.9 9596.0 9749.2 9751.2 9782.0 9839.6 9850.1 6307.0 6482.8 6992.1 7042.3 7160.6 8232.4 8251.9 8266.9 8283.8 8284.5 7131.4 7270.4 7303.4 7307.3 7328.6 7314.8 7346.4 7357.0 7443.4 7633.3 6697.0 6842.3 6845.7 6847.5 6850.9 4948.2 5061.7 5116.5 5160.2 5181.6 5043.3 5050.6 5108.6 5167.2 5175.5 13:51:54 INFO - PROCESS | 31717 | 13:51:54 INFO - PROCESS | 31717 | [#4] prototype.html Cycles:180 Average:4556.91 Median:5058.49 stddev:1319.94 (26.1%) stddev-sans-first:1284.76 13:51:54 INFO - PROCESS | 31717 | Values: 319.6 330.3 331.6 336.5 337.4 5049.9 5177.5 5208.0 5230.3 5277.2 5034.4 5090.6 5103.7 5125.2 5139.7 4096.3 4099.5 4106.1 4110.2 4119.0 3959.2 4112.6 4124.8 4128.0 4136.2 4062.9 4068.9 4073.9 4097.2 4100.8 4070.5 4073.6 4078.3 4080.8 4089.4 3657.9 3681.5 3691.5 3702.6 3721.7 4825.2 5032.5 5055.8 5057.3 5059.7 4641.8 4648.7 4652.0 4671.1 4676.9 5423.2 5441.2 5441.8 5454.7 5477.3 3928.5 3974.3 3991.2 4027.2 4028.3 5545.7 5619.9 5630.7 5645.7 5659.5 4075.3 4082.8 4092.5 4096.1 4098.3 3964.8 4073.6 4180.5 4185.1 4190.7 4680.3 4681.7 4692.4 4696.2 4702.5 5448.8 5457.1 5464.2 5502.9 5523.6 1337.8 1380.2 1401.2 1405.6 1437.8 922.2 923.2 954.8 957.3 964.5 4671.0 4679.5 4692.7 4693.3 4705.2 4895.2 4900.6 4901.9 4956.6 4960.9 4711.3 4728.1 4734.2 4746.4 4761.7 2857.9 2984.2 3002.5 3005.9 3012.2 5856.2 5860.4 5862.3 5873.4 5889.9 5408.3 5594.8 5614.2 5654.9 5691.9 5725.9 5792.6 5802.5 5817.4 5819.7 5557.7 5571.4 5585.6 5594.8 5598.9 5308.6 5515.5 5527.9 5537.7 5547.7 5751.5 5771.1 5846.9 5848.6 5861.9 3929.5 3951.5 3973.2 3983.9 4050.8 5351.8 5530.8 5541.5 5544.9 5558.6 5296.6 5337.7 5404.9 5412.5 5422.4 5386.4 5401.7 5405.5 5420.0 5421.7 5208.8 5404.8 5412.5 5414.4 5454.6 5477.8 5484.0 5492.5 5492.5 5493.7 5342.9 5348.8 5349.2 5350.7 5378.7 13:51:54 INFO - PROCESS | 31717 | 13:51:54 INFO - PROCESS | 31717 | [#5] yui.html Cycles:180 Average:16480.90 Median:585.53 stddev:21898.98 (3740.1%) stddev-sans-first:21928.39 13:51:54 INFO - PROCESS | 31717 | Values: 708.3 738.6 739.4 797.0 826.8 14141.6 14713.6 14737.0 14762.0 14860.0 13350.1 13449.3 13451.7 13462.7 13466.8 783.9 798.2 799.7 799.9 800.4 792.3 796.4 796.7 796.9 796.9 833.3 834.8 835.1 836.7 837.9 830.8 832.1 832.1 832.6 833.1 577.2 594.2 595.8 600.8 601.5 13675.2 13694.9 13710.8 13730.0 13735.5 12212.7 12250.7 12840.4 12936.3 13025.5 10262.5 12065.6 12190.4 12449.9 12976.4 4373.8 4395.3 4446.8 4475.9 4492.6 60460.7 62644.0 62659.0 62854.7 64397.7 10403.7 10451.7 10573.4 10713.1 10857.7 18046.0 18209.6 18247.9 18304.5 18308.4 7685.5 7776.0 7943.7 8008.2 8157.6 4452.4 4537.6 4541.3 4568.7 4608.2 3100.3 3192.3 3193.5 3196.6 3198.6 564.5 585.1 585.9 592.7 593.4 663.8 671.8 689.9 724.9 728.6 8772.6 8886.6 8958.3 9082.2 9227.8 560.3 571.4 580.9 592.6 726.9 4086.9 4262.4 4275.2 4280.4 4299.2 69392.0 80252.2 81337.6 81876.6 83128.6 45585.5 70914.6 71645.0 71852.6 72041.3 63251.7 63645.0 64033.0 64041.7 64484.4 7949.8 8147.8 8200.1 8212.9 8288.1 43976.0 44824.0 45479.0 45521.0 47555.3 58280.0 61034.7 61135.0 61639.4 62201.1 9073.4 9987.0 10026.2 10041.6 10320.6 10869.8 10923.7 11122.2 11299.8 11330.7 10815.2 10850.8 10984.2 10986.1 11220.0 10143.5 10171.8 10268.5 10362.4 11070.1 10244.5 10599.2 10826.4 11024.4 11101.6 8697.6 8839.6 8936.0 9181.8 9391.6 9313.7 9405.0 9571.3 9591.9 9772.6 13:51:54 INFO - PROCESS | 31717 | -------- Summary: end -------- 13:51:54 INFO - PROCESS | 31717 | 13:51:55 INFO - TEST-INFO | 31717: exit 0 13:51:55 INFO - TEST-OK | dromaeo_css | took 1118256ms 13:51:55 INFO - TEST-START | kraken 13:51:55 INFO - operating with platform_type : linux_ 13:51:55 INFO - Initialising browser for kraken test... 13:51:55 INFO - TEST-INFO | started process 32025 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptE2KMy/profile http://localhost:56071/getInfo.html) 13:51:59 INFO - PROCESS | 32025 | __metrics Screen width/height:1600/1200 13:51:59 INFO - PROCESS | 32025 | colorDepth:24 13:51:59 INFO - PROCESS | 32025 | Browser inner width/height: 1024/697 13:51:59 INFO - PROCESS | 32025 | __metrics 13:52:00 INFO - PROCESS | 32025 | 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" 13:52:00 INFO - PROCESS | 32025 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 205: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:52:00 INFO - PROCESS | 32025 | console.error: PushService: 13:52:00 INFO - PROCESS | 32025 | stateChangeProcessEnqueue: Error transitioning state 13:52:00 INFO - PROCESS | 32025 | UnknownError 13:52:01 INFO - TEST-INFO | 32025: exit 0 13:52:01 INFO - Browser initialized. 13:52:01 INFO - Running cycle 1/1 for kraken test... 13:52:01 INFO - TEST-INFO | started process 32109 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptE2KMy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:52:13 INFO - PROCESS | 32109 | RSS: Main: 174870528 13:52:13 INFO - PROCESS | 32109 | 13:52:16 INFO - PROCESS | 32109 | Cycle 1(1): loaded http://localhost:56071/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56071/tests/kraken/driver.html?testName=audio-beat-detection) 13:52:17 INFO - PROCESS | 32109 | RSS: Main: 239804416 13:52:17 INFO - PROCESS | 32109 | 13:52:19 INFO - PROCESS | 32109 | Cycle 1(1): loaded http://localhost:56071/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56071/tests/kraken/driver.html?testName=audio-dft) 13:52:20 INFO - PROCESS | 32109 | RSS: Main: 218017792 13:52:20 INFO - PROCESS | 32109 | 13:52:23 INFO - PROCESS | 32109 | Cycle 1(1): loaded http://localhost:56071/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56071/tests/kraken/driver.html?testName=audio-fft) 13:52:24 INFO - PROCESS | 32109 | RSS: Main: 299573248 13:52:24 INFO - PROCESS | 32109 | 13:52:26 INFO - PROCESS | 32109 | Cycle 1(1): loaded http://localhost:56071/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56071/tests/kraken/driver.html?testName=audio-oscillator) 13:52:26 INFO - PROCESS | 32109 | RSS: Main: 210923520 13:52:26 INFO - PROCESS | 32109 | 13:52:28 INFO - PROCESS | 32109 | Cycle 1(1): loaded http://localhost:56071/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56071/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:52:29 INFO - PROCESS | 32109 | RSS: Main: 213676032 13:52:29 INFO - PROCESS | 32109 | 13:52:32 INFO - PROCESS | 32109 | Cycle 1(1): loaded http://localhost:56071/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56071/tests/kraken/driver.html?testName=imaging-darkroom) 13:52:33 INFO - PROCESS | 32109 | RSS: Main: 250507264 13:52:33 INFO - PROCESS | 32109 | 13:52:36 INFO - PROCESS | 32109 | Cycle 1(1): loaded http://localhost:56071/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56071/tests/kraken/driver.html?testName=imaging-desaturate) 13:52:36 INFO - PROCESS | 32109 | RSS: Main: 248705024 13:52:36 INFO - PROCESS | 32109 | 13:52:39 INFO - PROCESS | 32109 | Cycle 1(1): loaded http://localhost:56071/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56071/tests/kraken/driver.html?testName=json-parse-financial) 13:52:40 INFO - PROCESS | 32109 | RSS: Main: 247676928 13:52:40 INFO - PROCESS | 32109 | 13:52:41 INFO - PROCESS | 32109 | Cycle 1(1): loaded http://localhost:56071/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56071/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:52:42 INFO - PROCESS | 32109 | RSS: Main: 210628608 13:52:42 INFO - PROCESS | 32109 | 13:52:44 INFO - PROCESS | 32109 | Cycle 1(1): loaded http://localhost:56071/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56071/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:52:44 INFO - PROCESS | 32109 | RSS: Main: 218226688 13:52:44 INFO - PROCESS | 32109 | 13:52:46 INFO - PROCESS | 32109 | Cycle 1(1): loaded http://localhost:56071/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56071/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:52:47 INFO - PROCESS | 32109 | RSS: Main: 227479552 13:52:47 INFO - PROCESS | 32109 | 13:52:49 INFO - PROCESS | 32109 | Cycle 1(1): loaded http://localhost:56071/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56071/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:52:50 INFO - PROCESS | 32109 | RSS: Main: 236199936 13:52:50 INFO - PROCESS | 32109 | 13:52:53 INFO - PROCESS | 32109 | Cycle 1(1): loaded http://localhost:56071/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56071/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:52:54 INFO - PROCESS | 32109 | RSS: Main: 233807872 13:52:54 INFO - PROCESS | 32109 | 13:52:55 INFO - PROCESS | 32109 | Cycle 1(1): loaded http://localhost:56071/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56071/tests/kraken/driver.html?testName=ai-astar) 13:52:56 INFO - PROCESS | 32109 | RSS: Main: 283140096 13:52:56 INFO - PROCESS | 32109 | 13:52:56 INFO - PROCESS | 32109 | __start_tp_report 13:52:56 INFO - PROCESS | 32109 | _x_x_mozilla_page_load 13:52:56 INFO - PROCESS | 32109 | _x_x_mozilla_page_load_details 13:52:56 INFO - PROCESS | 32109 | |i|pagename|runs| 13:52:56 INFO - PROCESS | 32109 | |0;ai-astar;106;111;112;111;111;113;111;111;112;111 13:52:56 INFO - PROCESS | 32109 | |1;audio-beat-detection;146;123;123;170;128;124;120;121;170;124 13:52:56 INFO - PROCESS | 32109 | |2;audio-dft;161;160;160;159;162;161;161;162;162;162 13:52:56 INFO - PROCESS | 32109 | |3;audio-fft;75;75;77;119;76;77;77;75;102;75 13:52:56 INFO - PROCESS | 32109 | |4;audio-oscillator;83;81;119;82;82;82;104;82;82;114 13:52:56 INFO - PROCESS | 32109 | |5;imaging-gaussian-blur;117;117;117;117;117;117;116;117;117;117 13:52:56 INFO - PROCESS | 32109 | |6;imaging-darkroom;145;146;146;146;146;146;145;146;145;146 13:52:56 INFO - PROCESS | 32109 | |7;imaging-desaturate;85;84;85;85;85;84;84;85;85;85 13:52:56 INFO - PROCESS | 32109 | |8;json-parse-financial;54;54;52;53;53;54;53;54;54;53 13:52:56 INFO - PROCESS | 32109 | |9;json-stringify-tinderbox;61;62;63;63;63;63;62;63;65;63 13:52:56 INFO - PROCESS | 32109 | |10;stanford-crypto-aes;87;80;80;80;81;90;80;80;80;79 13:52:56 INFO - PROCESS | 32109 | |11;stanford-crypto-ccm;130;132;133;132;133;134;132;135;170;131 13:52:56 INFO - PROCESS | 32109 | |12;stanford-crypto-pbkdf2;172;168;164;167;167;168;172;166;168;167 13:52:56 INFO - PROCESS | 32109 | |13;stanford-crypto-sha256-iterative;66;65;64;67;65;64;65;66;63;64 13:52:56 INFO - PROCESS | 32109 | __end_tp_report 13:52:56 INFO - PROCESS | 32109 | __start_cc_report 13:52:56 INFO - PROCESS | 32109 | _x_x_mozilla_cycle_collect,1690 13:52:56 INFO - PROCESS | 32109 | __end_cc_report 13:52:56 INFO - PROCESS | 32109 | __startTimestamp1477860776040__endTimestamp 13:52:56 INFO - PROCESS | 32109 | 13:52:56 INFO - PROCESS | 32109 | ------- Summary: start ------- 13:52:56 INFO - PROCESS | 32109 | Number of tests: 14 13:52:56 INFO - PROCESS | 32109 | 13:52:56 INFO - PROCESS | 32109 | [#0] ai-astar Cycles:10 Average:110.90 Median:111.00 stddev:1.85 (1.7%) stddev-sans-first:0.73 13:52:56 INFO - PROCESS | 32109 | Values: 106.0 111.0 112.0 111.0 111.0 113.0 111.0 111.0 112.0 111.0 13:52:56 INFO - PROCESS | 32109 | 13:52:56 INFO - PROCESS | 32109 | [#1] audio-beat-detection Cycles:10 Average:134.90 Median:126.00 stddev:19.92 (15.8%) stddev-sans-first:20.72 13:52:56 INFO - PROCESS | 32109 | Values: 146.0 123.0 123.0 170.0 128.0 124.0 120.0 121.0 170.0 124.0 13:52:56 INFO - PROCESS | 32109 | 13:52:56 INFO - PROCESS | 32109 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.50 stddev:1.05 (0.7%) stddev-sans-first:1.12 13:52:56 INFO - PROCESS | 32109 | Values: 161.0 160.0 160.0 159.0 162.0 161.0 161.0 162.0 162.0 162.0 13:52:56 INFO - PROCESS | 32109 | 13:52:56 INFO - PROCESS | 32109 | [#3] audio-fft Cycles:10 Average:82.80 Median:75.50 stddev:15.16 (20.1%) stddev-sans-first:15.82 13:52:56 INFO - PROCESS | 32109 | Values: 75.0 75.0 77.0 119.0 76.0 77.0 77.0 75.0 102.0 75.0 13:52:56 INFO - PROCESS | 32109 | 13:52:56 INFO - PROCESS | 32109 | [#4] audio-oscillator Cycles:10 Average:91.10 Median:82.00 stddev:15.10 (18.4%) stddev-sans-first:15.72 13:52:56 INFO - PROCESS | 32109 | Values: 83.0 81.0 119.0 82.0 82.0 82.0 104.0 82.0 82.0 114.0 13:52:56 INFO - PROCESS | 32109 | 13:52:56 INFO - PROCESS | 32109 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 13:52:56 INFO - PROCESS | 32109 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 13:52:56 INFO - PROCESS | 32109 | 13:52:56 INFO - PROCESS | 32109 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 13:52:56 INFO - PROCESS | 32109 | Values: 145.0 146.0 146.0 146.0 146.0 146.0 145.0 146.0 145.0 146.0 13:52:56 INFO - PROCESS | 32109 | 13:52:56 INFO - PROCESS | 32109 | [#7] imaging-desaturate Cycles:10 Average:84.70 Median:85.00 stddev:0.48 (0.6%) stddev-sans-first:0.50 13:52:56 INFO - PROCESS | 32109 | Values: 85.0 84.0 85.0 85.0 85.0 84.0 84.0 85.0 85.0 85.0 13:52:56 INFO - PROCESS | 32109 | 13:52:56 INFO - PROCESS | 32109 | [#8] json-parse-financial Cycles:10 Average:53.40 Median:54.00 stddev:0.70 (1.3%) stddev-sans-first:0.71 13:52:56 INFO - PROCESS | 32109 | Values: 54.0 54.0 52.0 53.0 53.0 54.0 53.0 54.0 54.0 53.0 13:52:56 INFO - PROCESS | 32109 | 13:52:56 INFO - PROCESS | 32109 | [#9] json-stringify-tinderbox Cycles:10 Average:62.80 Median:63.00 stddev:1.03 (1.6%) stddev-sans-first:0.87 13:52:56 INFO - PROCESS | 32109 | Values: 61.0 62.0 63.0 63.0 63.0 63.0 62.0 63.0 65.0 63.0 13:52:56 INFO - PROCESS | 32109 | 13:52:56 INFO - PROCESS | 32109 | [#10] stanford-crypto-aes Cycles:10 Average:81.70 Median:80.00 stddev:3.68 (4.6%) stddev-sans-first:3.37 13:52:56 INFO - PROCESS | 32109 | Values: 87.0 80.0 80.0 80.0 81.0 90.0 80.0 80.0 80.0 79.0 13:52:56 INFO - PROCESS | 32109 | 13:52:56 INFO - PROCESS | 32109 | [#11] stanford-crypto-ccm Cycles:10 Average:136.20 Median:133.00 stddev:11.96 (9.0%) stddev-sans-first:12.47 13:52:56 INFO - PROCESS | 32109 | Values: 130.0 132.0 133.0 132.0 133.0 134.0 132.0 135.0 170.0 131.0 13:52:56 INFO - PROCESS | 32109 | 13:52:56 INFO - PROCESS | 32109 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.90 Median:168.00 stddev:2.47 (1.5%) stddev-sans-first:2.13 13:52:56 INFO - PROCESS | 32109 | Values: 172.0 168.0 164.0 167.0 167.0 168.0 172.0 166.0 168.0 167.0 13:52:56 INFO - PROCESS | 32109 | 13:52:56 INFO - PROCESS | 32109 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.90 Median:65.00 stddev:1.20 (1.8%) stddev-sans-first:1.20 13:52:56 INFO - PROCESS | 32109 | Values: 66.0 65.0 64.0 67.0 65.0 64.0 65.0 66.0 63.0 64.0 13:52:56 INFO - PROCESS | 32109 | -------- Summary: end -------- 13:52:56 INFO - PROCESS | 32109 | 13:52:57 INFO - TEST-INFO | 32109: exit 0 13:52:57 INFO - TEST-OK | kraken | took 62148ms 13:52:57 INFO - SUITE-END | took 1180s 13:52:57 INFO - Completed test suite (00:19:40) 13:52:57 INFO - javascript benchmark 13:52:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2918.460084884296, 2935.5303151495764, 2974.2564358910267, 2983.388405376898, 2998.775091868109, 5052.6210534209895, 5125.436202017775, 5217.269582258482, 5245.527902488775, 5401.243825864382, 5144.09978253805, 5159.303494028305, 5170.0, 5176.352955880515, 5177.870553236171, 4688.179568575494, 4716.90566188676, 4727.81088756451, 4767.404074490689, 4787.353707249512, 4773.307870358796, 4856.514348565133, 4897.338859254009, 4948.802047918079, 4959.404871415417, 4937.827176048839, 4957.281194226835, 4963.726995015273, 4964.106460837048, 5029.47190544993, 4851.3450684157715, 4921.8523444296725, 5023.171176755831, 5024.899502009976, 5024.9748751256375, 4611.26219804833, 4829.420469543677, 4840.903181936377, 4885.8778530536665, 4887.315775791392, 5067.417247016567, 5111.667741596784, 5164.302819119408, 5164.948350516522, 5165.535101840815, 5441.129419292934, 5449.56403487724, 5453.400125986138, 5462.617616766828, 5463.31708536433, 5471.835844924659, 5492.093804522249, 5495.6427832191175, 5497.120460726264, 5503.862403439906, 5112.309838171836, 5113.974430127862, 5122.0, 5124.0, 5129.9230511542355, 5621.915671264935, 5624.943750562524, 5627.352854421794, 5628.831135065954, 5630.5495560355075, 5385.865353366197, 5415.48552887475, 5415.5938304626525, 5420.430854760272, 5424.213489044146, 5576.33084029919, 5587.357453892854, 5588.972055139699, 5589.552835773128, 5599.580031497572, 5596.188552659842, 5606.495415412633, 5613.691246981455, 5620.1288800236025, 5634.239377684042, 5388.595855310868, 5428.104362780097, 5525.668459892419, 5561.610687251934, 5628.915566266509, 4280.785960701953, 4301.075268817157, 4320.870373888725, 4348.434703488526, 4412.029353542215, 3805.353089974711, 3827.559830619459, 3834.405667121601, 3849.942250866239, 3881.7088718346236, 5129.12804823181, 5182.455842136596, 5301.098813201765, 5313.495217954288, 5323.254744335796, 5586.1062230043, 5602.159676048544, 5616.1014237721765, 5645.604807663424, 5679.744411501492, 5284.048871203144, 5307.150855863043, 5326.174442961347, 5330.093884039723, 5390.946090539122, 4717.599004084623, 4768.880777980578, 4844.660873738875, 4847.151748444008, 4903.754812259444, 5934.554908381802, 5940.910886336795, 5979.252593425822, 5981.641101533922, 5989.041753319448, 5688.77244910199, 5689.8620275945805, 5691.516221121251, 5696.515796157208, 5710.628809127394, 5603.551715862803, 5657.32112146545, 5882.117682347682, 5882.882342353215, 5902.822915312548, 5398.217258497574, 5407.864803379947, 5471.480209380103, 5493.890122197454, 5540.418256083053, 5521.365043020104, 5547.389787123332, 5572.526335261548, 5573.0, 5575.972120139373, 5378.381486128988, 5442.945570544244, 5452.727363631882, 5453.454654534515, 5508.669479831223, 5365.248865158959, 5416.133418653154, 5514.91727624094, 5522.502974732293, 5535.39110697831, 5516.393196748274, 5536.7231638418725, 5542.75057622416, 5559.24950131727, 5579.609427340048, 5393.325834270716, 5438.619296649196, 5452.5365343946205, 5602.047651899105, 5624.662520248635, 5331.200319952039, 5355.116405793001, 5368.8389348319615, 5370.03339398912, 5408.080626293461], "value": 5162.124744616697, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [553.899616494113, 584.5644994479112, 586.7066466766616, 590.6397097770362, 605.5851741557033, 29656.0, 30562.0, 40581.188376232494, 41304.79347603258, 41400.17199656005, 39369.21261574767, 43536.0, 43618.78190609042, 43627.3455898161, 43665.7816710916, 7798.2981531662135, 8643.438176518523, 8790.956045219766, 8805.95597022014, 8809.03100658927, 7838.529688218697, 10246.231532635082, 10445.634402795904, 10457.79084418315, 10795.946020269888, 10573.524191411367, 10616.150707943347, 10639.414832184228, 10643.04212620864, 10645.14838812897, 10421.531031103581, 10472.790544189074, 10492.16062714981, 10553.102986246178, 10561.471926403648, 10508.422036787973, 10568.471576421149, 10575.259731818776, 10589.205809564313, 10590.152787776959, 40703.7964810177, 41154.79422602868, 41185.1762964742, 41206.1758764823, 41208.1758364834, 3352.0, 3367.5453813735076, 3371.2077661749468, 3372.140104273419, 3424.7088997435, 30463.23841903948, 30649.540256896165, 30740.0, 30943.535846962313, 32401.83799081013, 4353.673474489395, 4375.343698445226, 4380.912381752379, 4387.824487020547, 4461.888452788674, 310061.0, 310538.99999999773, 310932.0, 311188.0, 312197.0, 53156.468435315925, 53434.73282633562, 53476.0, 53543.19685204725, 53564.73217633965, 34100.82949585236, 34532.82733586316, 34677.0, 37305.0, 57228.42771572314, 15572.143532105616, 15720.21398930049, 15728.528144155694, 15742.68514629701, 15749.370025199092, 10852.67441976742, 11057.612983545538, 11672.94163529194, 12057.638270851712, 12140.817887731691, 17323.0, 18088.186031628607, 18160.364387246384, 18173.54566135831, 18362.173702183434, 6772.729090836311, 6896.2069362023, 6898.792386436393, 7027.367536921702, 7190.928090719026, 871.329076611006, 974.1281553010016, 1014.1734486393566, 1027.4503140819625, 1135.1543100390097, 30984.22539436532, 31925.361492770015, 32059.0, 32098.67901320957, 32166.678333216838, 1080.6055789636725, 1088.515610553312, 1116.0346300450053, 1147.002108165901, 1157.7047852797482, 16135.354585816436, 16639.0, 16765.32938682439, 16873.746893796604, 17048.06235657026, 529978.0, 532578.0, 532864.0, 532948.0, 541122.0, 37473.43789843155, 55838.16242756362, 56020.15969760457, 56114.0, 56194.438055619736, 1185.6146752305535, 1233.0690328801697, 1281.7052078022107, 1296.3323888197585, 1313.5665230473921, 28519.572206417335, 31988.840055799574, 32171.356572867942, 32274.158876168764, 32878.34243315073, 47244.527554724016, 48005.51994480011, 48059.75970120127, 48107.518924810305, 48155.0, 396717.0, 396846.0, 398963.0, 400080.0, 401092.0, 26056.73943260543, 26922.730772692023, 26993.0, 28430.715692843634, 28626.28434289076, 44614.3307850376, 45365.0, 45370.773146135376, 45773.54226457693, 46779.29831052469, 39191.41212881752, 39244.80377598094, 39600.60399395969, 39694.60305396909, 41210.0, 38858.0, 39754.602453976244, 39785.40321895232, 39932.80033599814, 41066.58933410628, 39085.2182956345, 39634.603653964245, 40065.0, 40606.0, 41063.794681026404, 32435.0, 34657.30685386329, 35297.0, 36139.0, 36267.81866090652, 26895.0, 26948.0, 27058.72941270562, 27696.72303277022, 29219.561706573993], "value": 19456.44015561353, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [348.84999450236387, 371.4947671167212, 383.63554623108047, 388.07444245474534, 404.7571457125725, 14007.789883151761, 17646.294148234072, 18054.548636284082, 18925.905370473127, 20313.18747250112, 16240.918795406036, 18309.542261443472, 18724.344647937323, 18743.15655795489, 19051.809481905213, 4973.676711013782, 5248.8687782805355, 5249.921251181236, 5250.264962905197, 5272.683638981654, 3880.3985382265796, 4067.0849058961644, 5130.281760553526, 5209.0, 5215.71313577755, 3969.0474286171257, 6209.0, 6232.0, 6301.1808464899495, 6302.338254483282, 5591.496765291103, 5683.801066962677, 6196.008638617845, 6273.3412991635905, 6276.623402595836, 5509.47659972302, 5524.889502209973, 5529.060059789846, 5532.917006244909, 5534.833954981316, 13451.932740336235, 13579.86420135796, 13671.384787684578, 13689.931550342184, 13706.725865482635, 2125.011869480699, 2331.1724337859987, 2348.835581509295, 2365.6333268343433, 2395.988020059906, 9705.854412183753, 9721.562529686182, 9821.950890245575, 10119.949400253025, 10253.897461025368, 1783.179737320834, 1828.5977085041402, 1874.9156287967073, 1875.1561797191318, 1894.2612381171355, 73050.36706856411, 73306.63346683286, 74569.0, 74669.0, 77031.614841926, 10649.148068154529, 10787.946060269649, 10824.621138260123, 10825.079868211133, 10873.891261087447, 13959.79060314096, 14419.206943617992, 14688.485902993343, 14715.247611858907, 14758.704825903422, 5864.70676466175, 5981.252343457068, 6697.6986035628515, 7802.960985195038, 7942.126366099725, 7340.265973402617, 7457.776266712007, 7631.618419079024, 7671.846563068819, 7683.654235559413, 4505.932411013838, 4570.405847239837, 4576.153411618861, 4601.930971035437, 4694.36626055485, 1898.6297671953837, 1919.9616007679767, 1934.6517626827306, 1937.3800383877306, 1952.3264473756815, 856.9571521423904, 1028.2339656955467, 1048.2662136504478, 1049.150188347441, 1073.6993641780314, 18600.348987785634, 18988.810111898703, 19101.2359505621, 19464.416067517996, 19552.90223548873, 942.844430668932, 944.8866136063579, 948.5684013773716, 962.4177372689422, 994.6071301835734, 9524.0, 10871.619493317696, 10874.510647020903, 10899.29154604948, 10936.56253749857, 417377.0, 418883.0, 429125.0, 437049.0, 438529.0, 52503.73748131311, 84722.78892947051, 85971.14028859757, 87602.0, 88465.55767221123, 966.6036924860773, 979.9755006124761, 985.5023213277249, 991.0535438656066, 994.721477986165, 16297.918510407371, 16372.590685232964, 16818.309070548654, 17003.829961700223, 17188.914055430145, 38555.0, 39854.40218396668, 40051.0, 40328.0, 42782.358264625436, 51412.74293628508, 52188.739056304476, 55121.724391377786, 56502.502212246116, 56565.71717141388, 8369.623366948625, 8392.0, 8545.957270213608, 8573.61418736146, 8582.399232053696, 11883.643490695293, 12761.744765104831, 12967.157134786208, 13052.869471305165, 13281.867181328449, 10784.622538211439, 11288.096952243965, 11292.491837867152, 11514.76970460603, 11832.230904991147, 10953.83569246446, 11010.339379637247, 11050.502727377127, 11372.090232781193, 11558.364289964133, 11286.153538484483, 11392.25950313227, 11464.598739044093, 11468.655940321803, 11851.585194518151, 7876.448648594544, 8171.79570510742, 8316.875246871423, 8438.83122337562, 8506.319494440306, 10416.635417760343, 10647.574097036031, 11164.0, 11212.775744484901, 11542.365169915734], "value": 8687.323354497079, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1348.6898013456898, 1446.8914831387644, 1483.110133919648, 1591.586187591226, 1750.6411185706932, 7403.370713489353, 8097.352211823055, 8379.790505237357, 8388.161183881617, 8583.27042201412, 8476.872846907301, 8539.316854651628, 8548.871766923485, 8550.315974722023, 8556.016058153315, 2323.4191452136965, 2342.7071616047992, 2347.978629296253, 2351.600227961242, 2351.6002279612508, 2247.1123906057096, 2317.154238702878, 2364.798992085675, 2365.7989070928993, 2368.3131891751373, 2285.954280914389, 2299.5515874404496, 2323.384303159664, 2336.9649455258186, 2341.8126549876056, 2258.9435264118365, 2272.8068114210314, 2294.300238427279, 2303.965440518402, 2308.9307320780404, 2275.5107651854764, 2292.3123063081175, 2292.79364857162, 2295.3343530376337, 2295.91964281251, 8364.539950302731, 8396.916030839675, 8505.149485051506, 8515.489070655718, 8627.0, 5226.7909283628605, 5352.143657014898, 5359.705216213107, 5361.624686271963, 5363.597730170253, 3360.6135294441206, 3446.4141096013486, 3547.822608869546, 3619.0228638267786, 3623.547056617923, 1089.515165751241, 1119.641714651312, 1137.6530158301714, 1169.1060482019184, 1181.5982565927625, 11580.420978951019, 11611.883881161164, 11640.883591164065, 11702.122340824388, 11702.53189872404, 4147.149834283965, 4440.444944381952, 4507.6168525675685, 4519.0, 4542.500324964251, 9207.861882071775, 9271.814563708824, 9277.675281365255, 9282.953585232031, 9287.396319239228, 5038.571721403649, 5048.368953880765, 5052.065367906949, 5053.267276244924, 5060.84817455477, 4217.072244106353, 4378.64970802335, 4729.716217026989, 4804.663673542818, 4808.0624278266105, 3548.574171099433, 3562.5012498250267, 3596.5684117906017, 3600.4419315006216, 3649.7627654202392, 1085.56577369053, 1090.2204923479592, 1101.8512500812449, 1103.0734183286079, 1104.6133853151493, 784.8822676598442, 824.8102936324678, 856.3662889461754, 943.9150476457152, 958.2094771813282, 5580.776768929198, 5608.803691870765, 5777.653340799481, 5837.94162058374, 5989.670568118708, 882.2148288023664, 938.558877327655, 945.3760518058049, 981.1513041219293, 986.0927946289431, 3854.49891514107, 3897.7661340319673, 3928.587498312636, 4017.5580686124504, 4034.798260086984, 10326.0, 10608.416537090534, 10657.680269591925, 10671.519781609846, 10681.305715128492, 10402.427866467266, 10517.52671129801, 10612.57549698019, 10620.522076506575, 10632.840507392395, 7860.528368297921, 7935.841283174304, 8040.437169398086, 8046.718364857202, 8060.395470339748, 5308.681479111266, 5596.552275817843, 5616.803411880564, 5725.0, 5741.885162296814, 9154.771130721785, 9452.338336316392, 9478.620855165716, 9595.856062158933, 9595.952020239854, 9749.220062395134, 9751.219902407649, 9782.0, 9839.557219925264, 9850.113489785954, 6306.9950581380235, 6482.773102941374, 6992.1259842519685, 7042.260562641054, 7160.57036577807, 8232.423730338818, 8251.917480825115, 8266.917330826614, 8283.83432331338, 8284.50292982423, 7131.358177764027, 7270.382017528569, 7303.415726741954, 7307.3423391894985, 7328.633568321456, 7314.817129571803, 7346.449016323691, 7357.0, 7443.441741869273, 7633.313001829862, 6697.0, 6842.349976752201, 6845.657717114224, 6847.520673552804, 6850.9314906850295, 4948.208286674115, 5061.6962982221185, 5116.513931176532, 5160.225966105114, 5181.611379146504, 5043.319151914445, 5050.646454748133, 5108.565771909281, 5167.199084141964, 5175.4565770593545], "value": 4472.088536792447, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [319.56858241374147, 330.2981165024323, 331.55737090983536, 336.46837995966376, 337.35901786605433, 5049.949500504994, 5177.482251774821, 5208.0, 5230.29391032211, 5277.208418737191, 5034.395872495296, 5090.567301779353, 5103.728840665905, 5125.2312153177045, 5139.6893792082965, 4096.262672718909, 4099.528554216258, 4106.140228185511, 4110.239605672945, 4119.0, 3959.227950549644, 4112.609302116294, 4124.793760311973, 4128.02991297045, 4136.193442278757, 4062.8577999770014, 4068.8982775430554, 4073.87778366648, 4097.242010228102, 4100.835966561334, 4070.4911886014247, 4073.5519092899904, 4078.3474644057105, 4080.775557344345, 4089.44792453018, 3657.8719744808805, 3681.4845921571, 3691.464737613031, 3702.5927148013698, 3721.702263818915, 4825.155597770411, 5032.471590482984, 5055.848324550269, 5057.2666963290485, 5059.7097740076415, 4641.839540114971, 4648.674592778507, 4652.0, 4671.11248862715, 4676.883077923045, 5423.2136340230445, 5441.211024401479, 5441.755121019563, 5454.672719636835, 5477.3427188737205, 3928.5482169550583, 3974.3044967130636, 3991.1818077294083, 4027.2280196713355, 4028.3353246714255, 5545.72271386429, 5619.8595035124445, 5630.662160270397, 5645.745941432604, 5659.462351076641, 4075.347944328893, 4082.81627326771, 4092.46797916269, 4096.0508433927525, 4098.282800509899, 3964.801759911993, 4073.572274911151, 4180.456540649696, 4185.121124563876, 4190.748555086705, 4680.3447517347595, 4681.742504162304, 4692.41344831896, 4696.178168820443, 4702.506236845151, 5448.809291674773, 5457.144570845931, 5464.23500709901, 5502.9174562381595, 5523.613347065667, 1337.7592033434075, 1380.2270728392132, 1401.1733077484332, 1405.620482469748, 1437.8490258522913, 922.2477293142948, 923.2244914272044, 954.7565370830393, 957.2724729205854, 964.4695417520476, 4670.976645116821, 4679.532046795293, 4692.671512994058, 4693.319468677023, 4705.223638099744, 4895.241237608177, 4900.583450406684, 4901.852944411673, 4956.628252881048, 4960.90078198434, 4711.327478745065, 4728.1252968201, 4734.183161019188, 4746.406699162605, 4761.714297142183, 2857.9142625720847, 2984.2241017335214, 3002.4745669507747, 3005.9398812023637, 3012.201766531871, 5856.180134781134, 5860.413958604106, 5862.303340463434, 5873.353931067579, 5889.911651325234, 5408.269883565668, 5594.804181853616, 5614.214010038598, 5654.858628534237, 5691.946989806899, 5725.883452726678, 5792.580817699691, 5802.506786923074, 5817.44734250254, 5819.73811178498, 5557.722113894209, 5571.4428557143965, 5585.5531557476115, 5594.832155035356, 5598.944010560005, 5308.628396012242, 5515.531179849758, 5527.894421115873, 5537.667739935617, 5547.722613869371, 5751.511121554715, 5771.105478650816, 5846.883062338815, 5848.561357898089, 5861.853453663522, 3929.528456585228, 3951.4863067802153, 3973.165635216637, 3983.92032159361, 4050.7569545827346, 5351.785928562814, 5530.806421775219, 5541.473560011793, 5544.944550554443, 5558.555315574825, 5296.602754793329, 5337.706426146599, 5404.918926216032, 5412.539934105487, 5422.430644782241, 5386.353637563518, 5401.729913504388, 5405.486478784509, 5420.0, 5421.701806400686, 5208.8437346879655, 5404.83785486436, 5412.485813847678, 5414.377346605191, 5454.618176727591, 5477.780888764405, 5483.99834060573, 5492.533134683436, 5492.5331346835965, 5493.670379777226, 5342.8931421372135, 5348.786048558014, 5349.170878513836, 5350.652207606493, 5378.677279363251], "value": 4139.884436221655, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [708.2846325211535, 738.6417587470077, 739.4269441183086, 796.9521828690279, 826.7602395305364, 14141.575752727422, 14713.558593242193, 14737.0, 14762.0, 14860.0, 13350.0654954153, 13449.327533623304, 13451.730965380686, 13462.663433414169, 13466.797998030037, 783.9490433121844, 798.1938242375185, 799.6721344248859, 799.9120096789349, 800.4196957206037, 792.3265224559136, 796.3549524884833, 796.7052190689424, 796.8725003999361, 796.8884356190138, 833.2875391540207, 834.7829564313262, 835.0563862834988, 836.6611522333434, 837.9371547133959, 830.7881490220016, 832.0597724571226, 832.0597724571226, 832.5753865528563, 833.1418638802013, 577.2466930655493, 594.168164569606, 595.7795615622248, 600.7626987339976, 601.5067644531485, 13675.247861367621, 13694.863051369459, 13710.794338084937, 13730.0, 13735.45058197671, 12212.694682632917, 12250.693732656666, 12840.357982100857, 12936.28850413227, 13025.478980840755, 10262.486875656263, 12065.577704780291, 12190.39048047603, 12449.875501244962, 12976.351182440934, 4373.846915357947, 4395.340698895159, 4446.844360447401, 4475.865724028285, 4492.573205545468, 60460.69769651123, 62644.0, 62659.0, 62854.68572657153, 64397.67801161011, 10403.739906502247, 10451.68644940653, 10573.418461984666, 10713.142948564097, 10857.728556786144, 18046.0, 18209.63580728378, 18247.908760456114, 18304.450866474028, 18308.359207427944, 7685.500442471333, 7776.0, 7943.682252709827, 8008.239217274349, 8157.632906519102, 4452.443444569429, 4537.6143027842345, 4541.250693635513, 4568.725876447424, 4608.2166031774, 3100.3179300553843, 3192.2817366092445, 3193.5209718542405, 3196.6164060312913, 3198.648148703641, 564.4750382144563, 585.1486087742325, 585.9033259512217, 592.6977241606811, 593.4095574902913, 663.7643636509066, 671.7917445591883, 689.8965155226756, 724.9311315425026, 728.6101935464501, 8772.649094036295, 8886.60010299538, 8958.328125390492, 9082.18260356558, 9227.815443691223, 560.3360018378235, 571.3971759793458, 580.8576898659855, 592.5703864698146, 726.8727972604773, 4086.892672863753, 4262.403263543107, 4275.1663425631705, 4280.422143010716, 4299.1831552005015, 69392.0, 80252.19747802564, 81337.59331203306, 81876.59061704653, 83128.58435707903, 45585.54414455879, 70914.64542677253, 71645.0, 71852.64073679598, 72041.27958720346, 63251.68374158192, 63645.0, 64033.0, 64041.67979160074, 64484.35515644877, 7949.8410031797885, 8147.837043258983, 8200.138985406445, 8212.917870821215, 8288.129746376544, 43976.0, 44824.0, 45479.0, 45521.0, 47555.28667069927, 58280.0, 61034.694826525585, 61135.0, 61639.38360616336, 62201.06698399437, 9073.410228335137, 9987.0, 10026.248031397528, 10041.648542300984, 10320.587176513156, 10869.836952445878, 10923.726906827393, 11122.221444498808, 11299.830502542303, 11330.660080197607, 10815.188860835311, 10850.78298434011, 10984.176186785864, 10986.066184374098, 11219.990200881959, 10143.492825358555, 10171.847422288523, 10268.537915793957, 10362.430066346424, 11070.059044980944, 10244.53899574506, 10599.205059620404, 10826.40454774995, 11024.393658348547, 11101.5559377624, 8697.608607612547, 8839.558022098998, 8935.955320223356, 9181.77045573866, 9391.577379017825, 9313.696082548584, 9404.955868976405, 9571.28215383835, 9591.9040809591, 9772.558346960124], "value": 6649.350810480816, "unit": "score"}], "name": "dromaeo_css", "value": 6894.724617729529, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 111.0, 112.0, 111.0, 111.0, 113.0, 111.0, 111.0, 112.0, 111.0], "value": 110.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 123.0, 123.0, 170.0, 128.0, 124.0, 120.0, 121.0, 170.0, 124.0], "value": 134.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 160.0, 159.0, 162.0, 161.0, 161.0, 162.0, 162.0, 162.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 77.0, 119.0, 76.0, 77.0, 77.0, 75.0, 102.0, 75.0], "value": 82.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 81.0, 119.0, 82.0, 82.0, 82.0, 104.0, 82.0, 82.0, 114.0], "value": 91.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0, 146.0, 145.0, 146.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 85.0, 85.0, 85.0, 84.0, 84.0, 85.0, 85.0, 85.0], "value": 84.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 52.0, 53.0, 53.0, 54.0, 53.0, 54.0, 54.0, 53.0], "value": 53.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 63.0, 63.0, 63.0, 63.0, 62.0, 63.0, 65.0, 63.0], "value": 62.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 80.0, 80.0, 80.0, 81.0, 90.0, 80.0, 80.0, 80.0, 79.0], "value": 81.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 132.0, 133.0, 132.0, 133.0, 134.0, 132.0, 135.0, 170.0, 131.0], "value": 136.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 168.0, 164.0, 167.0, 167.0, 168.0, 172.0, 166.0, 168.0, 167.0], "value": 167.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 64.0, 67.0, 65.0, 64.0, 65.0, 66.0, 63.0, 64.0], "value": 64.9, "unit": "score"}], "name": "kraken", "value": 1494.9000000000003, "alertThreshold": 2.0}]} 13:52:57 INFO - Return code: 0 13:52:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:52:57 INFO - # TBPL SUCCESS # 13:52:57 INFO - Running post-action listener: _resource_record_post_action 13:52:57 INFO - [mozharness: 2016-10-30 20:52:57.845269Z] Finished run-tests step (success) 13:52:57 INFO - Running post-run listener: _resource_record_post_run 13:52:57 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 4096; Write bytes: 399134720; Read time: 12; Write time: 253240 13:52:57 INFO - TinderboxPrint: CPU usage
13.1% 13:52:57 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 13:52:57 INFO - TinderboxPrint: I/O write bytes / time
399,134,720 / 253,240 13:52:57 INFO - TinderboxPrint: CPU idle
8,306.3 (86.9%) 13:52:57 INFO - TinderboxPrint: CPU user
1,200.4 (12.6%) 13:52:57 INFO - TinderboxPrint: Swap in / out
0 / 0 13:52:57 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 110436352; Read time: 0; Write time: 81976 13:52:57 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 0; Write bytes: 288247808; Read time: 0; Write time: 171260 13:52:58 INFO - Running post-run listener: _upload_blobber_files 13:52:58 INFO - Blob upload gear active. 13:52:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:52:58 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 13:52:58 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'] 13:52:58 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 13:52:58 INFO - (blobuploader) - INFO - Open directory for files ... 13:52:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:52:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:52:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:53:02 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:53:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:53:02 INFO - (blobuploader) - INFO - Done attempting. 13:53:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:53:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:53:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:53:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:53:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:53:03 INFO - (blobuploader) - INFO - Done attempting. 13:53:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:53:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:53:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:53:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:53:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:53:04 INFO - (blobuploader) - INFO - Done attempting. 13:53:04 INFO - (blobuploader) - INFO - Iteration through files over. 13:53:04 INFO - Return code: 0 13:53:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:53:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:53:04 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/39836b1fb683f8ac2f3ae81a7b133808c46ee875189650c41c1a2b7fb187930ea6bc46cb9e0158f5aaa5f2414dd81f8ca67acdf25720c43f07af21f0ff934a10", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/57d59fb553d5d74addd7198fed449283bf3e51fc8e6edb634ea2c9736837bdb62d5802324030a4f6d5b715f389f5d8d26ea4b4bf481f9784844233076a80eba5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/50d89f52a390f7db2826c6c96a093a3e3be7697e0a3c32d25d978076f1df0466a918a529dd6cbf972eb139db6041a881e11163963fff9b9d45651db3b887fba5"} 13:53:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:53:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:53:04 INFO - Contents: 13:53:04 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/39836b1fb683f8ac2f3ae81a7b133808c46ee875189650c41c1a2b7fb187930ea6bc46cb9e0158f5aaa5f2414dd81f8ca67acdf25720c43f07af21f0ff934a10", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/57d59fb553d5d74addd7198fed449283bf3e51fc8e6edb634ea2c9736837bdb62d5802324030a4f6d5b715f389f5d8d26ea4b4bf481f9784844233076a80eba5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/50d89f52a390f7db2826c6c96a093a3e3be7697e0a3c32d25d978076f1df0466a918a529dd6cbf972eb139db6041a881e11163963fff9b9d45651db3b887fba5"} 13:53:04 INFO - Running post-run listener: copy_logs_to_upload_dir 13:53:04 INFO - Copying logs to upload dir... 13:53:04 INFO - mkdir: /builds/slave/test/build/upload/logs 13:53:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.674100 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-10-30 13:53:04.091720) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-30 13:53:04.094870) ========= 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=d2a8c569965ab8367867b893000001a1-1477859543.255758-352965245 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/39836b1fb683f8ac2f3ae81a7b133808c46ee875189650c41c1a2b7fb187930ea6bc46cb9e0158f5aaa5f2414dd81f8ca67acdf25720c43f07af21f0ff934a10", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/57d59fb553d5d74addd7198fed449283bf3e51fc8e6edb634ea2c9736837bdb62d5802324030a4f6d5b715f389f5d8d26ea4b4bf481f9784844233076a80eba5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/50d89f52a390f7db2826c6c96a093a3e3be7697e0a3c32d25d978076f1df0466a918a529dd6cbf972eb139db6041a881e11163963fff9b9d45651db3b887fba5"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477747962/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011356 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477747962/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/39836b1fb683f8ac2f3ae81a7b133808c46ee875189650c41c1a2b7fb187930ea6bc46cb9e0158f5aaa5f2414dd81f8ca67acdf25720c43f07af21f0ff934a10", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/57d59fb553d5d74addd7198fed449283bf3e51fc8e6edb634ea2c9736837bdb62d5802324030a4f6d5b715f389f5d8d26ea4b4bf481f9784844233076a80eba5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/50d89f52a390f7db2826c6c96a093a3e3be7697e0a3c32d25d978076f1df0466a918a529dd6cbf972eb139db6041a881e11163963fff9b9d45651db3b887fba5"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-30 13:53:04.123179) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-30 13:53:04.123580) ========= 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=d2a8c569965ab8367867b893000001a1-1477859543.255758-352965245 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004458 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-30 13:53:04.203257) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-30 13:53:04.206623) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-30 13:53:04.206937) ========= ========= Total master_lag: 0.18 =========