builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-043 starttime: 1477352722.18 results: success (0) buildid: 20161024160714 builduid: ddfea08ca68d4d73ab49e88ad245853d revision: 9cdd8ed1733a941de56c4d022400c3e4b2ce0d12 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-24 16:45:22.176028) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-24 16:45:22.176469) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-24 16:45:22.176744) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-24 16:45:22.191568) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 16:45:22.191923) ========= 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-1477352721.516814-2028116745 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-24 16:45:22-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.9M=0s 2016-10-24 16:45:22 (46.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.132262 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 16:45:22.337764) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 16:45:22.338071) ========= 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-1477352721.516814-2028116745 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015030 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 16:45:22.387295) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 16:45:22.387670) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 9cdd8ed1733a941de56c4d022400c3e4b2ce0d12 --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 9cdd8ed1733a941de56c4d022400c3e4b2ce0d12 --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-1477352721.516814-2028116745 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-24 16:45:22,487 truncating revision to first 12 chars 2016-10-24 16:45:22,487 Setting DEBUG logging. 2016-10-24 16:45:22,487 attempt 1/10 2016-10-24 16:45:22,487 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/9cdd8ed1733a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-24 16:45:22,984 unpacking tar archive at: fx-team-9cdd8ed1733a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.888360 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 16:45:23.288385) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-24 16:45:23.288717) ========= script_repo_revision: 9cdd8ed1733a941de56c4d022400c3e4b2ce0d12 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-24 16:45:23.289098) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-24 16:45:23.289362) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-24 16:45:23.296655) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-10-24 16:45:23.296940) ========= /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-1477352721.516814-2028116745 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:45:23 INFO - MultiFileLogger online at 20161024 16:45:23 in /builds/slave/test 16:45:23 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 16:45:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:45:23 INFO - {'append_to_log': False, 16:45:23 INFO - 'base_work_dir': '/builds/slave/test', 16:45:23 INFO - 'blob_upload_branch': 'Fx-Team', 16:45:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:45:23 INFO - 'branch': 'Fx-Team', 16:45:23 INFO - 'buildbot_json_path': 'buildprops.json', 16:45:23 INFO - 'config_files': ('talos/linux_config.py',), 16:45:23 INFO - 'default_actions': ('clobber', 16:45:23 INFO - 'read-buildbot-config', 16:45:23 INFO - 'download-and-extract', 16:45:23 INFO - 'populate-webroot', 16:45:23 INFO - 'create-virtualenv', 16:45:23 INFO - 'install', 16:45:23 INFO - 'run-tests'), 16:45:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:45:23 INFO - 'download_minidump_stackwalk': True, 16:45:23 INFO - 'download_symbols': 'ondemand', 16:45:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:45:23 INFO - 'tooltool.py': '/tools/tooltool.py', 16:45:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:45:23 INFO - '/tools/misc-python/virtualenv.py')}, 16:45:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:45:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:45:23 INFO - 'installer_path': 'installer.exe', 16:45:23 INFO - 'log_level': 'info', 16:45:23 INFO - 'log_name': 'talos', 16:45:23 INFO - 'log_to_console': True, 16:45:23 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:45:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:45:23 INFO - 'opt_config_files': (), 16:45:23 INFO - 'pip_index': False, 16:45:23 INFO - 'sps_profile': False, 16:45:23 INFO - 'sps_profile_interval': 0, 16:45:23 INFO - 'suite': 'dromaeojs', 16:45:23 INFO - 'system_bits': '32', 16:45:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:45:23 INFO - 'title': 'talos-linux64-ix-043', 16:45:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:45:23 INFO - 'use_talos_json': True, 16:45:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:45:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:45:23 INFO - 'work_dir': 'build'} 16:45:23 INFO - [mozharness: 2016-10-24 23:45:23.493412Z] Running clobber step. 16:45:23 INFO - Running pre-action listener: _resource_record_pre_action 16:45:23 INFO - Running main action method: clobber 16:45:23 INFO - rmtree: /builds/slave/test/build 16:45:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:45:23 INFO - Running post-action listener: _resource_record_post_action 16:45:23 INFO - [mozharness: 2016-10-24 23:45:23.949336Z] Finished clobber step (success) 16:45:23 INFO - [mozharness: 2016-10-24 23:45:23.949437Z] Running read-buildbot-config step. 16:45:23 INFO - Running pre-action listener: _resource_record_pre_action 16:45:23 INFO - Running main action method: read_buildbot_config 16:45:23 INFO - Using buildbot properties: 16:45:23 INFO - { 16:45:23 INFO - "project": "", 16:45:23 INFO - "product": "firefox", 16:45:23 INFO - "script_repo_revision": "production", 16:45:23 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 16:45:23 INFO - "repository": "", 16:45:23 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 16:45:23 INFO - "buildid": "20161024160714", 16:45:23 INFO - "stage_platform": "linux64-pgo", 16:45:23 INFO - "basedir": "/builds/slave/test", 16:45:23 INFO - "buildnumber": 1165, 16:45:23 INFO - "platform": "ubuntu64_hw", 16:45:23 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 16:45:23 INFO - "slavebuilddir": "test", 16:45:23 INFO - "branch": "fx-team", 16:45:23 INFO - "revision": "9cdd8ed1733a941de56c4d022400c3e4b2ce0d12", 16:45:23 INFO - "slavename": "talos-linux64-ix-043", 16:45:23 INFO - "builduid": "ddfea08ca68d4d73ab49e88ad245853d", 16:45:23 INFO - "repo_path": "integration/fx-team" 16:45:23 INFO - } 16:45:23 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477337493/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 16:45:23 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477337493/firefox-52.0a1.en-US.linux-x86_64.test_packages.json. 16:45:23 INFO - Running post-action listener: _resource_record_post_action 16:45:23 INFO - [mozharness: 2016-10-24 23:45:23.952459Z] Finished read-buildbot-config step (success) 16:45:23 INFO - [mozharness: 2016-10-24 23:45:23.952546Z] Running download-and-extract step. 16:45:23 INFO - Running pre-action listener: _resource_record_pre_action 16:45:23 INFO - Running main action method: download_and_extract 16:45:23 INFO - mkdir: /builds/slave/test/build/tests 16:45:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:45:23 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477337493/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 16:45:23 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477337493/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 16:45:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477337493/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 16:45:23 INFO - Downloaded 1361 bytes. 16:45:23 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 16:45:23 INFO - Using the following test package requirements: 16:45:23 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 16:45:23 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:45:23 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:45:23 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:45:23 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:45:23 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:45:23 INFO - u'jsshell-linux-x86_64.zip'], 16:45:23 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:45:23 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:45:23 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 16:45:23 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:45:23 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:45:23 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:45:23 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:45:23 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:45:23 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:45:23 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:45:23 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:45:23 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:45:23 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/1477337493/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 16:45:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477337493/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:45:23 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477337493/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 16:45:24 INFO - Http code: 200 16:45:24 INFO - via: 1.1 e1eb7447ab46f530f6009f1d93917c54.cloudfront.net (CloudFront) 16:45:24 INFO - x-amz-cf-id: Uyl6BXIuu6Y4NU6AIH4KBexoIHxEsdys5lY3i19WVTaOpz1hx4lo9g== 16:45:24 INFO - x-amz-replication-status: COMPLETED 16:45:24 INFO - x-amz-version-id: yDvNuWcVPzweL3inzTYhF2HTI6R8YQK8 16:45:24 INFO - Expected file size: 22021817 16:45:24 INFO - Obtained file size: 22021817 16:45:28 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 16:45:28 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/1477337493/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 16:45:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477337493/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:45:28 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477337493/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 16:45:28 INFO - Http code: 200 16:45:28 INFO - via: 1.1 76bce8bb4fbd102fc0b3aa2e41094b79.cloudfront.net (CloudFront) 16:45:28 INFO - x-amz-cf-id: 4jiYu8TQ4DK0ZS4_vlcievp1gE5oCjGUko9vi2GgXK8CEphNnJWaxw== 16:45:28 INFO - x-amz-replication-status: COMPLETED 16:45:28 INFO - x-amz-version-id: yDvNuWcVPzweL3inzTYhF2HTI6R8YQK8 16:45:28 INFO - Expected file size: 22021817 16:45:28 INFO - Obtained file size: 22021817 16:45:33 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/1477337493/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 16:45:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477337493/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 16:45:33 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477337493/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 16:45:33 INFO - Http code: 200 16:45:33 INFO - via: 1.1 f1a40337a32137e1c23ceffead6a50d5.cloudfront.net (CloudFront) 16:45:33 INFO - x-amz-cf-id: nnOPGTyTiYbAdTyIfsN6oP7s7z4bF7ivgjQO1bJ5XLZhG4dnM9EpJA== 16:45:33 INFO - x-amz-replication-status: COMPLETED 16:45:33 INFO - x-amz-version-id: 3TowWLeznLw.._tmdmRZ5wOkMhcAghWA 16:45:33 INFO - Expected file size: 14409028 16:45:33 INFO - Obtained file size: 14409028 16:45:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:45:33 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477337493/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 16:45:33 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477337493/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 16:45:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477337493/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 16:45:34 INFO - Downloaded 59371378 bytes. 16:45:34 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477337493/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 16:45:34 INFO - mkdir: /builds/slave/test/properties 16:45:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:45:34 INFO - Writing to file /builds/slave/test/properties/build_url 16:45:34 INFO - Contents: 16:45:34 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477337493/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 16:45:34 INFO - Running post-action listener: _resource_record_post_action 16:45:34 INFO - Running post-action listener: set_extra_try_arguments 16:45:34 INFO - [mozharness: 2016-10-24 23:45:34.469634Z] Finished download-and-extract step (success) 16:45:34 INFO - [mozharness: 2016-10-24 23:45:34.469860Z] Running populate-webroot step. 16:45:34 INFO - Running pre-action listener: _resource_record_pre_action 16:45:34 INFO - Running main action method: populate_webroot 16:45:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:45:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:45:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:45:34 INFO - '--tppagecycles', 16:45:34 INFO - '7'], 16:45:34 INFO - 'tests': ['tsvgm']}}, 16:45:34 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:45:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:45:34 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:45:34 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:45:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:45:34 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:45:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:45:34 INFO - 'talos_options': ['--disable-e10s'], 16:45:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:45:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:45:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:45:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:45:34 INFO - 'talos_options': ['--disable-e10s'], 16:45:34 INFO - 'tests': ['damp', 'tps']}, 16:45:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:45:34 INFO - 'tests': ['damp', 'tps']}, 16:45:34 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:45:34 INFO - 'tests': ['dromaeo_dom']}, 16:45:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:45:34 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:45:34 INFO - 'tests': ['basic_compositor_video']}, 16:45:34 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:45:34 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:45:34 INFO - 'tests': ['a11yr', 16:45:34 INFO - 'ts_paint', 16:45:34 INFO - 'tpaint', 16:45:34 INFO - 'sessionrestore', 16:45:34 INFO - 'sessionrestore_no_auto_restore', 16:45:34 INFO - 'tabpaint']}, 16:45:34 INFO - 'other-e10s': {'tests': ['a11yr', 16:45:34 INFO - 'ts_paint', 16:45:34 INFO - 'tpaint', 16:45:34 INFO - 'sessionrestore', 16:45:34 INFO - 'sessionrestore_no_auto_restore', 16:45:34 INFO - 'tabpaint']}, 16:45:34 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:45:34 INFO - 'ts_paint', 16:45:34 INFO - 'tpaint', 16:45:34 INFO - 'sessionrestore', 16:45:34 INFO - 'sessionrestore_no_auto_restore', 16:45:34 INFO - 'tabpaint']}, 16:45:34 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:45:34 INFO - 'ts_paint', 16:45:34 INFO - 'tpaint', 16:45:34 INFO - 'sessionrestore', 16:45:34 INFO - 'sessionrestore_no_auto_restore', 16:45:34 INFO - 'tabpaint']}, 16:45:34 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:45:34 INFO - 'tests': ['a11yr', 16:45:34 INFO - 'ts_paint', 16:45:34 INFO - 'tpaint', 16:45:34 INFO - 'sessionrestore', 16:45:34 INFO - 'sessionrestore_no_auto_restore', 16:45:34 INFO - 'tabpaint']}, 16:45:34 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:45:34 INFO - 'tests': ['a11yr', 16:45:34 INFO - 'ts_paint', 16:45:34 INFO - 'tpaint', 16:45:34 INFO - 'sessionrestore', 16:45:34 INFO - 'sessionrestore_no_auto_restore', 16:45:34 INFO - 'tabpaint']}, 16:45:34 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:45:34 INFO - 'tests': ['tsvgx', 16:45:34 INFO - 'tsvgr_opacity', 16:45:34 INFO - 'tart', 16:45:34 INFO - 'tscrollx', 16:45:34 INFO - 'cart']}, 16:45:34 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:45:34 INFO - 'tsvgr_opacity', 16:45:34 INFO - 'tart', 16:45:34 INFO - 'tscrollx', 16:45:34 INFO - 'cart']}, 16:45:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:45:34 INFO - 'talos_options': ['--disable-e10s'], 16:45:34 INFO - 'tests': ['tp5o']}, 16:45:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:45:34 INFO - 'tests': ['tp5o']}, 16:45:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:45:34 INFO - 'talos_options': ['--disable-e10s', 16:45:34 INFO - '--xperf_path', 16:45:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:45:34 INFO - 'tests': ['tp5n']}, 16:45:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:45:34 INFO - 'talos_options': ['--xperf_path', 16:45:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:45:34 INFO - 'tests': ['tp5n']}}, 16:45:34 INFO - 'talos.zip': {'path': '', 16:45:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:45:34 INFO - Running post-action listener: _resource_record_post_action 16:45:34 INFO - [mozharness: 2016-10-24 23:45:34.488399Z] Finished populate-webroot step (success) 16:45:34 INFO - [mozharness: 2016-10-24 23:45:34.488487Z] Running create-virtualenv step. 16:45:34 INFO - Running pre-action listener: _resource_record_pre_action 16:45:34 INFO - Running main action method: create_virtualenv 16:45:34 INFO - Creating virtualenv /builds/slave/test/build/venv 16:45:34 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 16:45:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:45:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:45:34 INFO - Using real prefix '/usr' 16:45:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:45:35 INFO - Installing distribute.............................................................................................................................................................................................done. 16:45:37 INFO - Installing pip.................done. 16:45:37 INFO - Return code: 0 16:45:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:45:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:45:37 INFO - Reading from file tmpfile_stdout 16:45:37 INFO - Output received: 16:45:37 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 16:45:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:45:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:45:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:45:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:45:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:45:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45:37 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 0x7f5bc8dc1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x206f7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20fe790>, '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 0x20ff690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20ffb20>, '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-1477352721.516814-2028116745', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:45:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:45:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:45:37 INFO - Using env: {'DISPLAY': ':0', 16:45:37 INFO - 'HOME': '/home/cltbld', 16:45:37 INFO - 'LANG': 'en_US.UTF-8', 16:45:37 INFO - 'LANGUAGE': 'en_US:en', 16:45:37 INFO - 'LOGNAME': 'cltbld', 16:45:37 INFO - 'MAIL': '/var/mail/cltbld', 16:45:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:45:37 INFO - 'MOZ_NO_REMOTE': '1', 16:45:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:45:37 INFO - 'NO_EM_RESTART': '1', 16:45:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:45:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:45:37 INFO - 'PWD': '/builds/slave/test', 16:45:37 INFO - 'SHELL': '/bin/bash', 16:45:37 INFO - 'SHLVL': '1', 16:45:37 INFO - 'TERM': 'linux', 16:45:37 INFO - 'TMOUT': '86400', 16:45:37 INFO - 'USER': 'cltbld', 16:45:37 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1477352721.516814-2028116745', 16:45:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:45:37 INFO - '_': '/tools/buildbot/bin/python'} 16:45:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:45:37 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 16:45:37 INFO - Cleaning up... 16:45:37 INFO - Return code: 0 16:45:37 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:45:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:45:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:45:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:45:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:45:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45:37 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 0x7f5bc8dc1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x206f7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20fe790>, '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 0x20ff690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20ffb20>, '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-1477352721.516814-2028116745', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:45:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 16:45:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 16:45:37 INFO - Using env: {'DISPLAY': ':0', 16:45:37 INFO - 'HOME': '/home/cltbld', 16:45:37 INFO - 'LANG': 'en_US.UTF-8', 16:45:37 INFO - 'LANGUAGE': 'en_US:en', 16:45:37 INFO - 'LOGNAME': 'cltbld', 16:45:37 INFO - 'MAIL': '/var/mail/cltbld', 16:45:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:45:37 INFO - 'MOZ_NO_REMOTE': '1', 16:45:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:45:37 INFO - 'NO_EM_RESTART': '1', 16:45:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:45:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:45:37 INFO - 'PWD': '/builds/slave/test', 16:45:37 INFO - 'SHELL': '/bin/bash', 16:45:37 INFO - 'SHLVL': '1', 16:45:37 INFO - 'TERM': 'linux', 16:45:37 INFO - 'TMOUT': '86400', 16:45:37 INFO - 'USER': 'cltbld', 16:45:37 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1477352721.516814-2028116745', 16:45:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:45:37 INFO - '_': '/tools/buildbot/bin/python'} 16:45:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:45:37 INFO - Downloading/unpacking psutil>=3.1.1 16:45:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:45:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:45:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:45:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:45:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:45:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:45:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:45:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:45:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:45:39 INFO - Installing collected packages: psutil 16:45:39 INFO - Running setup.py install for psutil 16:45:39 INFO - building 'psutil._psutil_linux' extension 16:45:39 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 16:45:39 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 16:45:40 INFO - building 'psutil._psutil_posix' extension 16:45:40 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 16:45:40 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 16:45:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:45:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:45:40 INFO - Successfully installed psutil 16:45:40 INFO - Cleaning up... 16:45:40 INFO - Return code: 0 16:45:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:45: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')]} 16:45:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:45:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45: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')]} 16:45:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:45:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5bc8dc1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x206f7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20fe790>, '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 0x20ff690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20ffb20>, '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-1477352721.516814-2028116745', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:45: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 16:45: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 mozsystemmonitor==0.3 16:45:40 INFO - Using env: {'DISPLAY': ':0', 16:45:40 INFO - 'HOME': '/home/cltbld', 16:45:40 INFO - 'LANG': 'en_US.UTF-8', 16:45:40 INFO - 'LANGUAGE': 'en_US:en', 16:45:40 INFO - 'LOGNAME': 'cltbld', 16:45:40 INFO - 'MAIL': '/var/mail/cltbld', 16:45:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:45:40 INFO - 'MOZ_NO_REMOTE': '1', 16:45:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:45:40 INFO - 'NO_EM_RESTART': '1', 16:45:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:45:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:45:40 INFO - 'PWD': '/builds/slave/test', 16:45:40 INFO - 'SHELL': '/bin/bash', 16:45:40 INFO - 'SHLVL': '1', 16:45:40 INFO - 'TERM': 'linux', 16:45:40 INFO - 'TMOUT': '86400', 16:45:40 INFO - 'USER': 'cltbld', 16:45:40 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1477352721.516814-2028116745', 16:45:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:45:40 INFO - '_': '/tools/buildbot/bin/python'} 16:45:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:45:40 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:45: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 16:45: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 16:45: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 16:45: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 16:45: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 16:45: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 16:45:42 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:45:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:45:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:45:42 INFO - Installing collected packages: mozsystemmonitor 16:45:42 INFO - Running setup.py install for mozsystemmonitor 16:45:42 INFO - Successfully installed mozsystemmonitor 16:45:42 INFO - Cleaning up... 16:45:42 INFO - Return code: 0 16:45:42 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:45: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')]} 16:45:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:45:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45: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')]} 16:45:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:45:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45: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', '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 0x7f5bc8dc1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x206f7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20fe790>, '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 0x20ff690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20ffb20>, '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-1477352721.516814-2028116745', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:45: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 16:45: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 jsonschema==2.5.1 16:45:42 INFO - Using env: {'DISPLAY': ':0', 16:45:42 INFO - 'HOME': '/home/cltbld', 16:45:42 INFO - 'LANG': 'en_US.UTF-8', 16:45:42 INFO - 'LANGUAGE': 'en_US:en', 16:45:42 INFO - 'LOGNAME': 'cltbld', 16:45:42 INFO - 'MAIL': '/var/mail/cltbld', 16:45:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:45:42 INFO - 'MOZ_NO_REMOTE': '1', 16:45:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:45:42 INFO - 'NO_EM_RESTART': '1', 16:45:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:45:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:45:42 INFO - 'PWD': '/builds/slave/test', 16:45:42 INFO - 'SHELL': '/bin/bash', 16:45:42 INFO - 'SHLVL': '1', 16:45:42 INFO - 'TERM': 'linux', 16:45:42 INFO - 'TMOUT': '86400', 16:45:42 INFO - 'USER': 'cltbld', 16:45:42 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1477352721.516814-2028116745', 16:45:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:45:42 INFO - '_': '/tools/buildbot/bin/python'} 16:45:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:45:42 INFO - Downloading/unpacking jsonschema==2.5.1 16:45:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:45:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:45:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:45:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:45:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:45:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:45:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:45:44 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:45:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:45:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:45:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:45:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:45:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:45:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:45:45 INFO - Downloading functools32-3.2.3-2.tar.gz 16:45:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:45:45 INFO - warning: no files found matching '*.txt' 16:45:45 INFO - no previously-included directories found matching 'build' 16:45:45 INFO - no previously-included directories found matching 'dist' 16:45:45 INFO - no previously-included directories found matching '.git*' 16:45:45 INFO - Installing collected packages: jsonschema, functools32 16:45:45 INFO - Running setup.py install for functools32 16:45:45 INFO - warning: no files found matching '*.txt' 16:45:45 INFO - no previously-included directories found matching 'build' 16:45:45 INFO - no previously-included directories found matching 'dist' 16:45:45 INFO - no previously-included directories found matching '.git*' 16:45:45 INFO - Successfully installed jsonschema functools32 16:45:45 INFO - Cleaning up... 16:45:45 INFO - Return code: 0 16:45:45 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:45: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')]} 16:45:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:45:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45: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')]} 16:45:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:45:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45: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', '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 0x7f5bc8dc1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x206f7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20fe790>, '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 0x20ff690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20ffb20>, '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-1477352721.516814-2028116745', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:45: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 16:45: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 functools32==3.2.3-2 16:45:45 INFO - Using env: {'DISPLAY': ':0', 16:45:45 INFO - 'HOME': '/home/cltbld', 16:45:45 INFO - 'LANG': 'en_US.UTF-8', 16:45:45 INFO - 'LANGUAGE': 'en_US:en', 16:45:45 INFO - 'LOGNAME': 'cltbld', 16:45:45 INFO - 'MAIL': '/var/mail/cltbld', 16:45:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:45:45 INFO - 'MOZ_NO_REMOTE': '1', 16:45:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:45:45 INFO - 'NO_EM_RESTART': '1', 16:45:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:45:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:45:45 INFO - 'PWD': '/builds/slave/test', 16:45:45 INFO - 'SHELL': '/bin/bash', 16:45:45 INFO - 'SHLVL': '1', 16:45:45 INFO - 'TERM': 'linux', 16:45:45 INFO - 'TMOUT': '86400', 16:45:45 INFO - 'USER': 'cltbld', 16:45:45 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1477352721.516814-2028116745', 16:45:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:45:45 INFO - '_': '/tools/buildbot/bin/python'} 16:45:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:45:45 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:45:45 INFO - Cleaning up... 16:45:45 INFO - Return code: 0 16:45:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:45: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')]} 16:45:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:45:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45: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')]} 16:45:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:45:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45: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', '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 0x7f5bc8dc1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x206f7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20fe790>, '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 0x20ff690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20ffb20>, '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-1477352721.516814-2028116745', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:45: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:45: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 blobuploader==1.2.4 16:45:45 INFO - Using env: {'DISPLAY': ':0', 16:45:45 INFO - 'HOME': '/home/cltbld', 16:45:45 INFO - 'LANG': 'en_US.UTF-8', 16:45:45 INFO - 'LANGUAGE': 'en_US:en', 16:45:45 INFO - 'LOGNAME': 'cltbld', 16:45:45 INFO - 'MAIL': '/var/mail/cltbld', 16:45:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:45:45 INFO - 'MOZ_NO_REMOTE': '1', 16:45:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:45:45 INFO - 'NO_EM_RESTART': '1', 16:45:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:45:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:45:45 INFO - 'PWD': '/builds/slave/test', 16:45:45 INFO - 'SHELL': '/bin/bash', 16:45:45 INFO - 'SHLVL': '1', 16:45:45 INFO - 'TERM': 'linux', 16:45:45 INFO - 'TMOUT': '86400', 16:45:45 INFO - 'USER': 'cltbld', 16:45:45 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1477352721.516814-2028116745', 16:45:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:45:45 INFO - '_': '/tools/buildbot/bin/python'} 16:45:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:45:45 INFO - Downloading/unpacking blobuploader==1.2.4 16:45: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 16:45: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 16:45: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 16:45: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 16:45: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 16:45: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 16:45:47 INFO - Downloading blobuploader-1.2.4.tar.gz 16:45:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:45:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:45: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 16:45: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 16:45: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 16:45: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 16:45: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 16:45: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 16:45:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:45:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:45: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 16:45: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 16:45: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 16:45: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 16:45: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 16:45: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 16:45:48 INFO - Downloading docopt-0.6.1.tar.gz 16:45:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:45:48 INFO - Installing collected packages: blobuploader, requests, docopt 16:45:48 INFO - Running setup.py install for blobuploader 16:45:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:45:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:45:48 INFO - Running setup.py install for requests 16:45:48 INFO - Running setup.py install for docopt 16:45:48 INFO - Successfully installed blobuploader requests docopt 16:45:48 INFO - Cleaning up... 16:45:49 INFO - Return code: 0 16:45:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:45:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:45:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:45:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:45:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:45:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45:49 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 0x7f5bc8dc1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x206f7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20fe790>, '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 0x20ff690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20ffb20>, '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-1477352721.516814-2028116745', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:45:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:45:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:45:49 INFO - Using env: {'DISPLAY': ':0', 16:45:49 INFO - 'HOME': '/home/cltbld', 16:45:49 INFO - 'LANG': 'en_US.UTF-8', 16:45:49 INFO - 'LANGUAGE': 'en_US:en', 16:45:49 INFO - 'LOGNAME': 'cltbld', 16:45:49 INFO - 'MAIL': '/var/mail/cltbld', 16:45:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:45:49 INFO - 'MOZ_NO_REMOTE': '1', 16:45:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:45:49 INFO - 'NO_EM_RESTART': '1', 16:45:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:45:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:45:49 INFO - 'PWD': '/builds/slave/test', 16:45:49 INFO - 'SHELL': '/bin/bash', 16:45:49 INFO - 'SHLVL': '1', 16:45:49 INFO - 'TERM': 'linux', 16:45:49 INFO - 'TMOUT': '86400', 16:45:49 INFO - 'USER': 'cltbld', 16:45:49 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1477352721.516814-2028116745', 16:45:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:45:49 INFO - '_': '/tools/buildbot/bin/python'} 16:45:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:45:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:45:49 INFO - Running setup.py (path:/tmp/pip-EdxTVg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:45:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:45:49 INFO - Running setup.py (path:/tmp/pip-vyhKqr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:45:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:45:49 INFO - Running setup.py (path:/tmp/pip-uly5tI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:45:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:45:49 INFO - Running setup.py (path:/tmp/pip-nUJVB0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:45:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:45:49 INFO - Running setup.py (path:/tmp/pip-li5rrX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:45:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:45:49 INFO - Running setup.py (path:/tmp/pip-e_rDZC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:45:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:45:49 INFO - Running setup.py (path:/tmp/pip-PXkuD8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:45:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:45:49 INFO - Running setup.py (path:/tmp/pip-EC2n81-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:45:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:45:49 INFO - Running setup.py (path:/tmp/pip-3PcAcN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:45:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:45:49 INFO - Running setup.py (path:/tmp/pip-41J3G9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:45:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:45:49 INFO - Running setup.py (path:/tmp/pip-Bpx_gV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:45:50 INFO - Running setup.py (path:/tmp/pip-ZNplUc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:45:50 INFO - Running setup.py (path:/tmp/pip-tInrK9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:45:50 INFO - Running setup.py (path:/tmp/pip-5G0hPI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:45:50 INFO - Running setup.py (path:/tmp/pip-kqEXQl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:45:50 INFO - Running setup.py (path:/tmp/pip-bgMtTf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:45:50 INFO - Running setup.py (path:/tmp/pip-CP0ODL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:45:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:45:50 INFO - Running setup.py install for manifestparser 16:45:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:45:50 INFO - Running setup.py install for mozcrash 16:45:50 INFO - Running setup.py install for mozdebug 16:45:50 INFO - Running setup.py install for mozdevice 16:45:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:45:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:45:50 INFO - Running setup.py install for mozfile 16:45:51 INFO - Running setup.py install for mozhttpd 16:45:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:45:51 INFO - Running setup.py install for mozinfo 16:45:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:45:51 INFO - Running setup.py install for mozInstall 16:45:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:45:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:45:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:45:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:45:51 INFO - Running setup.py install for mozleak 16:45:51 INFO - Running setup.py install for mozlog 16:45:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:45:51 INFO - Running setup.py install for moznetwork 16:45:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:45:51 INFO - Running setup.py install for mozprocess 16:45:51 INFO - Running setup.py install for mozprofile 16:45:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:45:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:45:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:45:51 INFO - Running setup.py install for mozrunner 16:45:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:45:51 INFO - Running setup.py install for mozscreenshot 16:45:52 INFO - Running setup.py install for moztest 16:45:52 INFO - Running setup.py install for mozversion 16:45:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:45:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:45:52 INFO - Cleaning up... 16:45:52 INFO - Return code: 0 16:45:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:45:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:45:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:45:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:45:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:45:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45:52 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 0x7f5bc8dc1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x206f7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20fe790>, '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 0x20ff690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20ffb20>, '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-1477352721.516814-2028116745', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:45:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:45:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:45:52 INFO - Using env: {'DISPLAY': ':0', 16:45:52 INFO - 'HOME': '/home/cltbld', 16:45:52 INFO - 'LANG': 'en_US.UTF-8', 16:45:52 INFO - 'LANGUAGE': 'en_US:en', 16:45:52 INFO - 'LOGNAME': 'cltbld', 16:45:52 INFO - 'MAIL': '/var/mail/cltbld', 16:45:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:45:52 INFO - 'MOZ_NO_REMOTE': '1', 16:45:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:45:52 INFO - 'NO_EM_RESTART': '1', 16:45:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:45:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:45:52 INFO - 'PWD': '/builds/slave/test', 16:45:52 INFO - 'SHELL': '/bin/bash', 16:45:52 INFO - 'SHLVL': '1', 16:45:52 INFO - 'TERM': 'linux', 16:45:52 INFO - 'TMOUT': '86400', 16:45:52 INFO - 'USER': 'cltbld', 16:45:52 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1477352721.516814-2028116745', 16:45:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:45:52 INFO - '_': '/tools/buildbot/bin/python'} 16:45:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:45:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:45:52 INFO - Running setup.py (path:/tmp/pip-_oz6vP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:45:52 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 16:45:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:45:52 INFO - Running setup.py (path:/tmp/pip-N8vwxi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:45:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:45:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:45:52 INFO - Running setup.py (path:/tmp/pip-LuQ3wL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:45:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:45:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:45:52 INFO - Running setup.py (path:/tmp/pip-ZdLAkj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:45:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:45:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:45:52 INFO - Running setup.py (path:/tmp/pip-LMWGvv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:45:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 16:45:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:45:52 INFO - Running setup.py (path:/tmp/pip-W2_44L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:45:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 16:45:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:45:52 INFO - Running setup.py (path:/tmp/pip-ogJ90G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:45:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 16:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:45:53 INFO - Running setup.py (path:/tmp/pip-yR0ImW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:45:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 16:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:45:53 INFO - Running setup.py (path:/tmp/pip-NPcBIO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:45:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 16:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:45:53 INFO - Running setup.py (path:/tmp/pip-Mit8vc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:45:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:45:53 INFO - Running setup.py (path:/tmp/pip-0eRuCO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:45:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 16:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:45:53 INFO - Running setup.py (path:/tmp/pip-EcjL0C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:45:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 16:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:45:53 INFO - Running setup.py (path:/tmp/pip-XzgtOA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:45:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 16:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:45:53 INFO - Running setup.py (path:/tmp/pip-3Un6qx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:45:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 16:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:45:53 INFO - Running setup.py (path:/tmp/pip-xvBzPA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:45:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 16:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:45:53 INFO - Running setup.py (path:/tmp/pip-pKUvpB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:45:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 16:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:45:53 INFO - Running setup.py (path:/tmp/pip-_VWlw2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:45:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 16:45:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:45:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:45:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:45:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:45:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:45:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:45:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:45:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:45:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:45:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:45:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:45:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:45:55 INFO - Downloading blessings-1.6.tar.gz 16:45:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:45:55 INFO - Installing collected packages: blessings 16:45:55 INFO - Running setup.py install for blessings 16:45:55 INFO - Successfully installed blessings 16:45:55 INFO - Cleaning up... 16:45:55 INFO - Return code: 0 16:45:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:45:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:45:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:45:56 INFO - Reading from file tmpfile_stdout 16:45:56 INFO - Current package versions: 16:45:56 INFO - argparse == 1.2.1 16:45:56 INFO - blessings == 1.6 16:45:56 INFO - blobuploader == 1.2.4 16:45:56 INFO - docopt == 0.6.1 16:45:56 INFO - functools32 == 3.2.3-2 16:45:56 INFO - jsonschema == 2.5.1 16:45:56 INFO - manifestparser == 1.1 16:45:56 INFO - mozInstall == 1.12 16:45:56 INFO - mozcrash == 0.17 16:45:56 INFO - mozdebug == 0.1 16:45:56 INFO - mozdevice == 0.48 16:45:56 INFO - mozfile == 1.2 16:45:56 INFO - mozhttpd == 0.7 16:45:56 INFO - mozinfo == 0.9 16:45:56 INFO - mozleak == 0.1 16:45:56 INFO - mozlog == 3.4 16:45:56 INFO - moznetwork == 0.27 16:45:56 INFO - mozprocess == 0.23 16:45:56 INFO - mozprofile == 0.28 16:45:56 INFO - mozrunner == 6.12 16:45:56 INFO - mozscreenshot == 0.1 16:45:56 INFO - mozsystemmonitor == 0.3 16:45:56 INFO - moztest == 0.7 16:45:56 INFO - mozversion == 1.4 16:45:56 INFO - psutil == 3.1.1 16:45:56 INFO - requests == 1.2.3 16:45:56 INFO - wsgiref == 0.1.2 16:45:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:45:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:45:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:45:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:45:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:45:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45:56 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 0x7f5bc8dc1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x206f7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20fe790>, '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 0x20ff690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20ffb20>, '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-1477352721.516814-2028116745', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:45:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 16:45:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:45:56 INFO - Using env: {'DISPLAY': ':0', 16:45:56 INFO - 'HOME': '/home/cltbld', 16:45:56 INFO - 'LANG': 'en_US.UTF-8', 16:45:56 INFO - 'LANGUAGE': 'en_US:en', 16:45:56 INFO - 'LOGNAME': 'cltbld', 16:45:56 INFO - 'MAIL': '/var/mail/cltbld', 16:45:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:45:56 INFO - 'MOZ_NO_REMOTE': '1', 16:45:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:45:56 INFO - 'NO_EM_RESTART': '1', 16:45:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:45:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:45:56 INFO - 'PWD': '/builds/slave/test', 16:45:56 INFO - 'SHELL': '/bin/bash', 16:45:56 INFO - 'SHLVL': '1', 16:45:56 INFO - 'TERM': 'linux', 16:45:56 INFO - 'TMOUT': '86400', 16:45:56 INFO - 'USER': 'cltbld', 16:45:56 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1477352721.516814-2028116745', 16:45:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:45:56 INFO - '_': '/tools/buildbot/bin/python'} 16:45:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:45:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:45:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 16:45:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 16:45:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:45:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 16:45:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 16:45:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 16:45:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 16:45:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 16:45:56 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:45:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:45:56 INFO - Cleaning up... 16:45:56 INFO - Return code: 0 16:45:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:45:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:45:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:45:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:45:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:45:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5bc8dc1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x206f7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20fe790>, '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 0x20ff690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20ffb20>, '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-1477352721.516814-2028116745', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:45:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:45:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:45:56 INFO - Using env: {'DISPLAY': ':0', 16:45:56 INFO - 'HOME': '/home/cltbld', 16:45:56 INFO - 'LANG': 'en_US.UTF-8', 16:45:56 INFO - 'LANGUAGE': 'en_US:en', 16:45:56 INFO - 'LOGNAME': 'cltbld', 16:45:56 INFO - 'MAIL': '/var/mail/cltbld', 16:45:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:45:56 INFO - 'MOZ_NO_REMOTE': '1', 16:45:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:45:56 INFO - 'NO_EM_RESTART': '1', 16:45:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:45:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:45:56 INFO - 'PWD': '/builds/slave/test', 16:45:56 INFO - 'SHELL': '/bin/bash', 16:45:56 INFO - 'SHLVL': '1', 16:45:56 INFO - 'TERM': 'linux', 16:45:56 INFO - 'TMOUT': '86400', 16:45:56 INFO - 'USER': 'cltbld', 16:45:56 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1477352721.516814-2028116745', 16:45:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:45:56 INFO - '_': '/tools/buildbot/bin/python'} 16:45:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:45:56 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:45:56 INFO - Cleaning up... 16:45:56 INFO - Return code: 0 16:45:56 INFO - Running post-action listener: _resource_record_post_action 16:45:56 INFO - Running post-action listener: _start_resource_monitoring 16:45:56 INFO - Starting resource monitoring. 16:45:56 INFO - [mozharness: 2016-10-24 23:45:56.635936Z] Finished create-virtualenv step (success) 16:45:56 INFO - [mozharness: 2016-10-24 23:45:56.636396Z] Running install step. 16:45:56 INFO - Running pre-action listener: _resource_record_pre_action 16:45:56 INFO - Running main action method: install 16:45:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:45:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:45:56 INFO - Reading from file tmpfile_stdout 16:45:56 INFO - Detecting whether we're running mozinstall >=1.0... 16:45:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:45:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:45:56 INFO - Reading from file tmpfile_stdout 16:45:56 INFO - Output received: 16:45:56 INFO - Usage: mozinstall [options] installer 16:45:56 INFO - Options: 16:45:56 INFO - -h, --help show this help message and exit 16:45:56 INFO - -d DEST, --destination=DEST 16:45:56 INFO - Directory to install application into. [default: 16:45:56 INFO - "/builds/slave/test"] 16:45:56 INFO - --app=APP Application being installed. [default: firefox] 16:45:56 INFO - mkdir: /builds/slave/test/build/application 16:45:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 16:45:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 16:46:13 INFO - Reading from file tmpfile_stdout 16:46:13 INFO - Output received: 16:46:13 INFO - /builds/slave/test/build/application/firefox/firefox 16:46:13 INFO - Running post-action listener: _resource_record_post_action 16:46:13 INFO - [mozharness: 2016-10-24 23:46:13.855269Z] Finished install step (success) 16:46:13 INFO - [mozharness: 2016-10-24 23:46:13.855543Z] Running run-tests step. 16:46:13 INFO - Running pre-action listener: _resource_record_pre_action 16:46:13 INFO - Running main action method: run_tests 16:46:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:46:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:46:13 INFO - Python 2.7.3 16:46:13 INFO - Return code: 0 16:46:13 INFO - grabbing minidump binary from tooltool 16:46:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:46:13 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 0x20fe790>, '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 0x20ff690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20ffb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:46:13 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 16:46:13 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 16:46:13 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 16:46:13 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:46:13 INFO - Return code: 0 16:46:13 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:46:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:46:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:46:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:46:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:46:13 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/1477337493/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 16:46:13 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/1477337493/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 16:46:13 INFO - Using env: {'DISPLAY': ':0', 16:46:13 INFO - 'HOME': '/home/cltbld', 16:46:13 INFO - 'LANG': 'en_US.UTF-8', 16:46:13 INFO - 'LANGUAGE': 'en_US:en', 16:46:13 INFO - 'LOGNAME': 'cltbld', 16:46:13 INFO - 'MAIL': '/var/mail/cltbld', 16:46:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:46:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:46:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:46:13 INFO - 'MOZ_NO_REMOTE': '1', 16:46:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:46:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:46:13 INFO - 'NO_EM_RESTART': '1', 16:46:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:46:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:46:13 INFO - 'PWD': '/builds/slave/test', 16:46:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:46:13 INFO - 'SHELL': '/bin/bash', 16:46:13 INFO - 'SHLVL': '1', 16:46:13 INFO - 'TERM': 'linux', 16:46:13 INFO - 'TMOUT': '86400', 16:46:13 INFO - 'USER': 'cltbld', 16:46:13 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1477352721.516814-2028116745', 16:46:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:46:13 INFO - '_': '/tools/buildbot/bin/python'} 16:46:13 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/1477337493/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 16:46:14 INFO - mozversion application_buildid: 20161024123133 16:46:14 INFO - mozversion application_changeset: 9cdd8ed1733a941de56c4d022400c3e4b2ce0d12 16:46:14 INFO - mozversion application_display_name: Nightly 16:46:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:46:14 INFO - mozversion application_name: Firefox 16:46:14 INFO - mozversion application_remotingname: firefox 16:46:14 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 16:46:14 INFO - mozversion application_vendor: Mozilla 16:46:14 INFO - mozversion application_version: 52.0a1 16:46:14 INFO - mozversion platform_buildid: 20161024123133 16:46:14 INFO - mozversion platform_changeset: 9cdd8ed1733a941de56c4d022400c3e4b2ce0d12 16:46:14 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 16:46:14 INFO - mozversion platform_version: 52.0a1 16:46:14 INFO - using testdate: 1477352774 16:46:14 INFO - actual date: 1477352774 16:46:14 INFO - starting webserver on 'localhost:33521' 16:46:14 INFO - SUITE-START | Running 2 tests 16:46:14 INFO - TEST-START | dromaeo_css 16:46:14 INFO - operating with platform_type : linux_ 16:46:14 INFO - Initialising browser for dromaeo_css test... 16:46:14 INFO - TEST-INFO | started process 9983 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpj6JGod/profile http://localhost:33521/getInfo.html) 16:46:18 INFO - PROCESS | 9983 | __metrics Screen width/height:1600/1200 16:46:18 INFO - PROCESS | 9983 | colorDepth:24 16:46:18 INFO - PROCESS | 9983 | Browser inner width/height: 1024/697 16:46:18 INFO - PROCESS | 9983 | __metrics 16:46:19 INFO - PROCESS | 9983 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 16:46:19 INFO - PROCESS | 9983 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:46:19 INFO - PROCESS | 9983 | console.error: PushService: 16:46:19 INFO - PROCESS | 9983 | stateChangeProcessEnqueue: Error transitioning state 16:46:19 INFO - PROCESS | 9983 | UnknownError 16:46:20 INFO - TEST-INFO | 9983: exit 0 16:46:20 INFO - Browser initialized. 16:46:20 INFO - Running cycle 1/1 for dromaeo_css test... 16:46:20 INFO - TEST-INFO | started process 10065 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpj6JGod/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:46:32 INFO - PROCESS | 10065 | RSS: Main: 172023808 16:46:32 INFO - PROCESS | 10065 | 16:47:24 INFO - PROCESS | 10065 | 1477352844031 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 16:49:34 INFO - PROCESS | 10065 | Cycle 1(1): loaded http://localhost:33521/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33521/tests/dromaeo/cssquery-ext.html) 16:49:36 INFO - PROCESS | 10065 | RSS: Main: 316121088 16:49:36 INFO - PROCESS | 10065 | 16:52:38 INFO - PROCESS | 10065 | Cycle 1(1): loaded http://localhost:33521/tests/dromaeo/cssquery-ext.html (next: http://localhost:33521/tests/dromaeo/cssquery-jquery.html) 16:52:39 INFO - PROCESS | 10065 | RSS: Main: 275841024 16:52:39 INFO - PROCESS | 10065 | 16:55:41 INFO - PROCESS | 10065 | Cycle 1(1): loaded http://localhost:33521/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33521/tests/dromaeo/cssquery-mootools.html) 16:55:41 INFO - PROCESS | 10065 | RSS: Main: 256147456 16:55:41 INFO - PROCESS | 10065 | 16:58:43 INFO - PROCESS | 10065 | Cycle 1(1): loaded http://localhost:33521/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33521/tests/dromaeo/cssquery-prototype.html) 16:58:44 INFO - PROCESS | 10065 | RSS: Main: 253075456 16:58:44 INFO - PROCESS | 10065 | 17:01:47 INFO - PROCESS | 10065 | Cycle 1(1): loaded http://localhost:33521/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33521/tests/dromaeo/cssquery-yui.html) 17:01:47 INFO - PROCESS | 10065 | RSS: Main: 216014848 17:01:47 INFO - PROCESS | 10065 | 17:04:50 INFO - PROCESS | 10065 | Cycle 1(1): loaded http://localhost:33521/tests/dromaeo/cssquery-yui.html (next: http://localhost:33521/tests/dromaeo/cssquery-dojo.html) 17:04:51 INFO - PROCESS | 10065 | RSS: Main: 282812416 17:04:51 INFO - PROCESS | 10065 | 17:04:51 INFO - PROCESS | 10065 | __start_tp_report 17:04:51 INFO - PROCESS | 10065 | _x_x_mozilla_page_load 17:04:51 INFO - PROCESS | 10065 | _x_x_mozilla_page_load_details 17:04:51 INFO - PROCESS | 10065 | |i|pagename|runs| 17:04:51 INFO - PROCESS | 10065 | |0;dojo.html;3068.46301897168;3105.441020616291;3122.4223518649046;3122.6565077841433;3144.4182826177157;5149.871253218671;5243.397009343927;5245.606579506538;5346.438623944483;5380.515753582177;5281.815136470224;5288.206768984654;5300.522952934235;5310.0972834618115;5315.521603055724;4747.501512341206;4771.71369717818;4785.688930219542;4811.711297322155;4816.8554943351755;4794.280857871329;4810.158222311099;4869.074875773609;4879.780409881564;4983.401991760994;4895.31465594817;4922.901541969159;4925.852224433254;4927.457979622239;4980.352554167953;206.53587363990638;4798.952010479886;4799.3041009053495;4920.360353154085;4993.525615066599;4194.4337514435465;4759.262314341283;4774.880627984328;4909.165441874889;4910.754462276872;5338.733063346856;5375.946240537583;5377.005254028018;5386.946130538684;5443.673379597237;5615.7472913718575;5678.176664383683;5703.942960570383;5742.799002034951;5745.138229265602;5690.3456102548325;5733.312002559678;5779.2775903012125;5785.074388097884;5808.564357673192;5372.489613486712;5404.891902162013;5406;5406.702631355274;5408.91886621701;5881.206037184926;5892.528597712173;5894.734736936848;5896.086106653475;5902;5476.91784623231;5518.19986102013;5619.26949496571;5674.290713660793;5675.120356344773;5738.282714660668;5741.368449470555;5744.741486633112;5754.05058165398;5803.970980145073;5719.685417302005;5733.111367738007;5733.168690539848;5738.913916291259;5739.024365857814;5513.5037846593195;5639.407862174495;5641.210230567724;5716.685582293014;5742.569307301969;4282.657387409062;4315.158544083936;4338.284183109751;4375.059362237134;4388.626966707866;3860.478835357247;3865.7100717446306;3873.205992771475;3914.9608503915165;3927.273454410943;5362.65142765719;5362.65142765719;5374.892502149935;5384.246205531229;5385.353757549041;5516.586256030814;5522.91715624266;5570.777168913279;5656.8868622627315;5661.801836935688;5345.4654534546235;5345.599080069011;5358.2498450217;5358.2498450217;5363;4865.854024379274;4903.950960490421;4914.115459217375;4914.262860570871;4917.041176970456;5829.358770535237;5838.620489668158;5844.3571207168025;5844.47399734026;5847.8245652630485;5642.125470551907;5646;5653.095504719226;5658.434156584309;5662.801801936913;5884.9705751470965;5906.793262235801;5909.261342332208;5914.787468569019;5917.142014407973;5625.803096891589;5629.943700562942;5633.521150702236;5638.436156384493;5649.350324712546;5825.2135961644635;5829.562782791223;5832.416758324133;5834.212381328636;5836.678982655994;5468.699221542854;5525.11598144311;5684.118961560965;5686.4029276926985;5693.658380497018;5481.095619222783;5541.833744987495;5549.306336707911;5553.750081246273;5625.803096891589;5511.58663100261;5512.834614961557;5523.6409633373705;5524.392316845224;5527.281453411031;5448.591355648421;5452.781888724407;5529.281193444826;5566.916496252478;5576.191452239484;5505.476979686923;5551.9722401387735;5557.944420555905;5572.4706152915405;5633.0705433604635 17:04:51 INFO - PROCESS | 10065 | |1;ext.html;541.8783867399172;587.0343285295688;600.7056542294275;616.1312549305477;637;31461;43076.569234307644;44279.33580996284;44306.77846610762;44379;45748.77125614376;46195;46219.76890115545;46268.76865615667;46274;8010.5594192319395;8509;8707.95646021769;8713.7821554461;8719.084496127878;8066.395020373466;10558.683239502789;10765.407902565355;10777.892221077807;11253;10971.561137554489;11022.063124634416;11034.337939723602;11049.889501104966;11060.557577696882;10807.945960270188;10881.727956801064;10882.782344353069;10886.183536234814;10898;10692;10747.140228781678;10761.30051546647;10764.838527422095;10770.892291077145;42796.57203427957;42954;43029.784851075856;43045.78477107626;43122;2991.4679260919725;3149.008062460318;3253.1704415374165;3289.111939776271;3540.433530635086;31923.680763192304;32786;32819.50770738441;33016.33967320664;33313.16717082068;4309.202797482476;4384.386185933972;4652.8138874444985;4657.5575320344515;4676.69601475903;335757;336493;337429;337627;338472.99999999756;48378.5162148374;48407.515924841005;48462;48481.5151848477;48512.27231591529;35393.64606353903;36003.099922502144;36046;37861.62138378581;38045.61954380476;15983.280752366172;16131.274092665859;16151.838481615034;16156.515304540882;16161.676766464605;10650.360978341325;11078.889211107786;11759.235649682743;12132.63602091921;12231.388430578436;18404.447866564024;19126.808731912504;19128.330508432136;19198.328058517884;19237.711434328496;6848.383645471832;6991.650417479105;7017.2631873652535;7098.1482222132645;7244.13070431541;887.9200871921429;963.7542426681151;981.5828272983953;1018.9861088217272;1032.6127702111708;32970;33019.66980330214;33042.834785825915;33181.295363502824;33528;1054.514923135351;1068.2095249515457;1111.1388673777726;1174.6006357838376;1195.5994741761433;16335.754963675554;17119.48641540756;17208.1395930203;17247.74128388075;17298.394556190724;516460;520638;522740;522753;528971.9439278505;58475.70762146247;58972.70513647404;58985.41014589799;59031.70484147552;59115;1151.8157094864782;1195.0917302849723;1226.8527776666856;1262.5581046633604;1273.840769903762;31953.360932781678;33370.33259334848;33949.49075763816;33983.320333593685;34600.82699586486;50558.92175095563;54998.72500637471;56115.99999999837;56173.43826561682;61319;477451;481778;484003;484535;486964;27182.320441989108;27366.315842104108;27558.448831023667;28929.42141157207;43408;46584.023404571555;46709.766451167525;46715.766421167675;47092.529074708815;47142.76428617972;38830.80584597172;39955;40457.39313910352;40632.79683601563;41995.16009679851;34640.66991626047;35238.471422929186;35314.1171470705;35608.643913561566;35648.821755891055;41069.58930410777;41109;41637.1672566553;41646.79176604097;41863.37204941989;34283;36621;36639.81680091689;37349.43975840419;37547.43678844765;28191;28246.43507129887;28581.571276431285;28693.713062869105;28768.951606856455 17:04:51 INFO - PROCESS | 10065 | |2;jquery.html;373.5909179448503;378.47203151603514;390.5469655199969;396.2510854485024;415.0723133795967;14229.715405691893;15742.763858542117;18559.536011599717;18904.716429253538;18912.05439728013;17550.561235969075;17673.293068277253;17842.82157178428;17868.195931183094;17973.37093201738;4166.437530933315;5509.421510741375;5745.310562732457;5748.482636562709;5755;4261.893452663693;6097.146399504073;6351;6415.101885736;6524.15186025816;6270.278917924452;6363.172787537614;6408.327125651809;6494.447971922392;6504.252011018722;6339.746410143589;6424.132742079806;6426.228852537702;6430.067640192169;6432.356764323577;5457;5629.183768353607;5683.488486036235;5689.374168841424;5692.48767610917;21918.561628767497;23089;23202.3039308821;23553.293401197992;23658.171963981178;2289.439087423575;2305.216226482987;2342.4963632819026;2954.1285320830407;3014;13238.602841914759;14077.436902523887;14748.115113093141;15046.473373431878;15061.849381506154;1811.420345489444;1896.506908203863;1906.1803424527448;1928.0937959159173;1932.1981377728225;81518;81703;82254.9999999994;84192;85870.57064714699;10017.198624110053;10182.389056656624;10279.537420816081;10318.1745460363;10556.366618002945;14605.707885842223;14608.561743147722;14631.195284259467;14632.48786292496;14652.12087274767;7589.924100759032;7683.2316768323835;7714;7934.444588878839;7956.641951112214;7348.63256837156;7422;7493.250674932572;7698.692052317957;7764.767056988299;6318.589291696117;6348.841278968062;6357.841053973688;6396.744130234832;6409.391107844747;1852.2776117314258;1858.9070546472622;1869.9906500467412;1894.9336773212872;1909.5798924236647;910.3763921713647;924.5007695844304;952.4428209497383;983.7147227304145;1094.6934858239706;19449.611007780048;19833.404997850088;19909;19942.60114797696;19953;965.4834663455158;967.6951760195516;974.8732664753678;994.4431118573622;1004.9648262310784;10178.796424071477;11033.944830275797;11090;11101.611443599435;11333;438302;439386;442099;442505;453220;80094.59952700316;80408;81048.59475702702;81430.77853832197;83603.5819820897;985.4678473624306;985.8619793228954;1022.3456987527989;1034.7206254311293;1038.89611038897;16867;17000.574985624964;17491;17930.193141308413;18359.54101147482;42184.890755462715;42313.78843105765;43126.568734312255;43389;43665;52460;56465;56910.7154464225;56927.715361422925;57846;7890.447668663368;8116.553589552631;8132.430729848854;8271.090180080308;8508.553545897335;13225.867741322849;13359.398827052612;13565;13595.45618175262;13689.589312320646;11434.371109589052;11717.414129293671;12221.205621634565;12306.938465307974;12314.076444266537;11136.777264454828;11320.37737924422;11442.37066961325;11539;12333.321667308026;11338.14963877729;11636.476358563716;11826.290422574673;12078.456469458719;12238.326892021025;7314.926850731425;7509.699612015458;7533.660985255567;8453.915460845314;8552.118533922527;8664.91335086641;10086;11647.184697071123;11723.589674361356;11996.940015299868 17:04:51 INFO - PROCESS | 10065 | |3;mootools.html;1294.1458637299384;1431.148466662336;1501.834798172201;1597.4648492754927;1763.7883453985523;7821.178776228499;8735.344849136316;9079.682211122612;9082.137196966294;9350.90649093509;9044.095590440953;9122.407043542165;9124.178823905848;9124.680636177734;9125.087491250872;2242.506648537323;2248.449129963153;2269.1830940861278;2271.3980795089315;2275.3174047785683;2247.314569056437;2287.142321629389;2308.307507747669;2341.6838726771925;2348.753380895007;2297.793198612125;2301.3671240408853;2307.0886999635136;2307.826912981525;2328.1851352026824;2234.4637287051155;2248.3592176229777;2250.8424410291286;2254.6392577187735;2262.5814224368464;2215.767344428844;2261.0503588492707;2262.1290803040783;2266.410733209361;2272.397814579138;8926.419782714103;9098.45409275439;9138.954305228497;9147.131022552847;9149.771255718593;5047.369078865142;5244.842654720326;5268.262443257947;5272.815451459219;5280.445553216895;3412.2493051528622;3611.1694310308776;3653.314813611993;3692.8153592320277;3704.685101766353;1048.491481631408;1089.3681664634573;1094.983575246364;1110.9777804443947;1111.7665290289049;12505.74988500225;12525.93737031318;12653.051021173356;12664.74670506594;12683.873161268453;4317.935230971538;4377.759223242689;4528.252838281713;4544.545545445495;4621.1219868224925;9780.853287200556;9794.167495762798;9796.167325777245;9797.16724078447;9797.951010244904;5161.948380516222;5167.9224811627855;5170.6122040847085;5172.379314482287;5177.094008548489;4055.655269302142;4254.127903779718;4286;4347.478302603708;4846.466888642247;3493.5807703075793;3796.6962642988497;3804.6956243500454;3867.5165604299464;3875.2755024014605;1147.300146910384;1177.8527684039495;1186.9703257418462;1190.6309044196153;1201.8677945425995;844.7888027993001;883.1345281624044;918.995405022984;939.8214339275515;963.1861077389594;5631.408702086222;5884.705764711833;5910.822675319747;5941.049432090845;6161.075838624152;420.81273833143956;425.4575416344186;429.60905575925756;443.81138016342925;447.05447977527945;3851.422286656968;4048.5344185418467;4056.5943405659787;4082.2243773682903;4128.504579450485;11068.612598559012;11095.334279943228;11385.462962499956;11473.483693233824;11475.827862582068;11144.944275278573;11275.154363422776;11277.661670149908;11288.774224515464;11294.435278236055;8278.420510564203;8369.707060252862;8393.916060839314;8416.2004609562;8475.957620211982;5809.477147056785;5815.069588865761;5838.562107842014;6039.396060394101;6083.847903802441;10326.328788628714;10458.843117353093;10469.31949423285;10477.1094456972;10598.735031624272;9161.129692679186;9912.256580756328;10296.742581435525;10318.17454603645;10473.31923424975;7286.672099755418;8130.308923741548;8270;8361.289290410383;8397;8180.754577362689;8410.663573457237;8512.70205542803;8513.063563008189;8547.102554231964;7330.96334518324;7512.511686740344;7741.380689544711;7759.495632783851;7845.097813751491;7231.927680723125;7278.67245973943;7344.742933997284;7405.518641288514;7611.505252158592;6315.810525684236;6365.267994180728;6366.936330636634;6500.934990650033;6792.694328755317;4624.959384138542;4718.457377401643;4732.148213321635;4873.975630121827;4960.950390496193;4905.705657660552;4919.458859525378;4976.253561965589;5005.874853128701;5039.21892106724 17:04:51 INFO - PROCESS | 10065 | |4;prototype.html;329.84497286275456;332.38674645279457;340.57938446019165;341.92990436960423;344.7087211306445;5048.217526283423;5161.483851614846;5212.400573933999;5213.165893457043;5256.369235691717;4976.975115124428;5098.419489958106;5151.793928242875;5154.536091751742;5160.974195129019;4070.8982275443054;4091.4067460218253;4099.385092236159;4103.076807718255;4103.815328310233;3771.7736935783805;3864.4589757433982;4101.384792281152;4108.342665173573;4113.136241389312;4034.8184331705143;4038.1923615276914;4041.1109555897656;4045.534763502191;4048.838046478137;3997.6208208168136;4017.537983131948;4026.295398305285;4037.2934736421303;4041.868276882463;3583.6953858922025;3586.4261718124976;3586.4620306953907;3587.4798154267746;3588.4617307403837;4986.4764199758865;5043.5965122790085;5077.187649976023;5083.79664813407;5088.6946783193125;4649.023705021949;4651.534846515356;4664.626829853603;4670.883227919295;4673.205555055649;5356.91964620531;5423.105187644034;5423.403425623178;5438.7280635968045;5441.394788537391;3771.264603402338;3899.278633452792;3923.1761330120707;3937.3897045957924;3946.1515774108416;5601.663900166003;5614.838287259435;5614.859628509279;5633.887322253532;5635.267415236034;4109.321961876257;4128.2156390285745;4131.9173616527505;4132.194222126716;4133.132042271097;4027.154297597537;4157.376393540993;4172.311568591209;4175.770332631673;4176.185643799491;4644.094401591725;4665.160271151158;4689.976550117296;4699.295105734167;4706.176419126639;5418.376886658085;5441.238226648273;5454.863628409322;5462.781488740406;5486.396496385394;1417.597212322816;1436.9425222990963;1439.9208043557705;1441.992790036043;1454.338276084379;910.2672348759312;923.7782932096248;936.3539157980971;940.8823897012874;946.6071580294101;4630.166570017429;4633.7683115844075;4637.536246375335;4685.477219903477;4703.623710103184;4943.629227807929;4945.282933974553;4946.629002824802;4946.950530494649;4961.479044700254;4448.887778055486;4598.21830288845;4674.813007479731;4678.368420263221;4719.427911788083;2529.4308780524602;2580.767730904228;2600.6359109724654;2606.5829467285143;2609.6085587161697;5008.348914641147;5012.598992080625;5018.422881368616;5024.949750502521;5051.545360917535;4687.960737079381;4904.43598986114;4966.602671786249;4990.251462280615;4997.425296090923;5013.470891378165;5027.787773379701;5044.974775126101;5060.3168572242275;5082.822101226513;4805.087033463631;4826.455534229013;4826.565609095198;4865.70805751656;4928.556429921181;4815.7351345676325;4843.951560484491;4953.554180123806;4958.7024778513405;5227.555657769132;5762.222100016612;5773.884522309614;5779.797707080232;5784;5807.767689292381;3788.7726736395903;3982.5021872265966;3986.760794352348;3992.700547458894;3994.6404823566018;5199.740012999259;5452.110381497812;5455.099908515051;5457.345118585637;5625.437456254342;5438.293021907127;5441.537469314994;5443.891122177613;5468.808591699271;5496.5053145217125;5287.735613219401;5432.641839540115;5439.401665816677;5441.401445841034;5463.890722185454;5426.403095659553;5438.347398312228;5452.282531002721;5455.699936503372;5459.454054594509;5479.780808767605;5495.53287970527;5497.862553436196;5497.900419915953;5505.339359276913;5233.7383130842545;5359.062164121186;5374.167004114369;5396.298481197419;5426.565874730091 17:04:51 INFO - PROCESS | 10065 | |5;yui.html;643.6266965160207;674.9021391898171;698.6681326369975;728.4281838756575;730.6711979609178;14008.299585020746;14518.709625807478;14650.487232946849;15007.849921500781;15157.317920693567;13606.523771667993;14024.527424620395;14097.295135243248;14131.152130872155;14197;670.9429698475635;673.737242475435;795.5862951265353;807.1807115777491;807.6850028488894;778.7079845058104;800.0519384529351;805.5448671500612;821.6590115102225;822.1203312455675;841.3941961787534;842.5660784695887;843.0599881132524;843.2705709561216;843.4180415513307;700.9228984811666;836.4061516323356;838.4801423117646;839.4249938791947;839.5718183726314;519.1460048220656;599.7990673124508;612.4212619074976;616.017452163798;621.8569728962319;13670.726585468334;13769.31153442334;13791.655208619764;14167.574972750834;14223.85776142246;13079.86920130796;13682.52111176104;13728.45086196561;13806.240656763874;14075.443417436922;11991.340476273801;12156.756864862742;12284.754304913851;12359.32023738694;12559.434825432878;4395.560443955611;4401.867943961686;4480.395146655193;4503.166914120865;4539.0694907543875;79248.20751792466;79923.6003819983;81201;81852;81903.18096819015;10173.643922462677;10230.130438912627;10313.432761198206;10409.53157107932;10546.894531054591;19185.136668849937;19231.903840480707;19252.326168584314;19337.709934350994;19358.903205483883;8099.230573095664;8137.918620813716;8310.584470776557;8417.537035463109;8434.24091831738;4502.189605870974;4529.456465224194;4617.976910115428;4754.833580824724;4756.500567440438;3257.820819854883;3327.73378129749;3329;3351.2962277921424;3362.69735723786;598.9221401217814;608.6895683201599;622.5268795715289;636.9713362898681;655.2530115668142;624.4036944717874;628.3747671067317;629.8362425769242;650.3528988656317;655.3773914780977;8722.956385218033;8822.823543529094;8864.290856731446;8983.146601072887;9011.82846229999;563.5801328010576;605.8405415756849;621.8538643418793;636.207921138186;637.1430426076919;4116.91766164675;4135.710500264952;4458.643308535309;4645.349651048856;4795.736234507136;68229;68625.65687171533;68821.65589172022;68954;109007.45496272467;103026.48486757519;103974.48012759887;104449;105211.0264744563;107735;88616;91481.54259228661;93271;94353.5282323584;94494.99999999863;8917.955410222907;9259.76850578741;9352.298577606844;9389.530523473935;9406.717798466058;52962.47037529575;54161.187582185514;54392;54869.1769623448;55898.44101559095;79558.6022069886;83080;85787.57106214428;85976.27130507631;88743;12122.575709850466;12202.633920982385;12472.376381181086;12532.37338133108;12587.24476531411;13463.394147263592;13514.797278041035;13524.729505410034;13620;14381.712365752417;11289.435528223721;11393.316401015965;11512.769744605228;11729.597628501726;11890.702732431759;12456.252624842538;12508.374581271082;12742.299173545543;12817.551385701456;13788.241646709528;12319.384030798245;12416.689582760504;12848.678783030498;13209.537666181637;13803.791393377012;9706.75733106678;9922.801543968935;10217.744556385853;10319.96282174906;10640.201984851323;10060;10657;10887.673369798918;10890.346579205274;10904.50929708181 17:04:51 INFO - PROCESS | 10065 | __end_tp_report 17:04:51 INFO - PROCESS | 10065 | __start_cc_report 17:04:51 INFO - PROCESS | 10065 | _x_x_mozilla_cycle_collect,1276 17:04:51 INFO - PROCESS | 10065 | __end_cc_report 17:04:51 INFO - PROCESS | 10065 | __startTimestamp1477353891093__endTimestamp 17:04:51 INFO - PROCESS | 10065 | 17:04:51 INFO - PROCESS | 10065 | ------- Summary: start ------- 17:04:51 INFO - PROCESS | 10065 | Number of tests: 6 17:04:51 INFO - PROCESS | 10065 | 17:04:51 INFO - PROCESS | 10065 | [#0] dojo.html Cycles:165 Average:5268.57 Median:5512.83 stddev:723.29 (13.1%) stddev-sans-first:704.61 17:04:51 INFO - PROCESS | 10065 | Values: 3068.5 3105.4 3122.4 3122.7 3144.4 5149.9 5243.4 5245.6 5346.4 5380.5 5281.8 5288.2 5300.5 5310.1 5315.5 4747.5 4771.7 4785.7 4811.7 4816.9 4794.3 4810.2 4869.1 4879.8 4983.4 4895.3 4922.9 4925.9 4927.5 4980.4 206.5 4799.0 4799.3 4920.4 4993.5 4194.4 4759.3 4774.9 4909.2 4910.8 5338.7 5375.9 5377.0 5386.9 5443.7 5615.7 5678.2 5703.9 5742.8 5745.1 5690.3 5733.3 5779.3 5785.1 5808.6 5372.5 5404.9 5406.0 5406.7 5408.9 5881.2 5892.5 5894.7 5896.1 5902.0 5476.9 5518.2 5619.3 5674.3 5675.1 5738.3 5741.4 5744.7 5754.1 5804.0 5719.7 5733.1 5733.2 5738.9 5739.0 5513.5 5639.4 5641.2 5716.7 5742.6 4282.7 4315.2 4338.3 4375.1 4388.6 3860.5 3865.7 3873.2 3915.0 3927.3 5362.7 5362.7 5374.9 5384.2 5385.4 5516.6 5522.9 5570.8 5656.9 5661.8 5345.5 5345.6 5358.2 5358.2 5363.0 4865.9 4904.0 4914.1 4914.3 4917.0 5829.4 5838.6 5844.4 5844.5 5847.8 5642.1 5646.0 5653.1 5658.4 5662.8 5885.0 5906.8 5909.3 5914.8 5917.1 5625.8 5629.9 5633.5 5638.4 5649.4 5825.2 5829.6 5832.4 5834.2 5836.7 5468.7 5525.1 5684.1 5686.4 5693.7 5481.1 5541.8 5549.3 5553.8 5625.8 5511.6 5512.8 5523.6 5524.4 5527.3 5448.6 5452.8 5529.3 5566.9 5576.2 5505.5 5552.0 5557.9 5572.5 5633.1 17:04:51 INFO - PROCESS | 10065 | 17:04:51 INFO - PROCESS | 10065 | [#1] ext.html Cycles:180 Average:60172.37 Median:19574.54 stddev:120557.18 (615.9%) stddev-sans-first:120812.24 17:04:51 INFO - PROCESS | 10065 | Values: 541.9 587.0 600.7 616.1 637.0 31461.0 43076.6 44279.3 44306.8 44379.0 45748.8 46195.0 46219.8 46268.8 46274.0 8010.6 8509.0 8708.0 8713.8 8719.1 8066.4 10558.7 10765.4 10777.9 11253.0 10971.6 11022.1 11034.3 11049.9 11060.6 10807.9 10881.7 10882.8 10886.2 10898.0 10692.0 10747.1 10761.3 10764.8 10770.9 42796.6 42954.0 43029.8 43045.8 43122.0 2991.5 3149.0 3253.2 3289.1 3540.4 31923.7 32786.0 32819.5 33016.3 33313.2 4309.2 4384.4 4652.8 4657.6 4676.7 335757.0 336493.0 337429.0 337627.0 338473.0 48378.5 48407.5 48462.0 48481.5 48512.3 35393.6 36003.1 36046.0 37861.6 38045.6 15983.3 16131.3 16151.8 16156.5 16161.7 10650.4 11078.9 11759.2 12132.6 12231.4 18404.4 19126.8 19128.3 19198.3 19237.7 6848.4 6991.7 7017.3 7098.1 7244.1 887.9 963.8 981.6 1019.0 1032.6 32970.0 33019.7 33042.8 33181.3 33528.0 1054.5 1068.2 1111.1 1174.6 1195.6 16335.8 17119.5 17208.1 17247.7 17298.4 516460.0 520638.0 522740.0 522753.0 528971.9 58475.7 58972.7 58985.4 59031.7 59115.0 1151.8 1195.1 1226.9 1262.6 1273.8 31953.4 33370.3 33949.5 33983.3 34600.8 50558.9 54998.7 56116.0 56173.4 61319.0 477451.0 481778.0 484003.0 484535.0 486964.0 27182.3 27366.3 27558.4 28929.4 43408.0 46584.0 46709.8 46715.8 47092.5 47142.8 38830.8 39955.0 40457.4 40632.8 41995.2 34640.7 35238.5 35314.1 35608.6 35648.8 41069.6 41109.0 41637.2 41646.8 41863.4 34283.0 36621.0 36639.8 37349.4 37547.4 28191.0 28246.4 28581.6 28693.7 28769.0 17:04:51 INFO - PROCESS | 10065 | 17:04:51 INFO - PROCESS | 10065 | [#2] jquery.html Cycles:180 Average:27479.27 Median:384.51 stddev:73120.10 (19016.5%) stddev-sans-first:73296.90 17:04:51 INFO - PROCESS | 10065 | Values: 373.6 378.5 390.5 396.3 415.1 14229.7 15742.8 18559.5 18904.7 18912.1 17550.6 17673.3 17842.8 17868.2 17973.4 4166.4 5509.4 5745.3 5748.5 5755.0 4261.9 6097.1 6351.0 6415.1 6524.2 6270.3 6363.2 6408.3 6494.4 6504.3 6339.7 6424.1 6426.2 6430.1 6432.4 5457.0 5629.2 5683.5 5689.4 5692.5 21918.6 23089.0 23202.3 23553.3 23658.2 2289.4 2305.2 2342.5 2954.1 3014.0 13238.6 14077.4 14748.1 15046.5 15061.8 1811.4 1896.5 1906.2 1928.1 1932.2 81518.0 81703.0 82255.0 84192.0 85870.6 10017.2 10182.4 10279.5 10318.2 10556.4 14605.7 14608.6 14631.2 14632.5 14652.1 7589.9 7683.2 7714.0 7934.4 7956.6 7348.6 7422.0 7493.3 7698.7 7764.8 6318.6 6348.8 6357.8 6396.7 6409.4 1852.3 1858.9 1870.0 1894.9 1909.6 910.4 924.5 952.4 983.7 1094.7 19449.6 19833.4 19909.0 19942.6 19953.0 965.5 967.7 974.9 994.4 1005.0 10178.8 11033.9 11090.0 11101.6 11333.0 438302.0 439386.0 442099.0 442505.0 453220.0 80094.6 80408.0 81048.6 81430.8 83603.6 985.5 985.9 1022.3 1034.7 1038.9 16867.0 17000.6 17491.0 17930.2 18359.5 42184.9 42313.8 43126.6 43389.0 43665.0 52460.0 56465.0 56910.7 56927.7 57846.0 7890.4 8116.6 8132.4 8271.1 8508.6 13225.9 13359.4 13565.0 13595.5 13689.6 11434.4 11717.4 12221.2 12306.9 12314.1 11136.8 11320.4 11442.4 11539.0 12333.3 11338.1 11636.5 11826.3 12078.5 12238.3 7314.9 7509.7 7533.7 8453.9 8552.1 8664.9 10086.0 11647.2 11723.6 11996.9 17:04:51 INFO - PROCESS | 10065 | 17:04:51 INFO - PROCESS | 10065 | [#3] mootools.html Cycles:180 Average:5766.44 Median:4582.83 stddev:3400.65 (74.2%) stddev-sans-first:3393.58 17:04:51 INFO - PROCESS | 10065 | Values: 1294.1 1431.1 1501.8 1597.5 1763.8 7821.2 8735.3 9079.7 9082.1 9350.9 9044.1 9122.4 9124.2 9124.7 9125.1 2242.5 2248.4 2269.2 2271.4 2275.3 2247.3 2287.1 2308.3 2341.7 2348.8 2297.8 2301.4 2307.1 2307.8 2328.2 2234.5 2248.4 2250.8 2254.6 2262.6 2215.8 2261.1 2262.1 2266.4 2272.4 8926.4 9098.5 9139.0 9147.1 9149.8 5047.4 5244.8 5268.3 5272.8 5280.4 3412.2 3611.2 3653.3 3692.8 3704.7 1048.5 1089.4 1095.0 1111.0 1111.8 12505.7 12525.9 12653.1 12664.7 12683.9 4317.9 4377.8 4528.3 4544.5 4621.1 9780.9 9794.2 9796.2 9797.2 9798.0 5161.9 5167.9 5170.6 5172.4 5177.1 4055.7 4254.1 4286.0 4347.5 4846.5 3493.6 3796.7 3804.7 3867.5 3875.3 1147.3 1177.9 1187.0 1190.6 1201.9 844.8 883.1 919.0 939.8 963.2 5631.4 5884.7 5910.8 5941.0 6161.1 420.8 425.5 429.6 443.8 447.1 3851.4 4048.5 4056.6 4082.2 4128.5 11068.6 11095.3 11385.5 11473.5 11475.8 11144.9 11275.2 11277.7 11288.8 11294.4 8278.4 8369.7 8393.9 8416.2 8476.0 5809.5 5815.1 5838.6 6039.4 6083.8 10326.3 10458.8 10469.3 10477.1 10598.7 9161.1 9912.3 10296.7 10318.2 10473.3 7286.7 8130.3 8270.0 8361.3 8397.0 8180.8 8410.7 8512.7 8513.1 8547.1 7331.0 7512.5 7741.4 7759.5 7845.1 7231.9 7278.7 7344.7 7405.5 7611.5 6315.8 6365.3 6366.9 6500.9 6792.7 4625.0 4718.5 4732.1 4874.0 4961.0 4905.7 4919.5 4976.3 5005.9 5039.2 17:04:51 INFO - PROCESS | 10065 | 17:04:51 INFO - PROCESS | 10065 | [#4] prototype.html Cycles:180 Average:4436.91 Median:4945.96 stddev:1274.18 (25.8%) stddev-sans-first:1239.90 17:04:51 INFO - PROCESS | 10065 | Values: 329.8 332.4 340.6 341.9 344.7 5048.2 5161.5 5212.4 5213.2 5256.4 4977.0 5098.4 5151.8 5154.5 5161.0 4070.9 4091.4 4099.4 4103.1 4103.8 3771.8 3864.5 4101.4 4108.3 4113.1 4034.8 4038.2 4041.1 4045.5 4048.8 3997.6 4017.5 4026.3 4037.3 4041.9 3583.7 3586.4 3586.5 3587.5 3588.5 4986.5 5043.6 5077.2 5083.8 5088.7 4649.0 4651.5 4664.6 4670.9 4673.2 5356.9 5423.1 5423.4 5438.7 5441.4 3771.3 3899.3 3923.2 3937.4 3946.2 5601.7 5614.8 5614.9 5633.9 5635.3 4109.3 4128.2 4131.9 4132.2 4133.1 4027.2 4157.4 4172.3 4175.8 4176.2 4644.1 4665.2 4690.0 4699.3 4706.2 5418.4 5441.2 5454.9 5462.8 5486.4 1417.6 1436.9 1439.9 1442.0 1454.3 910.3 923.8 936.4 940.9 946.6 4630.2 4633.8 4637.5 4685.5 4703.6 4943.6 4945.3 4946.6 4947.0 4961.5 4448.9 4598.2 4674.8 4678.4 4719.4 2529.4 2580.8 2600.6 2606.6 2609.6 5008.3 5012.6 5018.4 5024.9 5051.5 4688.0 4904.4 4966.6 4990.3 4997.4 5013.5 5027.8 5045.0 5060.3 5082.8 4805.1 4826.5 4826.6 4865.7 4928.6 4815.7 4844.0 4953.6 4958.7 5227.6 5762.2 5773.9 5779.8 5784.0 5807.8 3788.8 3982.5 3986.8 3992.7 3994.6 5199.7 5452.1 5455.1 5457.3 5625.4 5438.3 5441.5 5443.9 5468.8 5496.5 5287.7 5432.6 5439.4 5441.4 5463.9 5426.4 5438.3 5452.3 5455.7 5459.5 5479.8 5495.5 5497.9 5497.9 5505.3 5233.7 5359.1 5374.2 5396.3 5426.6 17:04:51 INFO - PROCESS | 10065 | 17:04:51 INFO - PROCESS | 10065 | [#5] yui.html Cycles:180 Average:20167.86 Median:4700.09 stddev:29182.01 (620.9%) stddev-sans-first:29227.05 17:04:51 INFO - PROCESS | 10065 | Values: 643.6 674.9 698.7 728.4 730.7 14008.3 14518.7 14650.5 15007.8 15157.3 13606.5 14024.5 14097.3 14131.2 14197.0 670.9 673.7 795.6 807.2 807.7 778.7 800.1 805.5 821.7 822.1 841.4 842.6 843.1 843.3 843.4 700.9 836.4 838.5 839.4 839.6 519.1 599.8 612.4 616.0 621.9 13670.7 13769.3 13791.7 14167.6 14223.9 13079.9 13682.5 13728.5 13806.2 14075.4 11991.3 12156.8 12284.8 12359.3 12559.4 4395.6 4401.9 4480.4 4503.2 4539.1 79248.2 79923.6 81201.0 81852.0 81903.2 10173.6 10230.1 10313.4 10409.5 10546.9 19185.1 19231.9 19252.3 19337.7 19358.9 8099.2 8137.9 8310.6 8417.5 8434.2 4502.2 4529.5 4618.0 4754.8 4756.5 3257.8 3327.7 3329.0 3351.3 3362.7 598.9 608.7 622.5 637.0 655.3 624.4 628.4 629.8 650.4 655.4 8723.0 8822.8 8864.3 8983.1 9011.8 563.6 605.8 621.9 636.2 637.1 4116.9 4135.7 4458.6 4645.3 4795.7 68229.0 68625.7 68821.7 68954.0 109007.5 103026.5 103974.5 104449.0 105211.0 107735.0 88616.0 91481.5 93271.0 94353.5 94495.0 8918.0 9259.8 9352.3 9389.5 9406.7 52962.5 54161.2 54392.0 54869.2 55898.4 79558.6 83080.0 85787.6 85976.3 88743.0 12122.6 12202.6 12472.4 12532.4 12587.2 13463.4 13514.8 13524.7 13620.0 14381.7 11289.4 11393.3 11512.8 11729.6 11890.7 12456.3 12508.4 12742.3 12817.6 13788.2 12319.4 12416.7 12848.7 13209.5 13803.8 9706.8 9922.8 10217.7 10320.0 10640.2 10060.0 10657.0 10887.7 10890.3 10904.5 17:04:51 INFO - PROCESS | 10065 | -------- Summary: end -------- 17:04:51 INFO - PROCESS | 10065 | 17:04:52 INFO - TEST-INFO | 10065: exit 0 17:04:52 INFO - TEST-OK | dromaeo_css | took 1117890ms 17:04:52 INFO - TEST-START | kraken 17:04:52 INFO - operating with platform_type : linux_ 17:04:52 INFO - Initialising browser for kraken test... 17:04:52 INFO - TEST-INFO | started process 10372 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVQHB3n/profile http://localhost:33521/getInfo.html) 17:04:56 INFO - PROCESS | 10372 | __metrics Screen width/height:1600/1200 17:04:56 INFO - PROCESS | 10372 | colorDepth:24 17:04:56 INFO - PROCESS | 10372 | Browser inner width/height: 1024/697 17:04:56 INFO - PROCESS | 10372 | __metrics 17:04:56 INFO - PROCESS | 10372 | 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" 17:04:56 INFO - PROCESS | 10372 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:04:57 INFO - PROCESS | 10372 | console.error: PushService: 17:04:57 INFO - PROCESS | 10372 | stateChangeProcessEnqueue: Error transitioning state 17:04:57 INFO - PROCESS | 10372 | UnknownError 17:04:58 INFO - TEST-INFO | 10372: exit 0 17:04:58 INFO - Browser initialized. 17:04:58 INFO - Running cycle 1/1 for kraken test... 17:04:58 INFO - TEST-INFO | started process 10455 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVQHB3n/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:05:10 INFO - PROCESS | 10455 | RSS: Main: 171958272 17:05:10 INFO - PROCESS | 10455 | 17:05:12 INFO - PROCESS | 10455 | Cycle 1(1): loaded http://localhost:33521/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33521/tests/kraken/driver.html?testName=audio-beat-detection) 17:05:13 INFO - PROCESS | 10455 | RSS: Main: 228560896 17:05:13 INFO - PROCESS | 10455 | 17:05:16 INFO - PROCESS | 10455 | Cycle 1(1): loaded http://localhost:33521/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33521/tests/kraken/driver.html?testName=audio-dft) 17:05:17 INFO - PROCESS | 10455 | RSS: Main: 216260608 17:05:17 INFO - PROCESS | 10455 | 17:05:20 INFO - PROCESS | 10455 | Cycle 1(1): loaded http://localhost:33521/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33521/tests/kraken/driver.html?testName=audio-fft) 17:05:20 INFO - PROCESS | 10455 | RSS: Main: 297906176 17:05:20 INFO - PROCESS | 10455 | 17:05:22 INFO - PROCESS | 10455 | Cycle 1(1): loaded http://localhost:33521/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33521/tests/kraken/driver.html?testName=audio-oscillator) 17:05:23 INFO - PROCESS | 10455 | RSS: Main: 206675968 17:05:23 INFO - PROCESS | 10455 | 17:05:25 INFO - PROCESS | 10455 | Cycle 1(1): loaded http://localhost:33521/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33521/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:05:26 INFO - PROCESS | 10455 | RSS: Main: 211685376 17:05:26 INFO - PROCESS | 10455 | 17:05:29 INFO - PROCESS | 10455 | Cycle 1(1): loaded http://localhost:33521/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33521/tests/kraken/driver.html?testName=imaging-darkroom) 17:05:29 INFO - PROCESS | 10455 | RSS: Main: 247922688 17:05:29 INFO - PROCESS | 10455 | 17:05:33 INFO - PROCESS | 10455 | Cycle 1(1): loaded http://localhost:33521/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33521/tests/kraken/driver.html?testName=imaging-desaturate) 17:05:33 INFO - PROCESS | 10455 | RSS: Main: 246767616 17:05:33 INFO - PROCESS | 10455 | 17:05:36 INFO - PROCESS | 10455 | Cycle 1(1): loaded http://localhost:33521/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33521/tests/kraken/driver.html?testName=json-parse-financial) 17:05:36 INFO - PROCESS | 10455 | RSS: Main: 246300672 17:05:36 INFO - PROCESS | 10455 | 17:05:38 INFO - PROCESS | 10455 | Cycle 1(1): loaded http://localhost:33521/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33521/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:05:39 INFO - PROCESS | 10455 | RSS: Main: 209080320 17:05:39 INFO - PROCESS | 10455 | 17:05:40 INFO - PROCESS | 10455 | Cycle 1(1): loaded http://localhost:33521/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33521/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:05:41 INFO - PROCESS | 10455 | RSS: Main: 215502848 17:05:41 INFO - PROCESS | 10455 | 17:05:43 INFO - PROCESS | 10455 | Cycle 1(1): loaded http://localhost:33521/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33521/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:05:44 INFO - PROCESS | 10455 | RSS: Main: 226152448 17:05:44 INFO - PROCESS | 10455 | 17:05:46 INFO - PROCESS | 10455 | Cycle 1(1): loaded http://localhost:33521/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33521/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:05:47 INFO - PROCESS | 10455 | RSS: Main: 229908480 17:05:47 INFO - PROCESS | 10455 | 17:05:50 INFO - PROCESS | 10455 | Cycle 1(1): loaded http://localhost:33521/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33521/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:05:50 INFO - PROCESS | 10455 | RSS: Main: 231571456 17:05:50 INFO - PROCESS | 10455 | 17:05:52 INFO - PROCESS | 10455 | Cycle 1(1): loaded http://localhost:33521/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33521/tests/kraken/driver.html?testName=ai-astar) 17:05:52 INFO - PROCESS | 10455 | RSS: Main: 282980352 17:05:52 INFO - PROCESS | 10455 | 17:05:52 INFO - PROCESS | 10455 | __start_tp_report 17:05:52 INFO - PROCESS | 10455 | _x_x_mozilla_page_load 17:05:52 INFO - PROCESS | 10455 | _x_x_mozilla_page_load_details 17:05:52 INFO - PROCESS | 10455 | |i|pagename|runs| 17:05:52 INFO - PROCESS | 10455 | |0;ai-astar;106;112;114;111;112;111;114;111;111;110 17:05:52 INFO - PROCESS | 10455 | |1;audio-beat-detection;159;130;127;159;125;126;124;125;158;127 17:05:52 INFO - PROCESS | 10455 | |2;audio-dft;162;162;161;161;164;161;161;161;161;161 17:05:52 INFO - PROCESS | 10455 | |3;audio-fft;75;75;75;119;76;76;75;76;97;75 17:05:52 INFO - PROCESS | 10455 | |4;audio-oscillator;82;82;106;82;82;83;103;82;83;109 17:05:52 INFO - PROCESS | 10455 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;117 17:05:52 INFO - PROCESS | 10455 | |6;imaging-darkroom;146;146;146;147;146;145;146;146;146;145 17:05:52 INFO - PROCESS | 10455 | |7;imaging-desaturate;84;84;84;84;84;84;85;85;85;85 17:05:52 INFO - PROCESS | 10455 | |8;json-parse-financial;52;60;54;53;54;54;54;55;54;55 17:05:52 INFO - PROCESS | 10455 | |9;json-stringify-tinderbox;58;59;60;59;60;59;59;59;59;59 17:05:52 INFO - PROCESS | 10455 | |10;stanford-crypto-aes;79;81;85;79;81;80;79;86;82;80 17:05:52 INFO - PROCESS | 10455 | |11;stanford-crypto-ccm;143;131;132;129;128;133;129;130;186;139 17:05:52 INFO - PROCESS | 10455 | |12;stanford-crypto-pbkdf2;168;169;166;165;166;168;166;165;163;168 17:05:52 INFO - PROCESS | 10455 | |13;stanford-crypto-sha256-iterative;64;66;66;66;66;65;64;65;64;64 17:05:52 INFO - PROCESS | 10455 | __end_tp_report 17:05:52 INFO - PROCESS | 10455 | __start_cc_report 17:05:52 INFO - PROCESS | 10455 | _x_x_mozilla_cycle_collect,1690 17:05:52 INFO - PROCESS | 10455 | __end_cc_report 17:05:52 INFO - PROCESS | 10455 | __startTimestamp1477353952655__endTimestamp 17:05:52 INFO - PROCESS | 10455 | 17:05:52 INFO - PROCESS | 10455 | ------- Summary: start ------- 17:05:52 INFO - PROCESS | 10455 | Number of tests: 14 17:05:52 INFO - PROCESS | 10455 | 17:05:52 INFO - PROCESS | 10455 | [#0] ai-astar Cycles:10 Average:111.20 Median:111.50 stddev:2.25 (2.0%) stddev-sans-first:1.39 17:05:52 INFO - PROCESS | 10455 | Values: 106.0 112.0 114.0 111.0 112.0 111.0 114.0 111.0 111.0 110.0 17:05:52 INFO - PROCESS | 10455 | 17:05:52 INFO - PROCESS | 10455 | [#1] audio-beat-detection Cycles:10 Average:136.00 Median:128.50 stddev:15.73 (12.2%) stddev-sans-first:14.31 17:05:52 INFO - PROCESS | 10455 | Values: 159.0 130.0 127.0 159.0 125.0 126.0 124.0 125.0 158.0 127.0 17:05:52 INFO - PROCESS | 10455 | 17:05:52 INFO - PROCESS | 10455 | [#2] audio-dft Cycles:10 Average:161.50 Median:161.00 stddev:0.97 (0.6%) stddev-sans-first:1.01 17:05:52 INFO - PROCESS | 10455 | Values: 162.0 162.0 161.0 161.0 164.0 161.0 161.0 161.0 161.0 161.0 17:05:52 INFO - PROCESS | 10455 | 17:05:52 INFO - PROCESS | 10455 | [#3] audio-fft Cycles:10 Average:81.90 Median:75.50 stddev:14.71 (19.5%) stddev-sans-first:15.39 17:05:52 INFO - PROCESS | 10455 | Values: 75.0 75.0 75.0 119.0 76.0 76.0 75.0 76.0 97.0 75.0 17:05:52 INFO - PROCESS | 10455 | 17:05:52 INFO - PROCESS | 10455 | [#4] audio-oscillator Cycles:10 Average:89.40 Median:82.00 stddev:11.55 (14.1%) stddev-sans-first:11.94 17:05:52 INFO - PROCESS | 10455 | Values: 82.0 82.0 106.0 82.0 82.0 83.0 103.0 82.0 83.0 109.0 17:05:52 INFO - PROCESS | 10455 | 17:05:52 INFO - PROCESS | 10455 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 17:05:52 INFO - PROCESS | 10455 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 17:05:52 INFO - PROCESS | 10455 | 17:05:52 INFO - PROCESS | 10455 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 17:05:52 INFO - PROCESS | 10455 | Values: 146.0 146.0 146.0 147.0 146.0 145.0 146.0 146.0 146.0 145.0 17:05:52 INFO - PROCESS | 10455 | 17:05:52 INFO - PROCESS | 10455 | [#7] imaging-desaturate Cycles:10 Average:84.40 Median:84.50 stddev:0.52 (0.6%) stddev-sans-first:0.53 17:05:52 INFO - PROCESS | 10455 | Values: 84.0 84.0 84.0 84.0 84.0 84.0 85.0 85.0 85.0 85.0 17:05:52 INFO - PROCESS | 10455 | 17:05:52 INFO - PROCESS | 10455 | [#8] json-parse-financial Cycles:10 Average:54.50 Median:54.00 stddev:2.12 (3.9%) stddev-sans-first:2.05 17:05:52 INFO - PROCESS | 10455 | Values: 52.0 60.0 54.0 53.0 54.0 54.0 54.0 55.0 54.0 55.0 17:05:52 INFO - PROCESS | 10455 | 17:05:52 INFO - PROCESS | 10455 | [#9] json-stringify-tinderbox Cycles:10 Average:59.10 Median:59.00 stddev:0.57 (1.0%) stddev-sans-first:0.44 17:05:52 INFO - PROCESS | 10455 | Values: 58.0 59.0 60.0 59.0 60.0 59.0 59.0 59.0 59.0 59.0 17:05:52 INFO - PROCESS | 10455 | 17:05:52 INFO - PROCESS | 10455 | [#10] stanford-crypto-aes Cycles:10 Average:81.20 Median:81.00 stddev:2.49 (3.1%) stddev-sans-first:2.51 17:05:52 INFO - PROCESS | 10455 | Values: 79.0 81.0 85.0 79.0 81.0 80.0 79.0 86.0 82.0 80.0 17:05:52 INFO - PROCESS | 10455 | 17:05:52 INFO - PROCESS | 10455 | [#11] stanford-crypto-ccm Cycles:10 Average:138.00 Median:132.50 stddev:17.53 (13.2%) stddev-sans-first:18.50 17:05:52 INFO - PROCESS | 10455 | Values: 143.0 131.0 132.0 129.0 128.0 133.0 129.0 130.0 186.0 139.0 17:05:52 INFO - PROCESS | 10455 | 17:05:52 INFO - PROCESS | 10455 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.40 Median:167.00 stddev:1.84 (1.1%) stddev-sans-first:1.86 17:05:52 INFO - PROCESS | 10455 | Values: 168.0 169.0 166.0 165.0 166.0 168.0 166.0 165.0 163.0 168.0 17:05:52 INFO - PROCESS | 10455 | 17:05:52 INFO - PROCESS | 10455 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.00 Median:65.50 stddev:0.94 (1.4%) stddev-sans-first:0.93 17:05:52 INFO - PROCESS | 10455 | Values: 64.0 66.0 66.0 66.0 66.0 65.0 64.0 65.0 64.0 64.0 17:05:52 INFO - PROCESS | 10455 | -------- Summary: end -------- 17:05:52 INFO - PROCESS | 10455 | 17:05:53 INFO - TEST-INFO | 10455: exit 0 17:05:53 INFO - TEST-OK | kraken | took 61892ms 17:05:53 INFO - SUITE-END | took 1179s 17:05:54 INFO - Completed test suite (00:19:40) 17:05:54 INFO - javascript benchmark 17:05:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3068.46301897168, 3105.441020616291, 3122.4223518649046, 3122.6565077841433, 3144.4182826177157, 5149.871253218671, 5243.397009343927, 5245.606579506538, 5346.438623944483, 5380.515753582177, 5281.815136470224, 5288.206768984654, 5300.522952934235, 5310.0972834618115, 5315.521603055724, 4747.501512341206, 4771.71369717818, 4785.688930219542, 4811.711297322155, 4816.8554943351755, 4794.280857871329, 4810.158222311099, 4869.074875773609, 4879.780409881564, 4983.401991760994, 4895.31465594817, 4922.901541969159, 4925.852224433254, 4927.457979622239, 4980.352554167953, 206.53587363990638, 4798.952010479886, 4799.3041009053495, 4920.360353154085, 4993.525615066599, 4194.4337514435465, 4759.262314341283, 4774.880627984328, 4909.165441874889, 4910.754462276872, 5338.733063346856, 5375.946240537583, 5377.005254028018, 5386.946130538684, 5443.673379597237, 5615.7472913718575, 5678.176664383683, 5703.942960570383, 5742.799002034951, 5745.138229265602, 5690.3456102548325, 5733.312002559678, 5779.2775903012125, 5785.074388097884, 5808.564357673192, 5372.489613486712, 5404.891902162013, 5406.0, 5406.702631355274, 5408.91886621701, 5881.206037184926, 5892.528597712173, 5894.734736936848, 5896.086106653475, 5902.0, 5476.91784623231, 5518.19986102013, 5619.26949496571, 5674.290713660793, 5675.120356344773, 5738.282714660668, 5741.368449470555, 5744.741486633112, 5754.05058165398, 5803.970980145073, 5719.685417302005, 5733.111367738007, 5733.168690539848, 5738.913916291259, 5739.024365857814, 5513.5037846593195, 5639.407862174495, 5641.210230567724, 5716.685582293014, 5742.569307301969, 4282.657387409062, 4315.158544083936, 4338.284183109751, 4375.059362237134, 4388.626966707866, 3860.478835357247, 3865.7100717446306, 3873.205992771475, 3914.9608503915165, 3927.273454410943, 5362.65142765719, 5362.65142765719, 5374.892502149935, 5384.246205531229, 5385.353757549041, 5516.586256030814, 5522.91715624266, 5570.777168913279, 5656.8868622627315, 5661.801836935688, 5345.4654534546235, 5345.599080069011, 5358.2498450217, 5358.2498450217, 5363.0, 4865.854024379274, 4903.950960490421, 4914.115459217375, 4914.262860570871, 4917.041176970456, 5829.358770535237, 5838.620489668158, 5844.3571207168025, 5844.47399734026, 5847.8245652630485, 5642.125470551907, 5646.0, 5653.095504719226, 5658.434156584309, 5662.801801936913, 5884.9705751470965, 5906.793262235801, 5909.261342332208, 5914.787468569019, 5917.142014407973, 5625.803096891589, 5629.943700562942, 5633.521150702236, 5638.436156384493, 5649.350324712546, 5825.2135961644635, 5829.562782791223, 5832.416758324133, 5834.212381328636, 5836.678982655994, 5468.699221542854, 5525.11598144311, 5684.118961560965, 5686.4029276926985, 5693.658380497018, 5481.095619222783, 5541.833744987495, 5549.306336707911, 5553.750081246273, 5625.803096891589, 5511.58663100261, 5512.834614961557, 5523.6409633373705, 5524.392316845224, 5527.281453411031, 5448.591355648421, 5452.781888724407, 5529.281193444826, 5566.916496252478, 5576.191452239484, 5505.476979686923, 5551.9722401387735, 5557.944420555905, 5572.4706152915405, 5633.0705433604635], "value": 5222.335904160693, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [541.8783867399172, 587.0343285295688, 600.7056542294275, 616.1312549305477, 637.0, 31461.0, 43076.569234307644, 44279.33580996284, 44306.77846610762, 44379.0, 45748.77125614376, 46195.0, 46219.76890115545, 46268.76865615667, 46274.0, 8010.5594192319395, 8509.0, 8707.95646021769, 8713.7821554461, 8719.084496127878, 8066.395020373466, 10558.683239502789, 10765.407902565355, 10777.892221077807, 11253.0, 10971.561137554489, 11022.063124634416, 11034.337939723602, 11049.889501104966, 11060.557577696882, 10807.945960270188, 10881.727956801064, 10882.782344353069, 10886.183536234814, 10898.0, 10692.0, 10747.140228781678, 10761.30051546647, 10764.838527422095, 10770.892291077145, 42796.57203427957, 42954.0, 43029.784851075856, 43045.78477107626, 43122.0, 2991.4679260919725, 3149.008062460318, 3253.1704415374165, 3289.111939776271, 3540.433530635086, 31923.680763192304, 32786.0, 32819.50770738441, 33016.33967320664, 33313.16717082068, 4309.202797482476, 4384.386185933972, 4652.8138874444985, 4657.5575320344515, 4676.69601475903, 335757.0, 336493.0, 337429.0, 337627.0, 338472.99999999756, 48378.5162148374, 48407.515924841005, 48462.0, 48481.5151848477, 48512.27231591529, 35393.64606353903, 36003.099922502144, 36046.0, 37861.62138378581, 38045.61954380476, 15983.280752366172, 16131.274092665859, 16151.838481615034, 16156.515304540882, 16161.676766464605, 10650.360978341325, 11078.889211107786, 11759.235649682743, 12132.63602091921, 12231.388430578436, 18404.447866564024, 19126.808731912504, 19128.330508432136, 19198.328058517884, 19237.711434328496, 6848.383645471832, 6991.650417479105, 7017.2631873652535, 7098.1482222132645, 7244.13070431541, 887.9200871921429, 963.7542426681151, 981.5828272983953, 1018.9861088217272, 1032.6127702111708, 32970.0, 33019.66980330214, 33042.834785825915, 33181.295363502824, 33528.0, 1054.514923135351, 1068.2095249515457, 1111.1388673777726, 1174.6006357838376, 1195.5994741761433, 16335.754963675554, 17119.48641540756, 17208.1395930203, 17247.74128388075, 17298.394556190724, 516460.0, 520638.0, 522740.0, 522753.0, 528971.9439278505, 58475.70762146247, 58972.70513647404, 58985.41014589799, 59031.70484147552, 59115.0, 1151.8157094864782, 1195.0917302849723, 1226.8527776666856, 1262.5581046633604, 1273.840769903762, 31953.360932781678, 33370.33259334848, 33949.49075763816, 33983.320333593685, 34600.82699586486, 50558.92175095563, 54998.72500637471, 56115.99999999837, 56173.43826561682, 61319.0, 477451.0, 481778.0, 484003.0, 484535.0, 486964.0, 27182.320441989108, 27366.315842104108, 27558.448831023667, 28929.42141157207, 43408.0, 46584.023404571555, 46709.766451167525, 46715.766421167675, 47092.529074708815, 47142.76428617972, 38830.80584597172, 39955.0, 40457.39313910352, 40632.79683601563, 41995.16009679851, 34640.66991626047, 35238.471422929186, 35314.1171470705, 35608.643913561566, 35648.821755891055, 41069.58930410777, 41109.0, 41637.1672566553, 41646.79176604097, 41863.37204941989, 34283.0, 36621.0, 36639.81680091689, 37349.43975840419, 37547.43678844765, 28191.0, 28246.43507129887, 28581.571276431285, 28693.713062869105, 28768.951606856455], "value": 20050.92870927699, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [373.5909179448503, 378.47203151603514, 390.5469655199969, 396.2510854485024, 415.0723133795967, 14229.715405691893, 15742.763858542117, 18559.536011599717, 18904.716429253538, 18912.05439728013, 17550.561235969075, 17673.293068277253, 17842.82157178428, 17868.195931183094, 17973.37093201738, 4166.437530933315, 5509.421510741375, 5745.310562732457, 5748.482636562709, 5755.0, 4261.893452663693, 6097.146399504073, 6351.0, 6415.101885736, 6524.15186025816, 6270.278917924452, 6363.172787537614, 6408.327125651809, 6494.447971922392, 6504.252011018722, 6339.746410143589, 6424.132742079806, 6426.228852537702, 6430.067640192169, 6432.356764323577, 5457.0, 5629.183768353607, 5683.488486036235, 5689.374168841424, 5692.48767610917, 21918.561628767497, 23089.0, 23202.3039308821, 23553.293401197992, 23658.171963981178, 2289.439087423575, 2305.216226482987, 2342.4963632819026, 2954.1285320830407, 3014.0, 13238.602841914759, 14077.436902523887, 14748.115113093141, 15046.473373431878, 15061.849381506154, 1811.420345489444, 1896.506908203863, 1906.1803424527448, 1928.0937959159173, 1932.1981377728225, 81518.0, 81703.0, 82254.9999999994, 84192.0, 85870.57064714699, 10017.198624110053, 10182.389056656624, 10279.537420816081, 10318.1745460363, 10556.366618002945, 14605.707885842223, 14608.561743147722, 14631.195284259467, 14632.48786292496, 14652.12087274767, 7589.924100759032, 7683.2316768323835, 7714.0, 7934.444588878839, 7956.641951112214, 7348.63256837156, 7422.0, 7493.250674932572, 7698.692052317957, 7764.767056988299, 6318.589291696117, 6348.841278968062, 6357.841053973688, 6396.744130234832, 6409.391107844747, 1852.2776117314258, 1858.9070546472622, 1869.9906500467412, 1894.9336773212872, 1909.5798924236647, 910.3763921713647, 924.5007695844304, 952.4428209497383, 983.7147227304145, 1094.6934858239706, 19449.611007780048, 19833.404997850088, 19909.0, 19942.60114797696, 19953.0, 965.4834663455158, 967.6951760195516, 974.8732664753678, 994.4431118573622, 1004.9648262310784, 10178.796424071477, 11033.944830275797, 11090.0, 11101.611443599435, 11333.0, 438302.0, 439386.0, 442099.0, 442505.0, 453220.0, 80094.59952700316, 80408.0, 81048.59475702702, 81430.77853832197, 83603.5819820897, 985.4678473624306, 985.8619793228954, 1022.3456987527989, 1034.7206254311293, 1038.89611038897, 16867.0, 17000.574985624964, 17491.0, 17930.193141308413, 18359.54101147482, 42184.890755462715, 42313.78843105765, 43126.568734312255, 43389.0, 43665.0, 52460.0, 56465.0, 56910.7154464225, 56927.715361422925, 57846.0, 7890.447668663368, 8116.553589552631, 8132.430729848854, 8271.090180080308, 8508.553545897335, 13225.867741322849, 13359.398827052612, 13565.0, 13595.45618175262, 13689.589312320646, 11434.371109589052, 11717.414129293671, 12221.205621634565, 12306.938465307974, 12314.076444266537, 11136.777264454828, 11320.37737924422, 11442.37066961325, 11539.0, 12333.321667308026, 11338.14963877729, 11636.476358563716, 11826.290422574673, 12078.456469458719, 12238.326892021025, 7314.926850731425, 7509.699612015458, 7533.660985255567, 8453.915460845314, 8552.118533922527, 8664.91335086641, 10086.0, 11647.184697071123, 11723.589674361356, 11996.940015299868], "value": 9259.409420470487, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1294.1458637299384, 1431.148466662336, 1501.834798172201, 1597.4648492754927, 1763.7883453985523, 7821.178776228499, 8735.344849136316, 9079.682211122612, 9082.137196966294, 9350.90649093509, 9044.095590440953, 9122.407043542165, 9124.178823905848, 9124.680636177734, 9125.087491250872, 2242.506648537323, 2248.449129963153, 2269.1830940861278, 2271.3980795089315, 2275.3174047785683, 2247.314569056437, 2287.142321629389, 2308.307507747669, 2341.6838726771925, 2348.753380895007, 2297.793198612125, 2301.3671240408853, 2307.0886999635136, 2307.826912981525, 2328.1851352026824, 2234.4637287051155, 2248.3592176229777, 2250.8424410291286, 2254.6392577187735, 2262.5814224368464, 2215.767344428844, 2261.0503588492707, 2262.1290803040783, 2266.410733209361, 2272.397814579138, 8926.419782714103, 9098.45409275439, 9138.954305228497, 9147.131022552847, 9149.771255718593, 5047.369078865142, 5244.842654720326, 5268.262443257947, 5272.815451459219, 5280.445553216895, 3412.2493051528622, 3611.1694310308776, 3653.314813611993, 3692.8153592320277, 3704.685101766353, 1048.491481631408, 1089.3681664634573, 1094.983575246364, 1110.9777804443947, 1111.7665290289049, 12505.74988500225, 12525.93737031318, 12653.051021173356, 12664.74670506594, 12683.873161268453, 4317.935230971538, 4377.759223242689, 4528.252838281713, 4544.545545445495, 4621.1219868224925, 9780.853287200556, 9794.167495762798, 9796.167325777245, 9797.16724078447, 9797.951010244904, 5161.948380516222, 5167.9224811627855, 5170.6122040847085, 5172.379314482287, 5177.094008548489, 4055.655269302142, 4254.127903779718, 4286.0, 4347.478302603708, 4846.466888642247, 3493.5807703075793, 3796.6962642988497, 3804.6956243500454, 3867.5165604299464, 3875.2755024014605, 1147.300146910384, 1177.8527684039495, 1186.9703257418462, 1190.6309044196153, 1201.8677945425995, 844.7888027993001, 883.1345281624044, 918.995405022984, 939.8214339275515, 963.1861077389594, 5631.408702086222, 5884.705764711833, 5910.822675319747, 5941.049432090845, 6161.075838624152, 420.81273833143956, 425.4575416344186, 429.60905575925756, 443.81138016342925, 447.05447977527945, 3851.422286656968, 4048.5344185418467, 4056.5943405659787, 4082.2243773682903, 4128.504579450485, 11068.612598559012, 11095.334279943228, 11385.462962499956, 11473.483693233824, 11475.827862582068, 11144.944275278573, 11275.154363422776, 11277.661670149908, 11288.774224515464, 11294.435278236055, 8278.420510564203, 8369.707060252862, 8393.916060839314, 8416.2004609562, 8475.957620211982, 5809.477147056785, 5815.069588865761, 5838.562107842014, 6039.396060394101, 6083.847903802441, 10326.328788628714, 10458.843117353093, 10469.31949423285, 10477.1094456972, 10598.735031624272, 9161.129692679186, 9912.256580756328, 10296.742581435525, 10318.17454603645, 10473.31923424975, 7286.672099755418, 8130.308923741548, 8270.0, 8361.289290410383, 8397.0, 8180.754577362689, 8410.663573457237, 8512.70205542803, 8513.063563008189, 8547.102554231964, 7330.96334518324, 7512.511686740344, 7741.380689544711, 7759.495632783851, 7845.097813751491, 7231.927680723125, 7278.67245973943, 7344.742933997284, 7405.518641288514, 7611.505252158592, 6315.810525684236, 6365.267994180728, 6366.936330636634, 6500.934990650033, 6792.694328755317, 4624.959384138542, 4718.457377401643, 4732.148213321635, 4873.975630121827, 4960.950390496193, 4905.705657660552, 4919.458859525378, 4976.253561965589, 5005.874853128701, 5039.21892106724], "value": 4482.671395607401, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [329.84497286275456, 332.38674645279457, 340.57938446019165, 341.92990436960423, 344.7087211306445, 5048.217526283423, 5161.483851614846, 5212.400573933999, 5213.165893457043, 5256.369235691717, 4976.975115124428, 5098.419489958106, 5151.793928242875, 5154.536091751742, 5160.974195129019, 4070.8982275443054, 4091.4067460218253, 4099.385092236159, 4103.076807718255, 4103.815328310233, 3771.7736935783805, 3864.4589757433982, 4101.384792281152, 4108.342665173573, 4113.136241389312, 4034.8184331705143, 4038.1923615276914, 4041.1109555897656, 4045.534763502191, 4048.838046478137, 3997.6208208168136, 4017.537983131948, 4026.295398305285, 4037.2934736421303, 4041.868276882463, 3583.6953858922025, 3586.4261718124976, 3586.4620306953907, 3587.4798154267746, 3588.4617307403837, 4986.4764199758865, 5043.5965122790085, 5077.187649976023, 5083.79664813407, 5088.6946783193125, 4649.023705021949, 4651.534846515356, 4664.626829853603, 4670.883227919295, 4673.205555055649, 5356.91964620531, 5423.105187644034, 5423.403425623178, 5438.7280635968045, 5441.394788537391, 3771.264603402338, 3899.278633452792, 3923.1761330120707, 3937.3897045957924, 3946.1515774108416, 5601.663900166003, 5614.838287259435, 5614.859628509279, 5633.887322253532, 5635.267415236034, 4109.321961876257, 4128.2156390285745, 4131.9173616527505, 4132.194222126716, 4133.132042271097, 4027.154297597537, 4157.376393540993, 4172.311568591209, 4175.770332631673, 4176.185643799491, 4644.094401591725, 4665.160271151158, 4689.976550117296, 4699.295105734167, 4706.176419126639, 5418.376886658085, 5441.238226648273, 5454.863628409322, 5462.781488740406, 5486.396496385394, 1417.597212322816, 1436.9425222990963, 1439.9208043557705, 1441.992790036043, 1454.338276084379, 910.2672348759312, 923.7782932096248, 936.3539157980971, 940.8823897012874, 946.6071580294101, 4630.166570017429, 4633.7683115844075, 4637.536246375335, 4685.477219903477, 4703.623710103184, 4943.629227807929, 4945.282933974553, 4946.629002824802, 4946.950530494649, 4961.479044700254, 4448.887778055486, 4598.21830288845, 4674.813007479731, 4678.368420263221, 4719.427911788083, 2529.4308780524602, 2580.767730904228, 2600.6359109724654, 2606.5829467285143, 2609.6085587161697, 5008.348914641147, 5012.598992080625, 5018.422881368616, 5024.949750502521, 5051.545360917535, 4687.960737079381, 4904.43598986114, 4966.602671786249, 4990.251462280615, 4997.425296090923, 5013.470891378165, 5027.787773379701, 5044.974775126101, 5060.3168572242275, 5082.822101226513, 4805.087033463631, 4826.455534229013, 4826.565609095198, 4865.70805751656, 4928.556429921181, 4815.7351345676325, 4843.951560484491, 4953.554180123806, 4958.7024778513405, 5227.555657769132, 5762.222100016612, 5773.884522309614, 5779.797707080232, 5784.0, 5807.767689292381, 3788.7726736395903, 3982.5021872265966, 3986.760794352348, 3992.700547458894, 3994.6404823566018, 5199.740012999259, 5452.110381497812, 5455.099908515051, 5457.345118585637, 5625.437456254342, 5438.293021907127, 5441.537469314994, 5443.891122177613, 5468.808591699271, 5496.5053145217125, 5287.735613219401, 5432.641839540115, 5439.401665816677, 5441.401445841034, 5463.890722185454, 5426.403095659553, 5438.347398312228, 5452.282531002721, 5455.699936503372, 5459.454054594509, 5479.780808767605, 5495.53287970527, 5497.862553436196, 5497.900419915953, 5505.339359276913, 5233.7383130842545, 5359.062164121186, 5374.167004114369, 5396.298481197419, 5426.565874730091], "value": 4040.3026800448406, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [643.6266965160207, 674.9021391898171, 698.6681326369975, 728.4281838756575, 730.6711979609178, 14008.299585020746, 14518.709625807478, 14650.487232946849, 15007.849921500781, 15157.317920693567, 13606.523771667993, 14024.527424620395, 14097.295135243248, 14131.152130872155, 14197.0, 670.9429698475635, 673.737242475435, 795.5862951265353, 807.1807115777491, 807.6850028488894, 778.7079845058104, 800.0519384529351, 805.5448671500612, 821.6590115102225, 822.1203312455675, 841.3941961787534, 842.5660784695887, 843.0599881132524, 843.2705709561216, 843.4180415513307, 700.9228984811666, 836.4061516323356, 838.4801423117646, 839.4249938791947, 839.5718183726314, 519.1460048220656, 599.7990673124508, 612.4212619074976, 616.017452163798, 621.8569728962319, 13670.726585468334, 13769.31153442334, 13791.655208619764, 14167.574972750834, 14223.85776142246, 13079.86920130796, 13682.52111176104, 13728.45086196561, 13806.240656763874, 14075.443417436922, 11991.340476273801, 12156.756864862742, 12284.754304913851, 12359.32023738694, 12559.434825432878, 4395.560443955611, 4401.867943961686, 4480.395146655193, 4503.166914120865, 4539.0694907543875, 79248.20751792466, 79923.6003819983, 81201.0, 81852.0, 81903.18096819015, 10173.643922462677, 10230.130438912627, 10313.432761198206, 10409.53157107932, 10546.894531054591, 19185.136668849937, 19231.903840480707, 19252.326168584314, 19337.709934350994, 19358.903205483883, 8099.230573095664, 8137.918620813716, 8310.584470776557, 8417.537035463109, 8434.24091831738, 4502.189605870974, 4529.456465224194, 4617.976910115428, 4754.833580824724, 4756.500567440438, 3257.820819854883, 3327.73378129749, 3329.0, 3351.2962277921424, 3362.69735723786, 598.9221401217814, 608.6895683201599, 622.5268795715289, 636.9713362898681, 655.2530115668142, 624.4036944717874, 628.3747671067317, 629.8362425769242, 650.3528988656317, 655.3773914780977, 8722.956385218033, 8822.823543529094, 8864.290856731446, 8983.146601072887, 9011.82846229999, 563.5801328010576, 605.8405415756849, 621.8538643418793, 636.207921138186, 637.1430426076919, 4116.91766164675, 4135.710500264952, 4458.643308535309, 4645.349651048856, 4795.736234507136, 68229.0, 68625.65687171533, 68821.65589172022, 68954.0, 109007.45496272467, 103026.48486757519, 103974.48012759887, 104449.0, 105211.0264744563, 107735.0, 88616.0, 91481.54259228661, 93271.0, 94353.5282323584, 94494.99999999863, 8917.955410222907, 9259.76850578741, 9352.298577606844, 9389.530523473935, 9406.717798466058, 52962.47037529575, 54161.187582185514, 54392.0, 54869.1769623448, 55898.44101559095, 79558.6022069886, 83080.0, 85787.57106214428, 85976.27130507631, 88743.0, 12122.575709850466, 12202.633920982385, 12472.376381181086, 12532.37338133108, 12587.24476531411, 13463.394147263592, 13514.797278041035, 13524.729505410034, 13620.0, 14381.712365752417, 11289.435528223721, 11393.316401015965, 11512.769744605228, 11729.597628501726, 11890.702732431759, 12456.252624842538, 12508.374581271082, 12742.299173545543, 12817.551385701456, 13788.241646709528, 12319.384030798245, 12416.689582760504, 12848.678783030498, 13209.537666181637, 13803.791393377012, 9706.75733106678, 9922.801543968935, 10217.744556385853, 10319.96282174906, 10640.201984851323, 10060.0, 10657.0, 10887.673369798918, 10890.346579205274, 10904.50929708181], "value": 7222.892920180819, "unit": "score"}], "name": "dromaeo_css", "value": 7088.410514412255, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 112.0, 114.0, 111.0, 112.0, 111.0, 114.0, 111.0, 111.0, 110.0], "value": 111.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 130.0, 127.0, 159.0, 125.0, 126.0, 124.0, 125.0, 158.0, 127.0], "value": 136.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 161.0, 161.0, 164.0, 161.0, 161.0, 161.0, 161.0, 161.0], "value": 161.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 119.0, 76.0, 76.0, 75.0, 76.0, 97.0, 75.0], "value": 81.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 106.0, 82.0, 82.0, 83.0, 103.0, 82.0, 83.0, 109.0], "value": 89.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 147.0, 146.0, 145.0, 146.0, 146.0, 146.0, 145.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 84.0, 84.0, 84.0, 84.0, 85.0, 85.0, 85.0, 85.0], "value": 84.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 60.0, 54.0, 53.0, 54.0, 54.0, 54.0, 55.0, 54.0, 55.0], "value": 54.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 60.0, 59.0, 60.0, 59.0, 59.0, 59.0, 59.0, 59.0], "value": 59.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 81.0, 85.0, 79.0, 81.0, 80.0, 79.0, 86.0, 82.0, 80.0], "value": 81.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 131.0, 132.0, 129.0, 128.0, 133.0, 129.0, 130.0, 186.0, 139.0], "value": 138.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 169.0, 166.0, 165.0, 166.0, 168.0, 166.0, 165.0, 163.0, 168.0], "value": 166.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 66.0, 66.0, 66.0, 65.0, 64.0, 65.0, 64.0, 64.0], "value": 65.0, "unit": "score"}], "name": "kraken", "value": 1491.5, "alertThreshold": 2.0}]} 17:05:54 INFO - Return code: 0 17:05:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:05:54 INFO - # TBPL SUCCESS # 17:05:54 INFO - Running post-action listener: _resource_record_post_action 17:05:54 INFO - [mozharness: 2016-10-25 00:05:54.451898Z] Finished run-tests step (success) 17:05:54 INFO - Running post-run listener: _resource_record_post_run 17:05:54 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 425984; Write bytes: 392650752; Read time: 184; Write time: 254048 17:05:54 INFO - TinderboxPrint: CPU usage
13.1% 17:05:54 INFO - TinderboxPrint: I/O read bytes / time
425,984 / 184 17:05:54 INFO - TinderboxPrint: I/O write bytes / time
392,650,752 / 254,048 17:05:54 INFO - TinderboxPrint: CPU idle
8,296.8 (86.9%) 17:05:54 INFO - TinderboxPrint: CPU user
1,200.8 (12.6%) 17:05:54 INFO - TinderboxPrint: Swap in / out
0 / 0 17:05:54 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 105193472; Read time: 0; Write time: 70160 17:05:54 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 421888; Write bytes: 286990336; Read time: 168; Write time: 183884 17:05:55 INFO - Running post-run listener: _upload_blobber_files 17:05:55 INFO - Blob upload gear active. 17:05:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:05:55 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 17:05:55 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'] 17:05:55 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 17:05:55 INFO - (blobuploader) - INFO - Open directory for files ... 17:05:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:05:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:05:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:06:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:06:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:06:00 INFO - (blobuploader) - INFO - Done attempting. 17:06:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:06:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:06:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:06:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:06:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:06:01 INFO - (blobuploader) - INFO - Done attempting. 17:06:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:06:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:06:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:06:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:06:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:06:01 INFO - (blobuploader) - INFO - Done attempting. 17:06:01 INFO - (blobuploader) - INFO - Iteration through files over. 17:06:01 INFO - Return code: 0 17:06:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:06:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:06:01 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/eea7290e03ad09ad43bf1fa73671ed51abc5c42006e45d21a3b4933db4383788b29c97e7c394cc20d47491e550a7c5b8f4d67015cc109bd2a536246e008b7499", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9fd1eda0c80cc2c3056458e42d5576e5793b29d3e63140c2a11ef756114dca107de96f88abb32455909df9063445ac8d546398a1771b6f616a20d36edd846978", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ae4d26f94cd2e18d0b05362b75a7d0d56feccb00ad5a7af53ea3cf73a25d55dbe348256e5011a7f0236426b09eed490746268e8de0dc981b941523b5a0fc8582"} 17:06:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:06:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:06:01 INFO - Contents: 17:06:01 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/eea7290e03ad09ad43bf1fa73671ed51abc5c42006e45d21a3b4933db4383788b29c97e7c394cc20d47491e550a7c5b8f4d67015cc109bd2a536246e008b7499", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9fd1eda0c80cc2c3056458e42d5576e5793b29d3e63140c2a11ef756114dca107de96f88abb32455909df9063445ac8d546398a1771b6f616a20d36edd846978", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ae4d26f94cd2e18d0b05362b75a7d0d56feccb00ad5a7af53ea3cf73a25d55dbe348256e5011a7f0236426b09eed490746268e8de0dc981b941523b5a0fc8582"} 17:06:01 INFO - Running post-run listener: copy_logs_to_upload_dir 17:06:01 INFO - Copying logs to upload dir... 17:06:01 INFO - mkdir: /builds/slave/test/build/upload/logs 17:06:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.582797 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-10-24 17:06:01.889573) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-24 17:06:01.892870) ========= 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-1477352721.516814-2028116745 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/eea7290e03ad09ad43bf1fa73671ed51abc5c42006e45d21a3b4933db4383788b29c97e7c394cc20d47491e550a7c5b8f4d67015cc109bd2a536246e008b7499", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9fd1eda0c80cc2c3056458e42d5576e5793b29d3e63140c2a11ef756114dca107de96f88abb32455909df9063445ac8d546398a1771b6f616a20d36edd846978", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ae4d26f94cd2e18d0b05362b75a7d0d56feccb00ad5a7af53ea3cf73a25d55dbe348256e5011a7f0236426b09eed490746268e8de0dc981b941523b5a0fc8582"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477337493/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011315 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477337493/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/eea7290e03ad09ad43bf1fa73671ed51abc5c42006e45d21a3b4933db4383788b29c97e7c394cc20d47491e550a7c5b8f4d67015cc109bd2a536246e008b7499", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9fd1eda0c80cc2c3056458e42d5576e5793b29d3e63140c2a11ef756114dca107de96f88abb32455909df9063445ac8d546398a1771b6f616a20d36edd846978", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ae4d26f94cd2e18d0b05362b75a7d0d56feccb00ad5a7af53ea3cf73a25d55dbe348256e5011a7f0236426b09eed490746268e8de0dc981b941523b5a0fc8582"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-24 17:06:01.918303) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 17:06:01.918632) ========= 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-1477352721.516814-2028116745 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004481 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 17:06:02.002359) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-24 17:06:02.002673) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-24 17:06:02.002957) ========= ========= Total master_lag: 0.16 =========