builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-059 starttime: 1469131657.23 results: success (0) buildid: 20160721113038 builduid: 621362698dd246b1be077853bb6c678e revision: bd6655e7b879214b7d983ca85c8160a77a653178 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-21 13:07:37.228459) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-21 13:07:37.228875) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-21 13:07:37.229148) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-21 13:07:37.243383) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 13:07:37.243644) ========= 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=3a3620fb28aea1604ab609ef000001d2-1469131657.602276-1239246029 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-21 13:07:38-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.2M=0s 2016-07-21 13:07:38 (46.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.115258 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 13:07:37.372638) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 13:07:37.372953) ========= 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=3a3620fb28aea1604ab609ef000001d2-1469131657.602276-1239246029 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018188 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 13:07:37.422246) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-21 13:07:37.422586) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev bd6655e7b879214b7d983ca85c8160a77a653178 --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 bd6655e7b879214b7d983ca85c8160a77a653178 --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=3a3620fb28aea1604ab609ef000001d2-1469131657.602276-1239246029 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-21 13:07:38,541 truncating revision to first 12 chars 2016-07-21 13:07:38,541 Setting DEBUG logging. 2016-07-21 13:07:38,541 attempt 1/10 2016-07-21 13:07:38,541 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/bd6655e7b879?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-21 13:07:39,779 unpacking tar archive at: fx-team-bd6655e7b879/testing/mozharness/ program finished with exit code 0 elapsedTime=1.587832 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-21 13:07:39.023475) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-21 13:07:39.023773) ========= script_repo_revision: bd6655e7b879214b7d983ca85c8160a77a653178 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-21 13:07:39.024142) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-21 13:07:39.024417) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-21 13:07:39.031902) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-07-21 13:07:39.032165) ========= /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=3a3620fb28aea1604ab609ef000001d2-1469131657.602276-1239246029 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:07:40 INFO - MultiFileLogger online at 20160721 13:07:40 in /builds/slave/test 13:07:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 13:07:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:07:40 INFO - {'append_to_log': False, 13:07:40 INFO - 'base_work_dir': '/builds/slave/test', 13:07:40 INFO - 'blob_upload_branch': 'Fx-Team', 13:07:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:07:40 INFO - 'branch': 'Fx-Team', 13:07:40 INFO - 'buildbot_json_path': 'buildprops.json', 13:07:40 INFO - 'config_files': ('talos/linux_config.py',), 13:07:40 INFO - 'default_actions': ('clobber', 13:07:40 INFO - 'read-buildbot-config', 13:07:40 INFO - 'download-and-extract', 13:07:40 INFO - 'populate-webroot', 13:07:40 INFO - 'create-virtualenv', 13:07:40 INFO - 'install', 13:07:40 INFO - 'run-tests'), 13:07:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:07:40 INFO - 'download_minidump_stackwalk': True, 13:07:40 INFO - 'download_symbols': 'ondemand', 13:07:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:07:40 INFO - 'tooltool.py': '/tools/tooltool.py', 13:07:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:07:40 INFO - '/tools/misc-python/virtualenv.py')}, 13:07:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:07:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:07:40 INFO - 'installer_path': 'installer.exe', 13:07:40 INFO - 'log_level': 'info', 13:07:40 INFO - 'log_name': 'talos', 13:07:40 INFO - 'log_to_console': True, 13:07:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:07:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:07:40 INFO - 'opt_config_files': (), 13:07:40 INFO - 'pip_index': False, 13:07:40 INFO - 'sps_profile': False, 13:07:40 INFO - 'sps_profile_interval': 0, 13:07:40 INFO - 'suite': 'dromaeojs', 13:07:40 INFO - 'system_bits': '32', 13:07:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:07:40 INFO - 'title': 'talos-linux64-ix-059', 13:07:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:07:40 INFO - 'use_talos_json': True, 13:07:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:07:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:07:40 INFO - 'work_dir': 'build'} 13:07:40 INFO - [mozharness: 2016-07-21 20:07:40.238280Z] Running clobber step. 13:07:40 INFO - Running pre-action listener: _resource_record_pre_action 13:07:40 INFO - Running main action method: clobber 13:07:40 INFO - rmtree: /builds/slave/test/build 13:07:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:07:41 INFO - Running post-action listener: _resource_record_post_action 13:07:41 INFO - [mozharness: 2016-07-21 20:07:41.210514Z] Finished clobber step (success) 13:07:41 INFO - [mozharness: 2016-07-21 20:07:41.210613Z] Running read-buildbot-config step. 13:07:41 INFO - Running pre-action listener: _resource_record_pre_action 13:07:41 INFO - Running main action method: read_buildbot_config 13:07:41 INFO - Using buildbot properties: 13:07:41 INFO - { 13:07:41 INFO - "project": "", 13:07:41 INFO - "product": "firefox", 13:07:41 INFO - "script_repo_revision": "production", 13:07:41 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 13:07:41 INFO - "repository": "", 13:07:41 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 13:07:41 INFO - "buildid": "20160721113038", 13:07:41 INFO - "pgo_build": "True", 13:07:41 INFO - "basedir": "/builds/slave/test", 13:07:41 INFO - "buildnumber": 1346, 13:07:41 INFO - "slavename": "talos-linux64-ix-059", 13:07:41 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 13:07:41 INFO - "platform": "ubuntu64_hw", 13:07:41 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 13:07:41 INFO - "branch": "fx-team", 13:07:41 INFO - "repo_path": "integration/fx-team", 13:07:41 INFO - "revision": "bd6655e7b879214b7d983ca85c8160a77a653178", 13:07:41 INFO - "stage_platform": "linux64-pgo", 13:07:41 INFO - "builduid": "621362698dd246b1be077853bb6c678e", 13:07:41 INFO - "slavebuilddir": "test" 13:07:41 INFO - } 13:07:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/aCafWlUuSdixsZLCLGTS9Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 13:07:41 INFO - Running post-action listener: _resource_record_post_action 13:07:41 INFO - [mozharness: 2016-07-21 20:07:41.213052Z] Finished read-buildbot-config step (success) 13:07:41 INFO - [mozharness: 2016-07-21 20:07:41.213140Z] Running download-and-extract step. 13:07:41 INFO - Running pre-action listener: _resource_record_pre_action 13:07:41 INFO - Running main action method: download_and_extract 13:07:41 INFO - mkdir: /builds/slave/test/build/tests 13:07:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:07:41 INFO - https://queue.taskcluster.net/v1/task/aCafWlUuSdixsZLCLGTS9Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 13:07:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aCafWlUuSdixsZLCLGTS9Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:07:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aCafWlUuSdixsZLCLGTS9Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:07:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aCafWlUuSdixsZLCLGTS9Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:07:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aCafWlUuSdixsZLCLGTS9Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 13:07:41 INFO - Downloaded 1361 bytes. 13:07:41 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:07:41 INFO - Using the following test package requirements: 13:07:41 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 13:07:41 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:07:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:07:41 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:07:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:07:41 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:07:41 INFO - u'jsshell-linux-x86_64.zip'], 13:07:41 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:07:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:07:41 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 13:07:41 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:07:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:07:41 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:07:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:07:41 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:07:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:07:41 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:07:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:07:41 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:07:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:07:41 INFO - https://queue.taskcluster.net/v1/task/aCafWlUuSdixsZLCLGTS9Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:07:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aCafWlUuSdixsZLCLGTS9Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:07:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aCafWlUuSdixsZLCLGTS9Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:07:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aCafWlUuSdixsZLCLGTS9Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:07:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aCafWlUuSdixsZLCLGTS9Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:07:43 INFO - Downloaded 24306908 bytes. 13:07:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:07:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 13:07:44 INFO - Return code: 0 13:07:44 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 13:07:44 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:07:44 INFO - https://queue.taskcluster.net/v1/task/aCafWlUuSdixsZLCLGTS9Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:07:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aCafWlUuSdixsZLCLGTS9Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:07:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aCafWlUuSdixsZLCLGTS9Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:07:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aCafWlUuSdixsZLCLGTS9Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:07:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aCafWlUuSdixsZLCLGTS9Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:07:45 INFO - Downloaded 24306908 bytes. 13:07:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:07:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 13:07:46 INFO - Return code: 0 13:07:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:07:46 INFO - https://queue.taskcluster.net/v1/task/aCafWlUuSdixsZLCLGTS9Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:07:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aCafWlUuSdixsZLCLGTS9Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 13:07:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aCafWlUuSdixsZLCLGTS9Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 13:07:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aCafWlUuSdixsZLCLGTS9Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 13:07:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aCafWlUuSdixsZLCLGTS9Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 13:07:47 INFO - Downloaded 14403317 bytes. 13:07:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:07:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 13:07:48 INFO - Return code: 0 13:07:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:07:48 INFO - https://queue.taskcluster.net/v1/task/aCafWlUuSdixsZLCLGTS9Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:07:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aCafWlUuSdixsZLCLGTS9Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:07:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aCafWlUuSdixsZLCLGTS9Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:07:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aCafWlUuSdixsZLCLGTS9Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:07:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aCafWlUuSdixsZLCLGTS9Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 13:07:49 INFO - Downloaded 60875246 bytes. 13:07:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aCafWlUuSdixsZLCLGTS9Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:07:49 INFO - mkdir: /builds/slave/test/properties 13:07:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:07:49 INFO - Writing to file /builds/slave/test/properties/build_url 13:07:49 INFO - Contents: 13:07:49 INFO - build_url:https://queue.taskcluster.net/v1/task/aCafWlUuSdixsZLCLGTS9Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:07:50 INFO - Running post-action listener: _resource_record_post_action 13:07:50 INFO - Running post-action listener: set_extra_try_arguments 13:07:50 INFO - [mozharness: 2016-07-21 20:07:50.354674Z] Finished download-and-extract step (success) 13:07:50 INFO - [mozharness: 2016-07-21 20:07:50.354906Z] Running populate-webroot step. 13:07:50 INFO - Running pre-action listener: _resource_record_pre_action 13:07:50 INFO - Running main action method: populate_webroot 13:07:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:07:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:07:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:07:50 INFO - '--tppagecycles', 13:07:50 INFO - '7'], 13:07:50 INFO - 'tests': ['tsvgm']}}, 13:07:50 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:07:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:07:50 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:07:50 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:07:50 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:07:50 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:07:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:07:50 INFO - 'talos_options': ['--disable-e10s'], 13:07:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:07:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:07:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:07:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:07:50 INFO - 'talos_options': ['--disable-e10s'], 13:07:50 INFO - 'tests': ['damp', 'tps']}, 13:07:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:07:50 INFO - 'tests': ['damp', 'tps']}, 13:07:50 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:07:50 INFO - 'tests': ['dromaeo_dom']}, 13:07:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:07:50 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:07:50 INFO - 'tests': ['basic_compositor_video']}, 13:07:50 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:07:50 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:07:50 INFO - 'tests': ['a11yr', 13:07:50 INFO - 'ts_paint', 13:07:50 INFO - 'tpaint', 13:07:50 INFO - 'sessionrestore', 13:07:50 INFO - 'sessionrestore_no_auto_restore', 13:07:50 INFO - 'tabpaint']}, 13:07:50 INFO - 'other-e10s': {'tests': ['a11yr', 13:07:50 INFO - 'ts_paint', 13:07:50 INFO - 'tpaint', 13:07:50 INFO - 'sessionrestore', 13:07:50 INFO - 'sessionrestore_no_auto_restore', 13:07:50 INFO - 'tabpaint']}, 13:07:50 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:07:50 INFO - 'ts_paint', 13:07:50 INFO - 'tpaint', 13:07:50 INFO - 'sessionrestore', 13:07:50 INFO - 'sessionrestore_no_auto_restore', 13:07:50 INFO - 'tabpaint']}, 13:07:50 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:07:50 INFO - 'ts_paint', 13:07:50 INFO - 'tpaint', 13:07:50 INFO - 'sessionrestore', 13:07:50 INFO - 'sessionrestore_no_auto_restore', 13:07:50 INFO - 'tabpaint']}, 13:07:50 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:07:50 INFO - 'tests': ['a11yr', 13:07:50 INFO - 'ts_paint', 13:07:50 INFO - 'tpaint', 13:07:50 INFO - 'sessionrestore', 13:07:50 INFO - 'sessionrestore_no_auto_restore', 13:07:50 INFO - 'tabpaint']}, 13:07:50 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:07:50 INFO - 'tests': ['a11yr', 13:07:50 INFO - 'ts_paint', 13:07:50 INFO - 'tpaint', 13:07:50 INFO - 'sessionrestore', 13:07:50 INFO - 'sessionrestore_no_auto_restore', 13:07:50 INFO - 'tabpaint']}, 13:07:50 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:07:50 INFO - 'tests': ['tsvgx', 13:07:50 INFO - 'tsvgr_opacity', 13:07:50 INFO - 'tart', 13:07:50 INFO - 'tscrollx', 13:07:50 INFO - 'cart']}, 13:07:50 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:07:50 INFO - 'tsvgr_opacity', 13:07:50 INFO - 'tart', 13:07:50 INFO - 'tscrollx', 13:07:50 INFO - 'cart']}, 13:07:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:07:50 INFO - 'talos_options': ['--disable-e10s'], 13:07:50 INFO - 'tests': ['tp5o']}, 13:07:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:07:50 INFO - 'tests': ['tp5o']}, 13:07:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:07:50 INFO - 'talos_options': ['--disable-e10s', 13:07:50 INFO - '--xperf_path', 13:07:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:07:50 INFO - 'tests': ['tp5n']}, 13:07:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:07:50 INFO - 'talos_options': ['--xperf_path', 13:07:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:07:50 INFO - 'tests': ['tp5n']}}, 13:07:50 INFO - 'talos.zip': {'path': '', 13:07:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:07:50 INFO - Running post-action listener: _resource_record_post_action 13:07:50 INFO - [mozharness: 2016-07-21 20:07:50.372206Z] Finished populate-webroot step (success) 13:07:50 INFO - [mozharness: 2016-07-21 20:07:50.372294Z] Running create-virtualenv step. 13:07:50 INFO - Running pre-action listener: _resource_record_pre_action 13:07:50 INFO - Running main action method: create_virtualenv 13:07:50 INFO - Creating virtualenv /builds/slave/test/build/venv 13:07:50 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 13:07:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:07:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:07:50 INFO - Using real prefix '/usr' 13:07:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:07:50 INFO - Installing distribute.............................................................................................................................................................................................done. 13:07:52 INFO - Installing pip.................done. 13:07:52 INFO - Return code: 0 13:07:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:07: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:07:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:07:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:07:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:07:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:52 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 0x1589030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x184a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18483b0>, '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 0x18492b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1849740>, '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': '3a3620fb28aea1604ab609ef000001d2-1469131657.602276-1239246029', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:07:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 13:07:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 13:07:52 INFO - Using env: {'DISPLAY': ':0', 13:07:52 INFO - 'HOME': '/home/cltbld', 13:07:52 INFO - 'LANG': 'en_US.UTF-8', 13:07:52 INFO - 'LANGUAGE': 'en_US:en', 13:07:52 INFO - 'LOGNAME': 'cltbld', 13:07:52 INFO - 'MAIL': '/var/mail/cltbld', 13:07:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:07:52 INFO - 'MOZ_NO_REMOTE': '1', 13:07:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:07:52 INFO - 'NO_EM_RESTART': '1', 13:07:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:07:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:07:52 INFO - 'PWD': '/builds/slave/test', 13:07:52 INFO - 'SHELL': '/bin/bash', 13:07:52 INFO - 'SHLVL': '1', 13:07:52 INFO - 'TERM': 'linux', 13:07:52 INFO - 'TMOUT': '86400', 13:07:52 INFO - 'USER': 'cltbld', 13:07:52 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1469131657.602276-1239246029', 13:07:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:07:52 INFO - '_': '/tools/buildbot/bin/python'} 13:07:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:07:53 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 13:07:53 INFO - Cleaning up... 13:07:53 INFO - Return code: 0 13:07:53 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:07:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:07:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:07:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:07:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:07:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1589030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x184a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18483b0>, '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 0x18492b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1849740>, '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': '3a3620fb28aea1604ab609ef000001d2-1469131657.602276-1239246029', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:07:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 13:07:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 13:07:53 INFO - Using env: {'DISPLAY': ':0', 13:07:53 INFO - 'HOME': '/home/cltbld', 13:07:53 INFO - 'LANG': 'en_US.UTF-8', 13:07:53 INFO - 'LANGUAGE': 'en_US:en', 13:07:53 INFO - 'LOGNAME': 'cltbld', 13:07:53 INFO - 'MAIL': '/var/mail/cltbld', 13:07:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:07:53 INFO - 'MOZ_NO_REMOTE': '1', 13:07:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:07:53 INFO - 'NO_EM_RESTART': '1', 13:07:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:07:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:07:53 INFO - 'PWD': '/builds/slave/test', 13:07:53 INFO - 'SHELL': '/bin/bash', 13:07:53 INFO - 'SHLVL': '1', 13:07:53 INFO - 'TERM': 'linux', 13:07:53 INFO - 'TMOUT': '86400', 13:07:53 INFO - 'USER': 'cltbld', 13:07:53 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1469131657.602276-1239246029', 13:07:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:07:53 INFO - '_': '/tools/buildbot/bin/python'} 13:07:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:07:53 INFO - Downloading/unpacking psutil>=3.1.1 13:07: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 13:07: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 13:07: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 13:07: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 13:07: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 13:07: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 13:07:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:07:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:07:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:07:55 INFO - Installing collected packages: psutil 13:07:55 INFO - Running setup.py install for psutil 13:07:55 INFO - building 'psutil._psutil_linux' extension 13:07:55 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 13:07:55 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 13:07:55 INFO - building 'psutil._psutil_posix' extension 13:07:55 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 13:07:55 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 13:07:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:07:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:07:55 INFO - Successfully installed psutil 13:07:55 INFO - Cleaning up... 13:07:55 INFO - Return code: 0 13:07:55 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:07:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:07:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:07:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:07:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:07:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1589030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x184a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18483b0>, '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 0x18492b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1849740>, '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': '3a3620fb28aea1604ab609ef000001d2-1469131657.602276-1239246029', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:07:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 13:07:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 13:07:55 INFO - Using env: {'DISPLAY': ':0', 13:07:55 INFO - 'HOME': '/home/cltbld', 13:07:55 INFO - 'LANG': 'en_US.UTF-8', 13:07:55 INFO - 'LANGUAGE': 'en_US:en', 13:07:55 INFO - 'LOGNAME': 'cltbld', 13:07:55 INFO - 'MAIL': '/var/mail/cltbld', 13:07:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:07:55 INFO - 'MOZ_NO_REMOTE': '1', 13:07:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:07:55 INFO - 'NO_EM_RESTART': '1', 13:07:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:07:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:07:55 INFO - 'PWD': '/builds/slave/test', 13:07:55 INFO - 'SHELL': '/bin/bash', 13:07:55 INFO - 'SHLVL': '1', 13:07:55 INFO - 'TERM': 'linux', 13:07:55 INFO - 'TMOUT': '86400', 13:07:55 INFO - 'USER': 'cltbld', 13:07:55 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1469131657.602276-1239246029', 13:07:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:07:55 INFO - '_': '/tools/buildbot/bin/python'} 13:07:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:07:56 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:07:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:07:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:07:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:07:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:07:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:07:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:07:58 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:07:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:07:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:07:58 INFO - Installing collected packages: mozsystemmonitor 13:07:58 INFO - Running setup.py install for mozsystemmonitor 13:07:58 INFO - Successfully installed mozsystemmonitor 13:07:58 INFO - Cleaning up... 13:07:58 INFO - Return code: 0 13:07:58 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:07:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:07:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:07:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:07:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:07:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1589030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x184a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18483b0>, '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 0x18492b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1849740>, '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': '3a3620fb28aea1604ab609ef000001d2-1469131657.602276-1239246029', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:07:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 13:07:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 13:07:58 INFO - Using env: {'DISPLAY': ':0', 13:07:58 INFO - 'HOME': '/home/cltbld', 13:07:58 INFO - 'LANG': 'en_US.UTF-8', 13:07:58 INFO - 'LANGUAGE': 'en_US:en', 13:07:58 INFO - 'LOGNAME': 'cltbld', 13:07:58 INFO - 'MAIL': '/var/mail/cltbld', 13:07:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:07:58 INFO - 'MOZ_NO_REMOTE': '1', 13:07:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:07:58 INFO - 'NO_EM_RESTART': '1', 13:07:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:07:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:07:58 INFO - 'PWD': '/builds/slave/test', 13:07:58 INFO - 'SHELL': '/bin/bash', 13:07:58 INFO - 'SHLVL': '1', 13:07:58 INFO - 'TERM': 'linux', 13:07:58 INFO - 'TMOUT': '86400', 13:07:58 INFO - 'USER': 'cltbld', 13:07:58 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1469131657.602276-1239246029', 13:07:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:07:58 INFO - '_': '/tools/buildbot/bin/python'} 13:07:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:07:58 INFO - Downloading/unpacking jsonschema==2.5.1 13:07:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:07:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:07:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:07:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:07:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:07:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:08:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:08:00 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:08:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:08:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:08:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:08:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:08:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:08:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:08:00 INFO - Downloading functools32-3.2.3-2.tar.gz 13:08:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:08:00 INFO - warning: no files found matching '*.txt' 13:08:00 INFO - no previously-included directories found matching 'build' 13:08:00 INFO - no previously-included directories found matching 'dist' 13:08:00 INFO - no previously-included directories found matching '.git*' 13:08:00 INFO - Installing collected packages: jsonschema, functools32 13:08:00 INFO - Running setup.py install for functools32 13:08:00 INFO - warning: no files found matching '*.txt' 13:08:00 INFO - no previously-included directories found matching 'build' 13:08:00 INFO - no previously-included directories found matching 'dist' 13:08:00 INFO - no previously-included directories found matching '.git*' 13:08:00 INFO - Successfully installed jsonschema functools32 13:08:00 INFO - Cleaning up... 13:08:00 INFO - Return code: 0 13:08:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:08:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:08:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:08:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:08:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:08:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1589030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x184a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18483b0>, '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 0x18492b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1849740>, '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': '3a3620fb28aea1604ab609ef000001d2-1469131657.602276-1239246029', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:08:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:08:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:08:00 INFO - Using env: {'DISPLAY': ':0', 13:08:00 INFO - 'HOME': '/home/cltbld', 13:08:00 INFO - 'LANG': 'en_US.UTF-8', 13:08:00 INFO - 'LANGUAGE': 'en_US:en', 13:08:00 INFO - 'LOGNAME': 'cltbld', 13:08:00 INFO - 'MAIL': '/var/mail/cltbld', 13:08:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:08:00 INFO - 'MOZ_NO_REMOTE': '1', 13:08:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:08:00 INFO - 'NO_EM_RESTART': '1', 13:08:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:08:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:08:00 INFO - 'PWD': '/builds/slave/test', 13:08:00 INFO - 'SHELL': '/bin/bash', 13:08:00 INFO - 'SHLVL': '1', 13:08:00 INFO - 'TERM': 'linux', 13:08:00 INFO - 'TMOUT': '86400', 13:08:00 INFO - 'USER': 'cltbld', 13:08:00 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1469131657.602276-1239246029', 13:08:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:08:00 INFO - '_': '/tools/buildbot/bin/python'} 13:08:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:08:01 INFO - Downloading/unpacking blobuploader==1.2.4 13:08:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:08:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:08:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:08:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:08:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:08:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:08:02 INFO - Downloading blobuploader-1.2.4.tar.gz 13:08:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:08:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:08:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:08:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:08:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:08:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:08:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:08:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:08:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:08:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:08:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:08:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:08:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:08:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:08:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:08:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:08:03 INFO - Downloading docopt-0.6.1.tar.gz 13:08:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:08:03 INFO - Installing collected packages: blobuploader, requests, docopt 13:08:03 INFO - Running setup.py install for blobuploader 13:08:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:08:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:08:03 INFO - Running setup.py install for requests 13:08:04 INFO - Running setup.py install for docopt 13:08:04 INFO - Successfully installed blobuploader requests docopt 13:08:04 INFO - Cleaning up... 13:08:04 INFO - Return code: 0 13:08:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:08:04 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:08:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:08:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:04 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:08:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:08:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:04 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 0x1589030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x184a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18483b0>, '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 0x18492b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1849740>, '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': '3a3620fb28aea1604ab609ef000001d2-1469131657.602276-1239246029', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:08:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 13:08:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:08:04 INFO - Using env: {'DISPLAY': ':0', 13:08:04 INFO - 'HOME': '/home/cltbld', 13:08:04 INFO - 'LANG': 'en_US.UTF-8', 13:08:04 INFO - 'LANGUAGE': 'en_US:en', 13:08:04 INFO - 'LOGNAME': 'cltbld', 13:08:04 INFO - 'MAIL': '/var/mail/cltbld', 13:08:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:08:04 INFO - 'MOZ_NO_REMOTE': '1', 13:08:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:08:04 INFO - 'NO_EM_RESTART': '1', 13:08:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:08:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:08:04 INFO - 'PWD': '/builds/slave/test', 13:08:04 INFO - 'SHELL': '/bin/bash', 13:08:04 INFO - 'SHLVL': '1', 13:08:04 INFO - 'TERM': 'linux', 13:08:04 INFO - 'TMOUT': '86400', 13:08:04 INFO - 'USER': 'cltbld', 13:08:04 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1469131657.602276-1239246029', 13:08:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:08:04 INFO - '_': '/tools/buildbot/bin/python'} 13:08:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:08:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:08:04 INFO - Running setup.py (path:/tmp/pip-izRwwS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:08:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:08:04 INFO - Running setup.py (path:/tmp/pip-S2VlE_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:08:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:08:04 INFO - Running setup.py (path:/tmp/pip-IcxqJk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:08:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:08:04 INFO - Running setup.py (path:/tmp/pip-qKD_Jr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:08:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:08:04 INFO - Running setup.py (path:/tmp/pip-Gp58rQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:08:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:08:05 INFO - Running setup.py (path:/tmp/pip-nxV_4T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:08:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:08:05 INFO - Running setup.py (path:/tmp/pip-8xlenK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:08:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:08:05 INFO - Running setup.py (path:/tmp/pip-1GlLsX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:08:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:08:05 INFO - Running setup.py (path:/tmp/pip-O9gNEi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:08:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:08:05 INFO - Running setup.py (path:/tmp/pip-dySy3K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:08:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:08:05 INFO - Running setup.py (path:/tmp/pip-7MVaKl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:08:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:08:05 INFO - Running setup.py (path:/tmp/pip-W8vq77-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:08:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:08:05 INFO - Running setup.py (path:/tmp/pip-FGmhIP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:08:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:08:05 INFO - Running setup.py (path:/tmp/pip-bqthJB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:08:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:08:05 INFO - Running setup.py (path:/tmp/pip-ETHcYy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:08:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:08:05 INFO - Running setup.py (path:/tmp/pip-fF35_9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:08:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:08:05 INFO - Running setup.py (path:/tmp/pip-z3uPqL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:08:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:08:05 INFO - Running setup.py install for manifestparser 13:08:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:08:05 INFO - Running setup.py install for mozcrash 13:08:06 INFO - Running setup.py install for mozdebug 13:08:06 INFO - Running setup.py install for mozdevice 13:08:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:08:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:08:06 INFO - Running setup.py install for mozfile 13:08:06 INFO - Running setup.py install for mozhttpd 13:08:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:08:06 INFO - Running setup.py install for mozinfo 13:08:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:08:06 INFO - Running setup.py install for mozInstall 13:08:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:08:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:08:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:08:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:08:06 INFO - Running setup.py install for mozleak 13:08:06 INFO - Running setup.py install for mozlog 13:08:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:08:06 INFO - Running setup.py install for moznetwork 13:08:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:08:07 INFO - Running setup.py install for mozprocess 13:08:07 INFO - Running setup.py install for mozprofile 13:08:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:08:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:08:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:08:07 INFO - Running setup.py install for mozrunner 13:08:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:08:07 INFO - Running setup.py install for mozscreenshot 13:08:07 INFO - Running setup.py install for moztest 13:08:07 INFO - Running setup.py install for mozversion 13:08:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:08:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:08:07 INFO - Cleaning up... 13:08:07 INFO - Return code: 0 13:08:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:08:07 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:08:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:08:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:07 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:08:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:08:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:07 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 0x1589030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x184a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18483b0>, '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 0x18492b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1849740>, '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': '3a3620fb28aea1604ab609ef000001d2-1469131657.602276-1239246029', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:08:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 13:08:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:08:07 INFO - Using env: {'DISPLAY': ':0', 13:08:07 INFO - 'HOME': '/home/cltbld', 13:08:07 INFO - 'LANG': 'en_US.UTF-8', 13:08:07 INFO - 'LANGUAGE': 'en_US:en', 13:08:07 INFO - 'LOGNAME': 'cltbld', 13:08:07 INFO - 'MAIL': '/var/mail/cltbld', 13:08:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:08:07 INFO - 'MOZ_NO_REMOTE': '1', 13:08:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:08:07 INFO - 'NO_EM_RESTART': '1', 13:08:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:08:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:08:07 INFO - 'PWD': '/builds/slave/test', 13:08:07 INFO - 'SHELL': '/bin/bash', 13:08:07 INFO - 'SHLVL': '1', 13:08:07 INFO - 'TERM': 'linux', 13:08:07 INFO - 'TMOUT': '86400', 13:08:07 INFO - 'USER': 'cltbld', 13:08:07 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1469131657.602276-1239246029', 13:08:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:08:07 INFO - '_': '/tools/buildbot/bin/python'} 13:08:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:08:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:08:07 INFO - Running setup.py (path:/tmp/pip-WzdjhM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:08:07 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 13:08:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:08:07 INFO - Running setup.py (path:/tmp/pip-c6y6X6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:08:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:08:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:08:08 INFO - Running setup.py (path:/tmp/pip-eTaxeb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:08:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 13:08:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:08:08 INFO - Running setup.py (path:/tmp/pip-Qby2Yy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:08:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:08:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:08:08 INFO - Running setup.py (path:/tmp/pip-kbJDrj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:08:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 13:08:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:08:08 INFO - Running setup.py (path:/tmp/pip-iORdWs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:08:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 13:08:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:08:08 INFO - Running setup.py (path:/tmp/pip-50Sr3U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:08:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 13:08:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:08:08 INFO - Running setup.py (path:/tmp/pip-bLZxZf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:08:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 13:08:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:08:08 INFO - Running setup.py (path:/tmp/pip-XffWet-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:08:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 13:08:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:08:08 INFO - Running setup.py (path:/tmp/pip-Lm8UkP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:08:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:08:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:08:08 INFO - Running setup.py (path:/tmp/pip-JS9n2n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:08:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 13:08:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:08:08 INFO - Running setup.py (path:/tmp/pip-dB8VTL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:08:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 13:08:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:08:08 INFO - Running setup.py (path:/tmp/pip-i3ZNQW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:08:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 13:08:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:08:08 INFO - Running setup.py (path:/tmp/pip-u9GF21-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:08:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 13:08:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:08:08 INFO - Running setup.py (path:/tmp/pip-bfCFBf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:08:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 13:08:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:08:08 INFO - Running setup.py (path:/tmp/pip-UoKhg3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:08:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 13:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:08:09 INFO - Running setup.py (path:/tmp/pip-izBilf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:08:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 13:08:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:08:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:08:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 13:08:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:08:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:08:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:08:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:08:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:08:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:08:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:08:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:08:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:08:11 INFO - Downloading blessings-1.6.tar.gz 13:08:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:08:11 INFO - Installing collected packages: blessings 13:08:11 INFO - Running setup.py install for blessings 13:08:11 INFO - Successfully installed blessings 13:08:11 INFO - Cleaning up... 13:08:11 INFO - Return code: 0 13:08:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:08:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:08:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:08:11 INFO - Reading from file tmpfile_stdout 13:08:11 INFO - Current package versions: 13:08:11 INFO - argparse == 1.2.1 13:08:11 INFO - blessings == 1.6 13:08:11 INFO - blobuploader == 1.2.4 13:08:11 INFO - docopt == 0.6.1 13:08:11 INFO - functools32 == 3.2.3-2 13:08:11 INFO - jsonschema == 2.5.1 13:08:11 INFO - manifestparser == 1.1 13:08:11 INFO - mozInstall == 1.12 13:08:11 INFO - mozcrash == 0.17 13:08:11 INFO - mozdebug == 0.1 13:08:11 INFO - mozdevice == 0.48 13:08:11 INFO - mozfile == 1.2 13:08:11 INFO - mozhttpd == 0.7 13:08:11 INFO - mozinfo == 0.9 13:08:11 INFO - mozleak == 0.1 13:08:11 INFO - mozlog == 3.3 13:08:11 INFO - moznetwork == 0.27 13:08:11 INFO - mozprocess == 0.23 13:08:11 INFO - mozprofile == 0.28 13:08:11 INFO - mozrunner == 6.12 13:08:11 INFO - mozscreenshot == 0.1 13:08:11 INFO - mozsystemmonitor == 0.3 13:08:11 INFO - moztest == 0.7 13:08:11 INFO - mozversion == 1.4 13:08:11 INFO - psutil == 3.1.1 13:08:11 INFO - requests == 1.2.3 13:08:11 INFO - wsgiref == 0.1.2 13:08:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:08:11 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:08:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:08:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:11 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:08:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:08:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:11 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 0x1589030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x184a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18483b0>, '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 0x18492b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1849740>, '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': '3a3620fb28aea1604ab609ef000001d2-1469131657.602276-1239246029', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:08:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 13:08:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:08:11 INFO - Using env: {'DISPLAY': ':0', 13:08:11 INFO - 'HOME': '/home/cltbld', 13:08:11 INFO - 'LANG': 'en_US.UTF-8', 13:08:11 INFO - 'LANGUAGE': 'en_US:en', 13:08:11 INFO - 'LOGNAME': 'cltbld', 13:08:11 INFO - 'MAIL': '/var/mail/cltbld', 13:08:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:08:11 INFO - 'MOZ_NO_REMOTE': '1', 13:08:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:08:11 INFO - 'NO_EM_RESTART': '1', 13:08:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:08:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:08:11 INFO - 'PWD': '/builds/slave/test', 13:08:11 INFO - 'SHELL': '/bin/bash', 13:08:11 INFO - 'SHLVL': '1', 13:08:11 INFO - 'TERM': 'linux', 13:08:11 INFO - 'TMOUT': '86400', 13:08:11 INFO - 'USER': 'cltbld', 13:08:11 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1469131657.602276-1239246029', 13:08:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:08:11 INFO - '_': '/tools/buildbot/bin/python'} 13:08:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:08:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:08:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 13:08:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 13:08:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 13:08:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 13:08:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 13:08:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 13:08:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 13:08:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 13:08:11 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:08:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 13:08:11 INFO - Cleaning up... 13:08:11 INFO - Return code: 0 13:08:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:08:11 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:08:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:08:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:11 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:08:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:08:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:11 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 0x1589030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x184a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18483b0>, '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 0x18492b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1849740>, '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': '3a3620fb28aea1604ab609ef000001d2-1469131657.602276-1239246029', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:08:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 13:08:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 13:08:11 INFO - Using env: {'DISPLAY': ':0', 13:08:11 INFO - 'HOME': '/home/cltbld', 13:08:11 INFO - 'LANG': 'en_US.UTF-8', 13:08:11 INFO - 'LANGUAGE': 'en_US:en', 13:08:11 INFO - 'LOGNAME': 'cltbld', 13:08:11 INFO - 'MAIL': '/var/mail/cltbld', 13:08:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:08:11 INFO - 'MOZ_NO_REMOTE': '1', 13:08:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:08:11 INFO - 'NO_EM_RESTART': '1', 13:08:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:08:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:08:11 INFO - 'PWD': '/builds/slave/test', 13:08:11 INFO - 'SHELL': '/bin/bash', 13:08:11 INFO - 'SHLVL': '1', 13:08:11 INFO - 'TERM': 'linux', 13:08:11 INFO - 'TMOUT': '86400', 13:08:11 INFO - 'USER': 'cltbld', 13:08:11 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1469131657.602276-1239246029', 13:08:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:08:11 INFO - '_': '/tools/buildbot/bin/python'} 13:08:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:08:11 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:08:11 INFO - Cleaning up... 13:08:11 INFO - Return code: 0 13:08:11 INFO - Running post-action listener: _resource_record_post_action 13:08:11 INFO - Running post-action listener: _start_resource_monitoring 13:08:11 INFO - Starting resource monitoring. 13:08:11 INFO - [mozharness: 2016-07-21 20:08:11.977558Z] Finished create-virtualenv step (success) 13:08:11 INFO - [mozharness: 2016-07-21 20:08:11.978041Z] Running install step. 13:08:11 INFO - Running pre-action listener: _resource_record_pre_action 13:08:11 INFO - Running main action method: install 13:08:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:08:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:08:12 INFO - Reading from file tmpfile_stdout 13:08:12 INFO - Detecting whether we're running mozinstall >=1.0... 13:08:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:08:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:08:12 INFO - Reading from file tmpfile_stdout 13:08:12 INFO - Output received: 13:08:12 INFO - Usage: mozinstall [options] installer 13:08:12 INFO - Options: 13:08:12 INFO - -h, --help show this help message and exit 13:08:12 INFO - -d DEST, --destination=DEST 13:08:12 INFO - Directory to install application into. [default: 13:08:12 INFO - "/builds/slave/test"] 13:08:12 INFO - --app=APP Application being installed. [default: firefox] 13:08:12 INFO - mkdir: /builds/slave/test/build/application 13:08:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 13:08:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 13:08:29 INFO - Reading from file tmpfile_stdout 13:08:29 INFO - Output received: 13:08:29 INFO - /builds/slave/test/build/application/firefox/firefox 13:08:29 INFO - Running post-action listener: _resource_record_post_action 13:08:29 INFO - [mozharness: 2016-07-21 20:08:29.513326Z] Finished install step (success) 13:08:29 INFO - [mozharness: 2016-07-21 20:08:29.513605Z] Running run-tests step. 13:08:29 INFO - Running pre-action listener: _resource_record_pre_action 13:08:29 INFO - Running main action method: run_tests 13:08:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:08:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:08:29 INFO - Python 2.7.3 13:08:29 INFO - Return code: 0 13:08:29 INFO - grabbing minidump binary from tooltool 13:08:29 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:08:29 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 0x18483b0>, '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 0x18492b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1849740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:08:29 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 13:08:29 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 13:08:29 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 13:08:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:08:29 INFO - Return code: 0 13:08:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:08:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:08:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:08:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:08:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:08:29 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://queue.taskcluster.net/v1/task/aCafWlUuSdixsZLCLGTS9Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 13:08:29 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://queue.taskcluster.net/v1/task/aCafWlUuSdixsZLCLGTS9Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-059 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 13:08:29 INFO - Using env: {'DISPLAY': ':0', 13:08:29 INFO - 'HOME': '/home/cltbld', 13:08:29 INFO - 'LANG': 'en_US.UTF-8', 13:08:29 INFO - 'LANGUAGE': 'en_US:en', 13:08:29 INFO - 'LOGNAME': 'cltbld', 13:08:29 INFO - 'MAIL': '/var/mail/cltbld', 13:08:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:08:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:08:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:08:29 INFO - 'MOZ_NO_REMOTE': '1', 13:08:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:08:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:08:29 INFO - 'NO_EM_RESTART': '1', 13:08:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:08:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:08:29 INFO - 'PWD': '/builds/slave/test', 13:08:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:08:29 INFO - 'SHELL': '/bin/bash', 13:08:29 INFO - 'SHLVL': '1', 13:08:29 INFO - 'TERM': 'linux', 13:08:29 INFO - 'TMOUT': '86400', 13:08:29 INFO - 'USER': 'cltbld', 13:08:29 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1469131657.602276-1239246029', 13:08:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:08:29 INFO - '_': '/tools/buildbot/bin/python'} 13:08:29 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://queue.taskcluster.net/v1/task/aCafWlUuSdixsZLCLGTS9Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 13:08:29 INFO - mozversion application_buildid: 20160721113038 13:08:29 INFO - mozversion application_changeset: bd6655e7b879214b7d983ca85c8160a77a653178 13:08:29 INFO - mozversion application_display_name: Nightly 13:08:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:08:29 INFO - mozversion application_name: Firefox 13:08:29 INFO - mozversion application_remotingname: firefox 13:08:29 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 13:08:29 INFO - mozversion application_vendor: Mozilla 13:08:29 INFO - mozversion application_version: 50.0a1 13:08:29 INFO - mozversion platform_buildid: 20160721113038 13:08:29 INFO - mozversion platform_changeset: bd6655e7b879214b7d983ca85c8160a77a653178 13:08:29 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 13:08:29 INFO - mozversion platform_version: 50.0a1 13:08:29 INFO - using testdate: 1469131709 13:08:29 INFO - actual date: 1469131709 13:08:29 INFO - starting webserver on 'localhost:40543' 13:08:29 INFO - SUITE-START | Running 2 tests 13:08:29 INFO - TEST-START | dromaeo_css 13:08:29 INFO - operating with platform_type : linux_ 13:08:29 INFO - Initialising browser for dromaeo_css test... 13:08:29 INFO - TEST-INFO | started process 14124 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8x1Q5U/profile http://localhost:40543/getInfo.html) 13:08:32 INFO - PROCESS | 14124 | JavaScript error: , line 0: uncaught exception: undefined 13:08:33 INFO - PROCESS | 14124 | __metrics Screen width/height:1600/1200 13:08:33 INFO - PROCESS | 14124 | colorDepth:24 13:08:33 INFO - PROCESS | 14124 | Browser inner width/height: 1024/697 13:08:33 INFO - PROCESS | 14124 | __metrics 13:08:34 INFO - PROCESS | 14124 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 13:08:34 INFO - PROCESS | 14124 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 58: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:08:35 INFO - TEST-INFO | 14124: exit 0 13:08:35 INFO - Browser initialized. 13:08:35 INFO - Running cycle 1/1 for dromaeo_css test... 13:08:35 INFO - TEST-INFO | started process 14207 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8x1Q5U/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:08:47 INFO - PROCESS | 14207 | RSS: Main: 157478912 13:08:47 INFO - PROCESS | 14207 | 13:09:38 INFO - PROCESS | 14207 | 1469131778930 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 13:11:46 INFO - PROCESS | 14207 | Cycle 1(1): loaded http://localhost:40543/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40543/tests/dromaeo/cssquery-ext.html) 13:11:48 INFO - PROCESS | 14207 | RSS: Main: 264667136 13:11:48 INFO - PROCESS | 14207 | 13:14:50 INFO - PROCESS | 14207 | Cycle 1(1): loaded http://localhost:40543/tests/dromaeo/cssquery-ext.html (next: http://localhost:40543/tests/dromaeo/cssquery-jquery.html) 13:14:51 INFO - PROCESS | 14207 | RSS: Main: 242905088 13:14:51 INFO - PROCESS | 14207 | 13:17:52 INFO - PROCESS | 14207 | Cycle 1(1): loaded http://localhost:40543/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40543/tests/dromaeo/cssquery-mootools.html) 13:17:53 INFO - PROCESS | 14207 | RSS: Main: 226648064 13:17:53 INFO - PROCESS | 14207 | 13:20:55 INFO - PROCESS | 14207 | Cycle 1(1): loaded http://localhost:40543/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40543/tests/dromaeo/cssquery-prototype.html) 13:20:56 INFO - PROCESS | 14207 | RSS: Main: 211603456 13:20:56 INFO - PROCESS | 14207 | 13:23:58 INFO - PROCESS | 14207 | Cycle 1(1): loaded http://localhost:40543/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40543/tests/dromaeo/cssquery-yui.html) 13:23:59 INFO - PROCESS | 14207 | RSS: Main: 184930304 13:23:59 INFO - PROCESS | 14207 | 13:27:02 INFO - PROCESS | 14207 | Cycle 1(1): loaded http://localhost:40543/tests/dromaeo/cssquery-yui.html (next: http://localhost:40543/tests/dromaeo/cssquery-dojo.html) 13:27:02 INFO - PROCESS | 14207 | RSS: Main: 276459520 13:27:02 INFO - PROCESS | 14207 | 13:27:02 INFO - PROCESS | 14207 | __start_tp_report 13:27:02 INFO - PROCESS | 14207 | _x_x_mozilla_page_load 13:27:02 INFO - PROCESS | 14207 | _x_x_mozilla_page_load_details 13:27:02 INFO - PROCESS | 14207 | |i|pagename|runs| 13:27:02 INFO - PROCESS | 14207 | |0;dojo.html;3061.372418654175;3071.5239137933618;3082.090783218951;3109.549115378272;3113.859876305566;5319.228711836791;5371.382291036532;5395.514403703666;5458;5469.863253418666;5359.517643412092;5424.945750542493;5434.538064264532;5478.890422191564;5566.332040155177;4809.4469136049365;4892.755362231892;4901.191303434929;4903.82836600719;5047.67190132642;4976.900461990758;5005.199168133099;5026.4219614744225;5035.269885866547;5038.042771873351;4798.568128868401;4804.279358096313;4841.661083724141;4842.2736589511505;5003.249512573107;4885.413750349945;4895.755212239374;4898.583620392271;4946.777395017233;4965.652404331699;4867.17258066126;4907.533784290523;4941.579965702919;4946.186172413644;4976.253561965698;5160.92258616121;5309.283246761715;5406.621536492447;5446.8910621787345;5454.154606036071;5792.420757924216;5855.268091488564;5899.115132730082;5906.822795316104;5909.852253693649;5828.912566311508;5924.881502369972;5944.64332140073;5948.73230704615;5949.345571987078;5239.921401178985;5346.385165705916;5450.5367043801725;5523.199136125279;5527.695976721278;6042.063480160582;6071.51427885768;6071.574989750763;6074.058520929263;6075.665838378932;5813.476787089182;5817.563682723812;5819.912701309484;5824.941750582525;5829.912551311733;5605.971970140124;5743.396943320975;5801.477866991991;5918.822435326861;5921.851953701106;5807.390224026501;5812.59311848175;5812.912806307909;5842.269716285465;5868.295804503487;5759.596828221985;5799.942000580025;5814.709264536757;5816.243888294494;5818.709064546841;4337.544557821383;4356.869293921124;4393.406890069799;4395.099004704028;4475.619572336323;3933.803309834554;3941.8620348288246;3965.980170099131;3988.780617066031;4020.8592699255387;5514.503694667499;5517.2551705520045;5519.199716041152;5522.9447705523235;5523.1991361253195;5652.265205523256;5790.36306006339;5837.211976383219;5838.5329173666005;5884.676342801102;5460.180972854104;5499.972500137554;5507.284053073075;5535.944640553624;5558.666480011212;5050.4697006814495;5054.595632349403;5057.570106540985;5060.316857224301;5103.055934652101;5900.055991041499;5916.1421593868645;5979.372165922602;6043.033114701627;6046.3349031606485;5752.395998420273;5780.3930587289415;5787.247657804627;5797.76808927655;5803.82588522345;5941.435563621449;5953.404659534185;5958.404159584007;5964.97017514927;5969.940300596939;5568.888622227451;5620.213170156263;5648.830535083954;5696.743646535999;5699.287589051369;5744.167095771173;5819.388964158872;5821.650700957786;5857.47282744555;5860.589758716849;5605.691686957257;5607.467290607386;5632.436756324335;5655.377908430151;5668.659880407189;5443.374011988672;5544.889102218014;5629.380768115586;5633.408492108433;5633.887322253614;5564.4991950724625;5644.0687286598895;5645.68948707825;5691.26013618227;5698.8290351289525;5644.2380278663495;5676.290463692038;5710;5719.3136823581435;5730.312362516524;5441.483059109379;5441.727913604224;5534.391216966211;5541.944580554304;5546.362168350692 13:27:02 INFO - PROCESS | 14207 | |1;ext.html;602.9306629737579;608.2154021312506;615.3538784276506;628.7987843889954;638.1863124516244;45114.54885451144;46640.533594664084;46788;46894.296585551245;49563.75218123904;45406.318905216445;45649.77175114128;45728.51257849055;45778.31332530015;45859;8945.418547794405;9071.682491112811;9077.68228112013;9086.409383390092;9086.545672716371;8893.066228046058;8977;8978.50618215998;8981.595828187714;8993.14565116313;9032.548372581377;9045.185933266004;9070;9077.863832042525;9078.954605226965;8977.506237156953;8991.145841145113;9012.504312262823;9018.053104424072;9021.548922553879;8939.821203575892;8967.641294348283;8999.23506501948;9005.954970225172;9016;41373.79313103445;41630.79184604088;41811.372829407585;42027.579724202675;42047.57952420498;3260.3479304139028;3345.96654033459;3351.7821341612716;3437;3445.6554344565593;31563;34111.658883411095;34470.31059378798;34545.48181777275;34548.481772773426;4337.71804832688;4394.604485596312;4395.846145384929;4496.1077948825505;4579.22153233951;380869;383219;383721;384274;386549;62022.37977620166;62308.68845655743;62387.37612623816;62426.37573624297;62488;66078.66960665166;66508.66745666241;66587.66706166536;66621;66677.66661166663;16706.665866682597;17052.658946820993;17056.403025894033;17056.744148837777;17059.914700426667;12862.614121576367;12906.290154041619;12914.67713307156;12940.741185176244;12953.676158095934;18185.11778929868;19709.408717738203;19819.702704459443;19826.702599460732;19991;7224.891626625605;7236.421086313082;7367.8158046049275;7390.593517356597;7400.222976587488;1012.5747186181821;1012.8581998520214;1035.1304903880625;1129.7909886670993;1149.431031639344;33016.83491582527;33441.69077371212;33610.327793444;33808.830955845064;33903.15242118967;928.4243768863348;1100.5212732461246;1119.082352470966;1188.9286642801287;1223.6818427208989;16908.66182676364;17059;17088;17423.65152696939;18186.36347727823;602454;610259;611398;612183;613517;62833.68583157055;63555.36444635494;63567.36432635707;63646.68176659087;63650.681746591894;1225.08730995409;1325.516186591887;1366.1939455720974;1379.1449301433177;1384.5707830572555;30681.471630761855;34230.82884585561;34405;34660.30679386449;34954.12614684653;51840;52554.73722631362;52637.47362526326;52652.47347526476;52752.47247527476;336309;338957;339010.5742069305;339272;339648;28478.145655630364;28592.42815143727;28748.281292967844;29369.55945660774;29455.26361840971;50185.24722129244;50197.74901125471;50418.747906260236;50607.49392506175;50665.74667126641;41074.794626026676;41521.584784151775;42882.35676464918;43256;44455;41897.162056759305;41945.37081943834;42697.35953960631;43286.35070473883;44308.33537497005;41135.7943210282;41803.7909810449;42582.14835703331;42662.78668606637;42692.359614605186;35505;37298.81350593338;38086.666966656034;38503.61496385113;38634.42048369221;27947.86026069938;28099;28130.156095317172;28296.858515708114;28415.289617758895 13:27:02 INFO - PROCESS | 14207 | |2;jquery.html;374.1880120139297;393.4511356657463;407.2283023670144;410.46024477811676;414.31844615607326;14065.859341406584;18071.45785626432;18972.715409268836;19344.516387090312;19429.611407771838;18251;18560.90719546404;18802;18896.905515472437;19121.52196195096;5648.802291919784;5709.343425506078;5782.392848750884;5827.912581311284;5831.533477321804;5636.210930469717;5696.287964004499;5747.281589801254;5755.338136114358;5756.769729210827;5675.1203563447525;5678.829635110933;5729.341125770548;5729.369769325371;5778.6243894146955;5592.5246354059955;5746.9712651436475;5754.625949313302;5758.222639943596;5771.105478650816;5016.598672106259;5041.798328066873;5056.494350564951;5096.923546146811;5145.253938178943;22705.545889082292;22956.54086918269;23006.654900176512;23055.884720576458;23109.422264443525;2426.9150579729803;2438.67077944477;2573.6268241104935;2738.411241583049;2957.1719918422878;14312.21282829444;14388.208648524327;14494.275286235752;14495.347709352998;14527.927360363235;1892.1579896945864;1921.0874834453523;1977.574821413403;1993.3720877923552;2038.551518665891;84121.57939210265;85467.57266213628;86630.56684716536;87007;87140.99999999936;9092.363534552518;9760.658376956773;9818.165455936325;10322.142014437473;10671.89328106709;13096.279704616338;13143;13152.539661111816;13158;13170.143940643828;7783.494072885244;7830.334421574116;7976.162502937224;8081.313088387553;8122.593870306461;7645;7684.731034413769;7762.7671169865;7783.260590243918;8193.426460147732;3957.584453632385;4033.9394909076386;4058.5738497457933;4126.525449573338;4147;1941.223510595773;1943.3684052682934;1943.426689126711;1958.8687408411581;1991.422487478615;875.6366108065209;969.9951500242595;1005.9094681478556;1056.3820165203442;1114.2868564118971;18344.357947471774;18789.154488048072;19323.130459129374;19432.80567194338;20007.59984800296;972.2027937091517;977.5014742481386;1003.3428104591504;1014.9543270552695;1054.9789004219872;10313.742156445998;10843.83734243987;10848.240623156304;10872;10872.836907446395;433299;478697;506588;527614;527813;94392.52803736075;96113;96160;96205.5189724047;96608.0339196613;958.3770549142973;982.0425085541683;989.8515222716507;994.8507723841337;1003.9247056470648;16510.587235319214;16592.917035414746;16687.198567588115;17282.65434691274;17744.822551774832;39265.411018834166;40943.38584921288;42952;44050.559494404646;45701;53971.46028539664;60751.392486074576;61659.38340616716;62627.37372626215;63280.73438531296;8448.915510844812;8464.830703385775;8510.31917446615;8560.400771946153;8740.73777786642;11739.941300293443;12884.742305153657;13098.083134180515;13482.597475064566;14067.929660352042;10988.945055274993;11256.21206515536;11910.702232444259;11957.701057473632;12002.279863208236;11432.371219583003;11503.654890353302;11820.349880756641;11832.822507662564;11837.408129593658;11885.28688278706;12075.939620301842;12150.08874334446;12209.69475763113;12490.063245256824;8097.959510202411;8159.673613055411;8290.29532489721;8303.709370172015;8356.122607126408;9279.536023198949;11516.884831151581;11524.481398337262;11578.478968446609;11676.182667213554 13:27:02 INFO - PROCESS | 14207 | |3;mootools.html;1332.780091284938;1475.6384685751989;1513.8334783173848;1646.1357787161746;1777.5200695812132;8680.175383338581;9036.548172591369;9141.680041198568;9316.208122309596;9355.06449355064;9261.212796912254;9326.90673093269;9327.207187389064;9330.580123894424;9370;2372.845765025272;2407.939801504968;2408.048820715825;2409.265174121892;2412.4089598048504;2312.9537409251807;2369.3721163891582;2388.6178211486167;2393.688820453339;2396.25716028031;2320.060375547906;2321.3036089173265;2332.5801355755957;2362.208660098869;2367.2779802160335;2246.9888550152414;2249.2127755285683;2255.842091053627;2282.942926426844;2313.8611683298886;2274.4882401459704;2274.6701728249477;2275.4311422144465;2279.065583110933;2283.337832028726;9073.954630226872;9146.725598231997;9227.307951903567;9293.442393456347;9313.161815436642;5286.392064912546;5483.259759932398;5486.478784515504;5488.17677348397;5488.670679759187;3446.4657978013447;3450.46517789743;3514.2620049789575;3514.6661067198575;3516.033090899997;1194.8088305871106;1204.9759004819941;1222.6576558563615;1228.5854865884435;1253.8056601226824;12955.48178072876;13003.869961300456;13059.542915997894;13065.738685226243;13066.673333166651;4368.104538569649;4613.792379342937;4669.0428462165855;4688.367070445446;4716.95283047172;10206.4386458744;10238.18094552434;10238.744031399126;10248.282620216662;10255.07704306601;5381.704006279614;5406.54044406222;5417.83746487606;5418.864528386822;5421;4091.734037287567;4405.647548196201;4541.455025396974;4982.950170498321;5052.671576347526;3854.4411060396087;3967.583403742623;3997.600239975979;4004.199160167978;4066.044479547304;1130.5647325779469;1174.1428757007432;1179.5281887245171;1181.639599922032;1188.2751521572006;854.9700760473478;929.0848514213494;929.6746138851348;944.9527523623791;952.0812416018575;5988.221531200916;5995.610285331527;6055.757769689251;6061.6666083365835;6076.574639775174;447.5278581096909;449.64478062331045;461.2251417618433;464.66311923854937;474.1347041649004;3947.921041579152;4054.3310353791885;4071.1654110907193;4092.529359123679;4094.931099194369;11340.149488788375;11691.123165762601;11770.234934729215;11801.114916381306;11827.17209795306;11578.76842463146;11583.594574190032;11598.94200528992;11652.825207621892;11660;8659.177378149066;8705.347098967603;8707.956460217658;8720.520371379635;8753.824923501494;5673.319201695823;5680.40355762639;5793.565482588739;5841.357450680337;5916.556258280732;10338.483075846329;10525.526351314056;10531.368117912949;10556.049955504042;10634;9666.709998700051;10932.289401188897;10937.179711521827;10966.670999870017;10981.066609337977;7468.365188958782;7638.923610763822;7731.226877312224;7906.407019473448;7910.644021019183;8529.530875801891;8906.287497000354;8947.865782013405;8970.820583588162;8975.506347150707;7847.725329613436;8166.183381661786;8190.50856948585;8221.136780637948;8335;7964.721234756756;8119.18808119207;8120.431569790058;8169.101398846241;8330.583470826556;7339.669714862951;7464.850702986018;7471.290227428385;7473.43949203801;7476.813079673052;5268.1834315681135;5311;5313.415524292402;5336.359636843604;5503.944960550343;5354.892902142014;5363.2759577456545;5393.325834270716;5435.945640543702;5678 13:27:02 INFO - PROCESS | 14207 | |4;prototype.html;329.1475079543979;332.84023668639054;338.1816005267254;341.12331308537057;342.07127648434493;5239.397469291032;5255.76349064292;5281.867953301169;5304.01875653004;5312.548433383157;4924.950750492503;5029.270755740425;5181.35233095863;5217.713025783581;5225.817096401626;4134;4151.418801367811;4162.354835000579;4187.623113919746;4205.13794672093;4123.958760412403;4163.438710483569;4186.769727664977;4192.5597812229735;4196.790160491979;3942.349512330462;3961.722679412442;4114.917701645965;4125.669946404296;4166.500019997605;4111.424400583921;4112.259793237216;4113.4035564843225;4145.357469592218;4149.730267532631;3666.944995825065;3673.2837096765875;3675.5405574303213;3678.5953545110015;3684.6499582539614;5030.597552195815;5071.695698258116;5115.641905066647;5125.256837758541;5157.432682404932;4687.507811679793;4692.436907571079;4694.929576056362;4695.272232803921;4703.600193983515;5388.655934668393;5391.460853914617;5407.756650950717;5416.8104116356135;5467.644603100785;3748.6063963283736;3951.7826519541413;4019.733783858075;4025.295573274665;4034.11249525104;5633.352164501094;5657.6322539035245;5663.093904975225;5663.858403539944;5664.376918538957;4052.4124002019544;4065.634092931591;4066.430699702044;4082.183563287295;4083.4686992377265;3922.6861851052417;4116.567760385176;4130.215259100762;4138.0689344897155;4146.1914926589625;4651.930221046687;4652.185867473178;4660.370849935215;4661.184292748755;4675.4155730533685;5454.181872719124;5482.698451585121;5487.38122253936;5518.586106042063;5573.637713548606;1351.5269655620455;1407.7677183264852;1428.6214153249398;1430.3348942741468;1431.2128329418779;904.4889637354873;925.4863550729275;931.1340453378288;933.3140141995627;935.7274107214183;4722.1972264714395;4763.285507173951;4765.618750499952;4785.210440277316;4816;4604.493505714368;4974.90050198994;4990.8253211137435;5003.674761140514;5011.298418221452;4651;4659.883502912454;4722.315264286659;4769.712177712067;4807.399075115611;2672.835003647052;2676.866156692158;2678.906238281651;2685.516607010718;2690.0584795321874;5119.436861945183;5160.5550445875215;5393.6763794172475;5860.882782344329;5883.17635531026;5737.971310143506;5758.222639943638;5759.481646651821;5786.739596718074;5796.971015144897;5660.745266462936;5785.8553536161935;5849.61977471463;5852.824415267549;5895.852603684856;5579.7489112990825;5632.225848857597;5634.464725851038;5641.238432811518;5660.575456840671;5611.466910643482;5613.887722245614;5629.240052592848;5639.436056394327;5649.943500564942;5643.492085712305;5786.971065144648;5789.594728368974;5802.0119638387105;5877.23595932526;4053.858114965962;4060.16766562848;4060.715749897479;4067.349224124126;4073.938890916579;5482.342118945592;5528.51216952381;5596.300462442195;5611.747471363717;5722.284714410699;5495.780168793203;5507.284053073075;5515.124857548452;5519.972400137974;5520.36515800672;5280.7359632019015;5497.175423686479;5547.4175211603815;5590.133529302964;5592.748326325243;5438.15708565173;5472.480114389126;5472.589555783253;5477.808276710455;5508.3114610673665;5497.285352904097;5569.5519165018195;5604.710916489149;5616.185653080199;5631.1271752878365;5189.221616757516;5333.653312534673;5389.56883449331;5473.397926228032;5481.054225749802 13:27:02 INFO - PROCESS | 14207 | |5;yui.html;811.1645005644186;840.134661298862;841.0345222276962;861.1904809479086;868.4875923205308;15454.459093931715;16670.583235419104;16702.665946681074;16712.58218544537;16734.74897876533;15120.168390738505;15227.543173704778;15231.84768152318;15248.618784530392;15270;662.4931927075767;787.3189690917372;792.5324058805304;803.6463955859432;808.6805711743872;802.9839403211932;819.3117781063905;820.1839170025833;820.2904487618227;821.1172989036779;859.3898332184157;863.4775960543875;864.2869632553137;864.9870251946226;865.1867244789877;694.1773997812583;833.5415521463171;840.9369297302727;854.2055888024136;864.1660797330575;626.2266101364811;629.7481007596953;630.8864404407204;630.9621422714606;631.1195881744986;14977.475788347465;15045.548633541011;15098.16960067196;15145.772813407697;15153.696926061528;13821;13903.86096139046;13915.98218258357;13990.230537320444;14125.788113178207;13079.580277648665;13177.868221317856;13210.471581136839;13241.271730054843;13718.725625487534;4415.646748260131;4427.911441771146;4437.0682156747125;4632.490426053131;4663.114008338405;75989;76020;79489.20510794876;80227.59886200531;82269;11498.482568284448;11571.710707232387;11603.245789023686;11679.357635330138;11954.940225298991;21557;21590.892045539673;21607.02768375427;21638.675419868716;21667.891660541598;8647.221750042527;8752.431091979;8794.692185773467;8916.484757056995;9061.275097992146;4707.058588282357;4709.693869898446;4921.926171107436;4927.704337739747;4989.950100498949;3648.7628304160144;3753.60587138352;3757.229767897574;3758.6805121564425;3763.473113764075;636.78667646339;647.0488382078337;651.4299987510927;655.9409653131241;657.1883723601348;671.4762485261504;705.4708968273794;723.8950352198901;725.419664268583;736.5309392760053;9084.591193396313;9849.803003939882;10021.348612340174;10188;10194.184465242912;572.9341125770507;617.8146556033172;680.0581195044898;688.61437594947;696.5054811084086;4474.619657329164;4685.4143232095985;4710.9764451177525;4713.31656909753;4781;67194;83172.58413707893;88842.55578722066;113269;117925;95946;99003;101483;102180.48909755403;108621.37067943987;83560;85330.57334713411;87008;87379.56310218408;89896;9215.953920230357;9242.306826987868;9379.671711490339;9428.764280893032;9491.905080949102;46648;52651;53793.46206538041;53928;55423.16865247105;83206;83563;83631.16368836477;84301;85255;11940.820887686517;12005.879941200825;12099.697507562381;12480.313582753035;12634.873651263737;12984.285864277555;13038.608841734764;13106.934465327613;13169.868301316865;13737.450501979809;12134.817977730518;12585.874141258837;12682.936585317015;12864.871351286367;12896.29070401137;12067.879321207027;12556.748865022832;12612.180208286432;12723.745525089262;13109.60671179866;11988.64034078979;11995.460204291003;12440.253584784941;12477.438515266653;12513.499460021862;10553.366797992145;10834.404107774148;11056.778864422828;11080.889191107986;11206.775864482828;9510.85733713981;9758.560864761244;9822.65620703272;10505.31715438494;10558.260921735406 13:27:02 INFO - PROCESS | 14207 | __end_tp_report 13:27:02 INFO - PROCESS | 14207 | __start_cc_report 13:27:02 INFO - PROCESS | 14207 | _x_x_mozilla_cycle_collect,966 13:27:02 INFO - PROCESS | 14207 | __end_cc_report 13:27:02 INFO - PROCESS | 14207 | __startTimestamp1469132822910__endTimestamp 13:27:02 INFO - PROCESS | 14207 | 13:27:02 INFO - PROCESS | 14207 | ------- Summary: start ------- 13:27:02 INFO - PROCESS | 14207 | Number of tests: 6 13:27:02 INFO - PROCESS | 14207 | 13:27:02 INFO - PROCESS | 14207 | [#0] dojo.html Cycles:165 Average:5392.73 Median:5566.33 stddev:625.61 (11.2%) stddev-sans-first:600.20 13:27:02 INFO - PROCESS | 14207 | Values: 3061.4 3071.5 3082.1 3109.5 3113.9 5319.2 5371.4 5395.5 5458.0 5469.9 5359.5 5424.9 5434.5 5478.9 5566.3 4809.4 4892.8 4901.2 4903.8 5047.7 4976.9 5005.2 5026.4 5035.3 5038.0 4798.6 4804.3 4841.7 4842.3 5003.2 4885.4 4895.8 4898.6 4946.8 4965.7 4867.2 4907.5 4941.6 4946.2 4976.3 5160.9 5309.3 5406.6 5446.9 5454.2 5792.4 5855.3 5899.1 5906.8 5909.9 5828.9 5924.9 5944.6 5948.7 5949.3 5239.9 5346.4 5450.5 5523.2 5527.7 6042.1 6071.5 6071.6 6074.1 6075.7 5813.5 5817.6 5819.9 5824.9 5829.9 5606.0 5743.4 5801.5 5918.8 5921.9 5807.4 5812.6 5812.9 5842.3 5868.3 5759.6 5799.9 5814.7 5816.2 5818.7 4337.5 4356.9 4393.4 4395.1 4475.6 3933.8 3941.9 3966.0 3988.8 4020.9 5514.5 5517.3 5519.2 5522.9 5523.2 5652.3 5790.4 5837.2 5838.5 5884.7 5460.2 5500.0 5507.3 5535.9 5558.7 5050.5 5054.6 5057.6 5060.3 5103.1 5900.1 5916.1 5979.4 6043.0 6046.3 5752.4 5780.4 5787.2 5797.8 5803.8 5941.4 5953.4 5958.4 5965.0 5969.9 5568.9 5620.2 5648.8 5696.7 5699.3 5744.2 5819.4 5821.7 5857.5 5860.6 5605.7 5607.5 5632.4 5655.4 5668.7 5443.4 5544.9 5629.4 5633.4 5633.9 5564.5 5644.1 5645.7 5691.3 5698.8 5644.2 5676.3 5710.0 5719.3 5730.3 5441.5 5441.7 5534.4 5541.9 5546.4 13:27:02 INFO - PROCESS | 14207 | 13:27:02 INFO - PROCESS | 14207 | [#1] ext.html Cycles:180 Average:61571.84 Median:42622.47 stddev:122214.16 (286.7%) stddev-sans-first:122471.27 13:27:02 INFO - PROCESS | 14207 | Values: 602.9 608.2 615.4 628.8 638.2 45114.5 46640.5 46788.0 46894.3 49563.8 45406.3 45649.8 45728.5 45778.3 45859.0 8945.4 9071.7 9077.7 9086.4 9086.5 8893.1 8977.0 8978.5 8981.6 8993.1 9032.5 9045.2 9070.0 9077.9 9079.0 8977.5 8991.1 9012.5 9018.1 9021.5 8939.8 8967.6 8999.2 9006.0 9016.0 41373.8 41630.8 41811.4 42027.6 42047.6 3260.3 3346.0 3351.8 3437.0 3445.7 31563.0 34111.7 34470.3 34545.5 34548.5 4337.7 4394.6 4395.8 4496.1 4579.2 380869.0 383219.0 383721.0 384274.0 386549.0 62022.4 62308.7 62387.4 62426.4 62488.0 66078.7 66508.7 66587.7 66621.0 66677.7 16706.7 17052.7 17056.4 17056.7 17059.9 12862.6 12906.3 12914.7 12940.7 12953.7 18185.1 19709.4 19819.7 19826.7 19991.0 7224.9 7236.4 7367.8 7390.6 7400.2 1012.6 1012.9 1035.1 1129.8 1149.4 33016.8 33441.7 33610.3 33808.8 33903.2 928.4 1100.5 1119.1 1188.9 1223.7 16908.7 17059.0 17088.0 17423.7 18186.4 602454.0 610259.0 611398.0 612183.0 613517.0 62833.7 63555.4 63567.4 63646.7 63650.7 1225.1 1325.5 1366.2 1379.1 1384.6 30681.5 34230.8 34405.0 34660.3 34954.1 51840.0 52554.7 52637.5 52652.5 52752.5 336309.0 338957.0 339010.6 339272.0 339648.0 28478.1 28592.4 28748.3 29369.6 29455.3 50185.2 50197.7 50418.7 50607.5 50665.7 41074.8 41521.6 42882.4 43256.0 44455.0 41897.2 41945.4 42697.4 43286.4 44308.3 41135.8 41803.8 42582.1 42662.8 42692.4 35505.0 37298.8 38086.7 38503.6 38634.4 27947.9 28099.0 28130.2 28296.9 28415.3 13:27:02 INFO - PROCESS | 14207 | 13:27:02 INFO - PROCESS | 14207 | [#2] jquery.html Cycles:180 Average:29391.53 Median:2175.52 stddev:82000.25 (3769.2%) stddev-sans-first:82201.34 13:27:02 INFO - PROCESS | 14207 | Values: 374.2 393.5 407.2 410.5 414.3 14065.9 18071.5 18972.7 19344.5 19429.6 18251.0 18560.9 18802.0 18896.9 19121.5 5648.8 5709.3 5782.4 5827.9 5831.5 5636.2 5696.3 5747.3 5755.3 5756.8 5675.1 5678.8 5729.3 5729.4 5778.6 5592.5 5747.0 5754.6 5758.2 5771.1 5016.6 5041.8 5056.5 5096.9 5145.3 22705.5 22956.5 23006.7 23055.9 23109.4 2426.9 2438.7 2573.6 2738.4 2957.2 14312.2 14388.2 14494.3 14495.3 14527.9 1892.2 1921.1 1977.6 1993.4 2038.6 84121.6 85467.6 86630.6 87007.0 87141.0 9092.4 9760.7 9818.2 10322.1 10671.9 13096.3 13143.0 13152.5 13158.0 13170.1 7783.5 7830.3 7976.2 8081.3 8122.6 7645.0 7684.7 7762.8 7783.3 8193.4 3957.6 4033.9 4058.6 4126.5 4147.0 1941.2 1943.4 1943.4 1958.9 1991.4 875.6 970.0 1005.9 1056.4 1114.3 18344.4 18789.2 19323.1 19432.8 20007.6 972.2 977.5 1003.3 1015.0 1055.0 10313.7 10843.8 10848.2 10872.0 10872.8 433299.0 478697.0 506588.0 527614.0 527813.0 94392.5 96113.0 96160.0 96205.5 96608.0 958.4 982.0 989.9 994.9 1003.9 16510.6 16592.9 16687.2 17282.7 17744.8 39265.4 40943.4 42952.0 44050.6 45701.0 53971.5 60751.4 61659.4 62627.4 63280.7 8448.9 8464.8 8510.3 8560.4 8740.7 11739.9 12884.7 13098.1 13482.6 14067.9 10988.9 11256.2 11910.7 11957.7 12002.3 11432.4 11503.7 11820.3 11832.8 11837.4 11885.3 12075.9 12150.1 12209.7 12490.1 8098.0 8159.7 8290.3 8303.7 8356.1 9279.5 11516.9 11524.5 11578.5 11676.2 13:27:02 INFO - PROCESS | 14207 | 13:27:02 INFO - PROCESS | 14207 | [#3] mootools.html Cycles:180 Average:5990.57 Median:2537.51 stddev:3523.46 (138.9%) stddev-sans-first:3515.96 13:27:02 INFO - PROCESS | 14207 | Values: 1332.8 1475.6 1513.8 1646.1 1777.5 8680.2 9036.5 9141.7 9316.2 9355.1 9261.2 9326.9 9327.2 9330.6 9370.0 2372.8 2407.9 2408.0 2409.3 2412.4 2313.0 2369.4 2388.6 2393.7 2396.3 2320.1 2321.3 2332.6 2362.2 2367.3 2247.0 2249.2 2255.8 2282.9 2313.9 2274.5 2274.7 2275.4 2279.1 2283.3 9074.0 9146.7 9227.3 9293.4 9313.2 5286.4 5483.3 5486.5 5488.2 5488.7 3446.5 3450.5 3514.3 3514.7 3516.0 1194.8 1205.0 1222.7 1228.6 1253.8 12955.5 13003.9 13059.5 13065.7 13066.7 4368.1 4613.8 4669.0 4688.4 4717.0 10206.4 10238.2 10238.7 10248.3 10255.1 5381.7 5406.5 5417.8 5418.9 5421.0 4091.7 4405.6 4541.5 4983.0 5052.7 3854.4 3967.6 3997.6 4004.2 4066.0 1130.6 1174.1 1179.5 1181.6 1188.3 855.0 929.1 929.7 945.0 952.1 5988.2 5995.6 6055.8 6061.7 6076.6 447.5 449.6 461.2 464.7 474.1 3947.9 4054.3 4071.2 4092.5 4094.9 11340.1 11691.1 11770.2 11801.1 11827.2 11578.8 11583.6 11598.9 11652.8 11660.0 8659.2 8705.3 8708.0 8720.5 8753.8 5673.3 5680.4 5793.6 5841.4 5916.6 10338.5 10525.5 10531.4 10556.0 10634.0 9666.7 10932.3 10937.2 10966.7 10981.1 7468.4 7638.9 7731.2 7906.4 7910.6 8529.5 8906.3 8947.9 8970.8 8975.5 7847.7 8166.2 8190.5 8221.1 8335.0 7964.7 8119.2 8120.4 8169.1 8330.6 7339.7 7464.9 7471.3 7473.4 7476.8 5268.2 5311.0 5313.4 5336.4 5503.9 5354.9 5363.3 5393.3 5435.9 5678.0 13:27:02 INFO - PROCESS | 14207 | 13:27:02 INFO - PROCESS | 14207 | [#4] prototype.html Cycles:180 Average:4575.09 Median:5122.35 stddev:1342.52 (26.2%) stddev-sans-first:1307.92 13:27:02 INFO - PROCESS | 14207 | Values: 329.1 332.8 338.2 341.1 342.1 5239.4 5255.8 5281.9 5304.0 5312.5 4925.0 5029.3 5181.4 5217.7 5225.8 4134.0 4151.4 4162.4 4187.6 4205.1 4124.0 4163.4 4186.8 4192.6 4196.8 3942.3 3961.7 4114.9 4125.7 4166.5 4111.4 4112.3 4113.4 4145.4 4149.7 3666.9 3673.3 3675.5 3678.6 3684.6 5030.6 5071.7 5115.6 5125.3 5157.4 4687.5 4692.4 4694.9 4695.3 4703.6 5388.7 5391.5 5407.8 5416.8 5467.6 3748.6 3951.8 4019.7 4025.3 4034.1 5633.4 5657.6 5663.1 5663.9 5664.4 4052.4 4065.6 4066.4 4082.2 4083.5 3922.7 4116.6 4130.2 4138.1 4146.2 4651.9 4652.2 4660.4 4661.2 4675.4 5454.2 5482.7 5487.4 5518.6 5573.6 1351.5 1407.8 1428.6 1430.3 1431.2 904.5 925.5 931.1 933.3 935.7 4722.2 4763.3 4765.6 4785.2 4816.0 4604.5 4974.9 4990.8 5003.7 5011.3 4651.0 4659.9 4722.3 4769.7 4807.4 2672.8 2676.9 2678.9 2685.5 2690.1 5119.4 5160.6 5393.7 5860.9 5883.2 5738.0 5758.2 5759.5 5786.7 5797.0 5660.7 5785.9 5849.6 5852.8 5895.9 5579.7 5632.2 5634.5 5641.2 5660.6 5611.5 5613.9 5629.2 5639.4 5649.9 5643.5 5787.0 5789.6 5802.0 5877.2 4053.9 4060.2 4060.7 4067.3 4073.9 5482.3 5528.5 5596.3 5611.7 5722.3 5495.8 5507.3 5515.1 5520.0 5520.4 5280.7 5497.2 5547.4 5590.1 5592.7 5438.2 5472.5 5472.6 5477.8 5508.3 5497.3 5569.6 5604.7 5616.2 5631.1 5189.2 5333.7 5389.6 5473.4 5481.1 13:27:02 INFO - PROCESS | 14207 | 13:27:02 INFO - PROCESS | 14207 | [#5] yui.html Cycles:180 Average:20590.11 Median:4712.15 stddev:29365.36 (623.2%) stddev-sans-first:29410.18 13:27:02 INFO - PROCESS | 14207 | Values: 811.2 840.1 841.0 861.2 868.5 15454.5 16670.6 16702.7 16712.6 16734.7 15120.2 15227.5 15231.8 15248.6 15270.0 662.5 787.3 792.5 803.6 808.7 803.0 819.3 820.2 820.3 821.1 859.4 863.5 864.3 865.0 865.2 694.2 833.5 840.9 854.2 864.2 626.2 629.7 630.9 631.0 631.1 14977.5 15045.5 15098.2 15145.8 15153.7 13821.0 13903.9 13916.0 13990.2 14125.8 13079.6 13177.9 13210.5 13241.3 13718.7 4415.6 4427.9 4437.1 4632.5 4663.1 75989.0 76020.0 79489.2 80227.6 82269.0 11498.5 11571.7 11603.2 11679.4 11954.9 21557.0 21590.9 21607.0 21638.7 21667.9 8647.2 8752.4 8794.7 8916.5 9061.3 4707.1 4709.7 4921.9 4927.7 4990.0 3648.8 3753.6 3757.2 3758.7 3763.5 636.8 647.0 651.4 655.9 657.2 671.5 705.5 723.9 725.4 736.5 9084.6 9849.8 10021.3 10188.0 10194.2 572.9 617.8 680.1 688.6 696.5 4474.6 4685.4 4711.0 4713.3 4781.0 67194.0 83172.6 88842.6 113269.0 117925.0 95946.0 99003.0 101483.0 102180.5 108621.4 83560.0 85330.6 87008.0 87379.6 89896.0 9216.0 9242.3 9379.7 9428.8 9491.9 46648.0 52651.0 53793.5 53928.0 55423.2 83206.0 83563.0 83631.2 84301.0 85255.0 11940.8 12005.9 12099.7 12480.3 12634.9 12984.3 13038.6 13106.9 13169.9 13737.5 12134.8 12585.9 12682.9 12864.9 12896.3 12067.9 12556.7 12612.2 12723.7 13109.6 11988.6 11995.5 12440.3 12477.4 12513.5 10553.4 10834.4 11056.8 11080.9 11206.8 9510.9 9758.6 9822.7 10505.3 10558.3 13:27:02 INFO - PROCESS | 14207 | -------- Summary: end -------- 13:27:02 INFO - PROCESS | 14207 | 13:27:03 INFO - TEST-INFO | 14207: exit 0 13:27:03 INFO - TEST-OK | dromaeo_css | took 1113844ms 13:27:03 INFO - TEST-START | kraken 13:27:03 INFO - operating with platform_type : linux_ 13:27:03 INFO - Initialising browser for kraken test... 13:27:03 INFO - TEST-INFO | started process 14404 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptbvi58/profile http://localhost:40543/getInfo.html) 13:27:06 INFO - PROCESS | 14404 | JavaScript error: , line 0: uncaught exception: undefined 13:27:07 INFO - PROCESS | 14404 | __metrics Screen width/height:1600/1200 13:27:07 INFO - PROCESS | 14404 | colorDepth:24 13:27:07 INFO - PROCESS | 14404 | Browser inner width/height: 1024/697 13:27:07 INFO - PROCESS | 14404 | __metrics 13:27:08 INFO - PROCESS | 14404 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 13:27:08 INFO - PROCESS | 14404 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 58: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:27:09 INFO - TEST-INFO | 14404: exit 0 13:27:09 INFO - Browser initialized. 13:27:09 INFO - Running cycle 1/1 for kraken test... 13:27:09 INFO - TEST-INFO | started process 14487 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptbvi58/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:27:20 INFO - PROCESS | 14487 | RSS: Main: 157659136 13:27:20 INFO - PROCESS | 14487 | 13:27:23 INFO - PROCESS | 14487 | Cycle 1(1): loaded http://localhost:40543/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40543/tests/kraken/driver.html?testName=audio-beat-detection) 13:27:24 INFO - PROCESS | 14487 | RSS: Main: 213843968 13:27:24 INFO - PROCESS | 14487 | 13:27:26 INFO - PROCESS | 14487 | Cycle 1(1): loaded http://localhost:40543/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40543/tests/kraken/driver.html?testName=audio-dft) 13:27:27 INFO - PROCESS | 14487 | RSS: Main: 192823296 13:27:27 INFO - PROCESS | 14487 | 13:27:30 INFO - PROCESS | 14487 | Cycle 1(1): loaded http://localhost:40543/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40543/tests/kraken/driver.html?testName=audio-fft) 13:27:31 INFO - PROCESS | 14487 | RSS: Main: 270270464 13:27:31 INFO - PROCESS | 14487 | 13:27:33 INFO - PROCESS | 14487 | Cycle 1(1): loaded http://localhost:40543/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40543/tests/kraken/driver.html?testName=audio-oscillator) 13:27:33 INFO - PROCESS | 14487 | RSS: Main: 180760576 13:27:33 INFO - PROCESS | 14487 | 13:27:36 INFO - PROCESS | 14487 | Cycle 1(1): loaded http://localhost:40543/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40543/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:27:36 INFO - PROCESS | 14487 | RSS: Main: 185401344 13:27:36 INFO - PROCESS | 14487 | 13:27:39 INFO - PROCESS | 14487 | Cycle 1(1): loaded http://localhost:40543/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40543/tests/kraken/driver.html?testName=imaging-darkroom) 13:27:40 INFO - PROCESS | 14487 | RSS: Main: 220459008 13:27:40 INFO - PROCESS | 14487 | 13:27:43 INFO - PROCESS | 14487 | Cycle 1(1): loaded http://localhost:40543/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40543/tests/kraken/driver.html?testName=imaging-desaturate) 13:27:44 INFO - PROCESS | 14487 | RSS: Main: 220667904 13:27:44 INFO - PROCESS | 14487 | 13:27:47 INFO - PROCESS | 14487 | Cycle 1(1): loaded http://localhost:40543/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40543/tests/kraken/driver.html?testName=json-parse-financial) 13:27:47 INFO - PROCESS | 14487 | RSS: Main: 220868608 13:27:47 INFO - PROCESS | 14487 | 13:27:49 INFO - PROCESS | 14487 | Cycle 1(1): loaded http://localhost:40543/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40543/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:27:49 INFO - PROCESS | 14487 | RSS: Main: 185376768 13:27:49 INFO - PROCESS | 14487 | 13:27:51 INFO - PROCESS | 14487 | Cycle 1(1): loaded http://localhost:40543/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40543/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:27:52 INFO - PROCESS | 14487 | RSS: Main: 190111744 13:27:52 INFO - PROCESS | 14487 | 13:27:54 INFO - PROCESS | 14487 | Cycle 1(1): loaded http://localhost:40543/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40543/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:27:54 INFO - PROCESS | 14487 | RSS: Main: 195137536 13:27:54 INFO - PROCESS | 14487 | 13:27:57 INFO - PROCESS | 14487 | Cycle 1(1): loaded http://localhost:40543/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40543/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:27:58 INFO - PROCESS | 14487 | RSS: Main: 189083648 13:27:58 INFO - PROCESS | 14487 | 13:28:00 INFO - PROCESS | 14487 | Cycle 1(1): loaded http://localhost:40543/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40543/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:28:01 INFO - PROCESS | 14487 | RSS: Main: 194072576 13:28:01 INFO - PROCESS | 14487 | 13:28:02 INFO - PROCESS | 14487 | Cycle 1(1): loaded http://localhost:40543/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40543/tests/kraken/driver.html?testName=ai-astar) 13:28:03 INFO - PROCESS | 14487 | RSS: Main: 244879360 13:28:03 INFO - PROCESS | 14487 | 13:28:03 INFO - PROCESS | 14487 | __start_tp_report 13:28:03 INFO - PROCESS | 14487 | _x_x_mozilla_page_load 13:28:03 INFO - PROCESS | 14487 | _x_x_mozilla_page_load_details 13:28:03 INFO - PROCESS | 14487 | |i|pagename|runs| 13:28:03 INFO - PROCESS | 14487 | |0;ai-astar;102;114;111;109;112;111;109;110;111;113 13:28:03 INFO - PROCESS | 14487 | |1;audio-beat-detection;150;118;118;182;122;125;143;117;157;116 13:28:03 INFO - PROCESS | 14487 | |2;audio-dft;160;160;161;160;159;159;161;160;161;161 13:28:03 INFO - PROCESS | 14487 | |3;audio-fft;74;74;75;129;75;76;75;74;98;74 13:28:03 INFO - PROCESS | 14487 | |4;audio-oscillator;85;85;113;85;83;85;133;84;85;136 13:28:03 INFO - PROCESS | 14487 | |5;imaging-gaussian-blur;117;116;117;116;117;117;117;117;117;117 13:28:03 INFO - PROCESS | 14487 | |6;imaging-darkroom;145;146;145;146;145;146;145;146;145;146 13:28:03 INFO - PROCESS | 14487 | |7;imaging-desaturate;95;95;95;94;95;94;94;94;94;95 13:28:03 INFO - PROCESS | 14487 | |8;json-parse-financial;55;52;56;53;55;52;62;52;54;52 13:28:03 INFO - PROCESS | 14487 | |9;json-stringify-tinderbox;61;62;62;61;63;62;62;61;62;61 13:28:03 INFO - PROCESS | 14487 | |10;stanford-crypto-aes;75;85;75;75;75;76;76;75;75;84 13:28:03 INFO - PROCESS | 14487 | |11;stanford-crypto-ccm;118;120;119;123;127;120;120;121;164;134 13:28:03 INFO - PROCESS | 14487 | |12;stanford-crypto-pbkdf2;154;153;154;154;151;153;155;155;154;156 13:28:03 INFO - PROCESS | 14487 | |13;stanford-crypto-sha256-iterative;63;64;64;62;62;62;64;63;62;61 13:28:03 INFO - PROCESS | 14487 | __end_tp_report 13:28:03 INFO - PROCESS | 14487 | __start_cc_report 13:28:03 INFO - PROCESS | 14487 | _x_x_mozilla_cycle_collect,1676 13:28:03 INFO - PROCESS | 14487 | __end_cc_report 13:28:03 INFO - PROCESS | 14487 | __startTimestamp1469132883208__endTimestamp 13:28:03 INFO - PROCESS | 14487 | 13:28:03 INFO - PROCESS | 14487 | ------- Summary: start ------- 13:28:03 INFO - PROCESS | 14487 | Number of tests: 14 13:28:03 INFO - PROCESS | 14487 | 13:28:03 INFO - PROCESS | 14487 | [#0] ai-astar Cycles:10 Average:110.20 Median:111.00 stddev:3.29 (3.0%) stddev-sans-first:1.69 13:28:03 INFO - PROCESS | 14487 | Values: 102.0 114.0 111.0 109.0 112.0 111.0 109.0 110.0 111.0 113.0 13:28:03 INFO - PROCESS | 14487 | 13:28:03 INFO - PROCESS | 14487 | [#1] audio-beat-detection Cycles:10 Average:134.80 Median:134.00 stddev:22.39 (16.7%) stddev-sans-first:23.07 13:28:03 INFO - PROCESS | 14487 | Values: 150.0 118.0 118.0 182.0 122.0 125.0 143.0 117.0 157.0 116.0 13:28:03 INFO - PROCESS | 14487 | 13:28:03 INFO - PROCESS | 14487 | [#2] audio-dft Cycles:10 Average:160.20 Median:160.50 stddev:0.79 (0.5%) stddev-sans-first:0.83 13:28:03 INFO - PROCESS | 14487 | Values: 160.0 160.0 161.0 160.0 159.0 159.0 161.0 160.0 161.0 161.0 13:28:03 INFO - PROCESS | 14487 | 13:28:03 INFO - PROCESS | 14487 | [#3] audio-fft Cycles:10 Average:82.40 Median:75.00 stddev:17.96 (23.9%) stddev-sans-first:18.79 13:28:03 INFO - PROCESS | 14487 | Values: 74.0 74.0 75.0 129.0 75.0 76.0 75.0 74.0 98.0 74.0 13:28:03 INFO - PROCESS | 14487 | 13:28:03 INFO - PROCESS | 14487 | [#4] audio-oscillator Cycles:10 Average:97.40 Median:85.00 stddev:21.49 (25.3%) stddev-sans-first:22.32 13:28:03 INFO - PROCESS | 14487 | Values: 85.0 85.0 113.0 85.0 83.0 85.0 133.0 84.0 85.0 136.0 13:28:03 INFO - PROCESS | 14487 | 13:28:03 INFO - PROCESS | 14487 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 13:28:03 INFO - PROCESS | 14487 | Values: 117.0 116.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 13:28:03 INFO - PROCESS | 14487 | 13:28:03 INFO - PROCESS | 14487 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:146.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 13:28:03 INFO - PROCESS | 14487 | Values: 145.0 146.0 145.0 146.0 145.0 146.0 145.0 146.0 145.0 146.0 13:28:03 INFO - PROCESS | 14487 | 13:28:03 INFO - PROCESS | 14487 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:95.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 13:28:03 INFO - PROCESS | 14487 | Values: 95.0 95.0 95.0 94.0 95.0 94.0 94.0 94.0 94.0 95.0 13:28:03 INFO - PROCESS | 14487 | 13:28:03 INFO - PROCESS | 14487 | [#8] json-parse-financial Cycles:10 Average:54.30 Median:54.50 stddev:3.09 (5.7%) stddev-sans-first:3.27 13:28:03 INFO - PROCESS | 14487 | Values: 55.0 52.0 56.0 53.0 55.0 52.0 62.0 52.0 54.0 52.0 13:28:03 INFO - PROCESS | 14487 | 13:28:03 INFO - PROCESS | 14487 | [#9] json-stringify-tinderbox Cycles:10 Average:61.70 Median:62.00 stddev:0.67 (1.1%) stddev-sans-first:0.67 13:28:03 INFO - PROCESS | 14487 | Values: 61.0 62.0 62.0 61.0 63.0 62.0 62.0 61.0 62.0 61.0 13:28:03 INFO - PROCESS | 14487 | 13:28:03 INFO - PROCESS | 14487 | [#10] stanford-crypto-aes Cycles:10 Average:77.10 Median:75.50 stddev:3.93 (5.2%) stddev-sans-first:4.09 13:28:03 INFO - PROCESS | 14487 | Values: 75.0 85.0 75.0 75.0 75.0 76.0 76.0 75.0 75.0 84.0 13:28:03 INFO - PROCESS | 14487 | 13:28:03 INFO - PROCESS | 14487 | [#11] stanford-crypto-ccm Cycles:10 Average:126.60 Median:122.00 stddev:13.99 (11.5%) stddev-sans-first:14.48 13:28:03 INFO - PROCESS | 14487 | Values: 118.0 120.0 119.0 123.0 127.0 120.0 120.0 121.0 164.0 134.0 13:28:03 INFO - PROCESS | 14487 | 13:28:03 INFO - PROCESS | 14487 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.90 Median:154.00 stddev:1.37 (0.9%) stddev-sans-first:1.45 13:28:03 INFO - PROCESS | 14487 | Values: 154.0 153.0 154.0 154.0 151.0 153.0 155.0 155.0 154.0 156.0 13:28:03 INFO - PROCESS | 14487 | 13:28:03 INFO - PROCESS | 14487 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.70 Median:63.00 stddev:1.06 (1.7%) stddev-sans-first:1.12 13:28:03 INFO - PROCESS | 14487 | Values: 63.0 64.0 64.0 62.0 62.0 62.0 64.0 63.0 62.0 61.0 13:28:03 INFO - PROCESS | 14487 | -------- Summary: end -------- 13:28:03 INFO - PROCESS | 14487 | 13:28:04 INFO - TEST-INFO | 14487: exit 0 13:28:04 INFO - TEST-OK | kraken | took 60611ms 13:28:04 INFO - SUITE-END | took 1174s 13:28:04 INFO - Completed test suite (00:19:34) 13:28:04 INFO - javascript benchmark 13:28:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3061.372418654175, 3071.5239137933618, 3082.090783218951, 3109.549115378272, 3113.859876305566, 5319.228711836791, 5371.382291036532, 5395.514403703666, 5458.0, 5469.863253418666, 5359.517643412092, 5424.945750542493, 5434.538064264532, 5478.890422191564, 5566.332040155177, 4809.4469136049365, 4892.755362231892, 4901.191303434929, 4903.82836600719, 5047.67190132642, 4976.900461990758, 5005.199168133099, 5026.4219614744225, 5035.269885866547, 5038.042771873351, 4798.568128868401, 4804.279358096313, 4841.661083724141, 4842.2736589511505, 5003.249512573107, 4885.413750349945, 4895.755212239374, 4898.583620392271, 4946.777395017233, 4965.652404331699, 4867.17258066126, 4907.533784290523, 4941.579965702919, 4946.186172413644, 4976.253561965698, 5160.92258616121, 5309.283246761715, 5406.621536492447, 5446.8910621787345, 5454.154606036071, 5792.420757924216, 5855.268091488564, 5899.115132730082, 5906.822795316104, 5909.852253693649, 5828.912566311508, 5924.881502369972, 5944.64332140073, 5948.73230704615, 5949.345571987078, 5239.921401178985, 5346.385165705916, 5450.5367043801725, 5523.199136125279, 5527.695976721278, 6042.063480160582, 6071.51427885768, 6071.574989750763, 6074.058520929263, 6075.665838378932, 5813.476787089182, 5817.563682723812, 5819.912701309484, 5824.941750582525, 5829.912551311733, 5605.971970140124, 5743.396943320975, 5801.477866991991, 5918.822435326861, 5921.851953701106, 5807.390224026501, 5812.59311848175, 5812.912806307909, 5842.269716285465, 5868.295804503487, 5759.596828221985, 5799.942000580025, 5814.709264536757, 5816.243888294494, 5818.709064546841, 4337.544557821383, 4356.869293921124, 4393.406890069799, 4395.099004704028, 4475.619572336323, 3933.803309834554, 3941.8620348288246, 3965.980170099131, 3988.780617066031, 4020.8592699255387, 5514.503694667499, 5517.2551705520045, 5519.199716041152, 5522.9447705523235, 5523.1991361253195, 5652.265205523256, 5790.36306006339, 5837.211976383219, 5838.5329173666005, 5884.676342801102, 5460.180972854104, 5499.972500137554, 5507.284053073075, 5535.944640553624, 5558.666480011212, 5050.4697006814495, 5054.595632349403, 5057.570106540985, 5060.316857224301, 5103.055934652101, 5900.055991041499, 5916.1421593868645, 5979.372165922602, 6043.033114701627, 6046.3349031606485, 5752.395998420273, 5780.3930587289415, 5787.247657804627, 5797.76808927655, 5803.82588522345, 5941.435563621449, 5953.404659534185, 5958.404159584007, 5964.97017514927, 5969.940300596939, 5568.888622227451, 5620.213170156263, 5648.830535083954, 5696.743646535999, 5699.287589051369, 5744.167095771173, 5819.388964158872, 5821.650700957786, 5857.47282744555, 5860.589758716849, 5605.691686957257, 5607.467290607386, 5632.436756324335, 5655.377908430151, 5668.659880407189, 5443.374011988672, 5544.889102218014, 5629.380768115586, 5633.408492108433, 5633.887322253614, 5564.4991950724625, 5644.0687286598895, 5645.68948707825, 5691.26013618227, 5698.8290351289525, 5644.2380278663495, 5676.290463692038, 5710.0, 5719.3136823581435, 5730.312362516524, 5441.483059109379, 5441.727913604224, 5534.391216966211, 5541.944580554304, 5546.362168350692], "value": 5349.40056982524, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [602.9306629737579, 608.2154021312506, 615.3538784276506, 628.7987843889954, 638.1863124516244, 45114.54885451144, 46640.533594664084, 46788.0, 46894.296585551245, 49563.75218123904, 45406.318905216445, 45649.77175114128, 45728.51257849055, 45778.31332530015, 45859.0, 8945.418547794405, 9071.682491112811, 9077.68228112013, 9086.409383390092, 9086.545672716371, 8893.066228046058, 8977.0, 8978.50618215998, 8981.595828187714, 8993.14565116313, 9032.548372581377, 9045.185933266004, 9070.0, 9077.863832042525, 9078.954605226965, 8977.506237156953, 8991.145841145113, 9012.504312262823, 9018.053104424072, 9021.548922553879, 8939.821203575892, 8967.641294348283, 8999.23506501948, 9005.954970225172, 9016.0, 41373.79313103445, 41630.79184604088, 41811.372829407585, 42027.579724202675, 42047.57952420498, 3260.3479304139028, 3345.96654033459, 3351.7821341612716, 3437.0, 3445.6554344565593, 31563.0, 34111.658883411095, 34470.31059378798, 34545.48181777275, 34548.481772773426, 4337.71804832688, 4394.604485596312, 4395.846145384929, 4496.1077948825505, 4579.22153233951, 380869.0, 383219.0, 383721.0, 384274.0, 386549.0, 62022.37977620166, 62308.68845655743, 62387.37612623816, 62426.37573624297, 62488.0, 66078.66960665166, 66508.66745666241, 66587.66706166536, 66621.0, 66677.66661166663, 16706.665866682597, 17052.658946820993, 17056.403025894033, 17056.744148837777, 17059.914700426667, 12862.614121576367, 12906.290154041619, 12914.67713307156, 12940.741185176244, 12953.676158095934, 18185.11778929868, 19709.408717738203, 19819.702704459443, 19826.702599460732, 19991.0, 7224.891626625605, 7236.421086313082, 7367.8158046049275, 7390.593517356597, 7400.222976587488, 1012.5747186181821, 1012.8581998520214, 1035.1304903880625, 1129.7909886670993, 1149.431031639344, 33016.83491582527, 33441.69077371212, 33610.327793444, 33808.830955845064, 33903.15242118967, 928.4243768863348, 1100.5212732461246, 1119.082352470966, 1188.9286642801287, 1223.6818427208989, 16908.66182676364, 17059.0, 17088.0, 17423.65152696939, 18186.36347727823, 602454.0, 610259.0, 611398.0, 612183.0, 613517.0, 62833.68583157055, 63555.36444635494, 63567.36432635707, 63646.68176659087, 63650.681746591894, 1225.08730995409, 1325.516186591887, 1366.1939455720974, 1379.1449301433177, 1384.5707830572555, 30681.471630761855, 34230.82884585561, 34405.0, 34660.30679386449, 34954.12614684653, 51840.0, 52554.73722631362, 52637.47362526326, 52652.47347526476, 52752.47247527476, 336309.0, 338957.0, 339010.5742069305, 339272.0, 339648.0, 28478.145655630364, 28592.42815143727, 28748.281292967844, 29369.55945660774, 29455.26361840971, 50185.24722129244, 50197.74901125471, 50418.747906260236, 50607.49392506175, 50665.74667126641, 41074.794626026676, 41521.584784151775, 42882.35676464918, 43256.0, 44455.0, 41897.162056759305, 41945.37081943834, 42697.35953960631, 43286.35070473883, 44308.33537497005, 41135.7943210282, 41803.7909810449, 42582.14835703331, 42662.78668606637, 42692.359614605186, 35505.0, 37298.81350593338, 38086.666966656034, 38503.61496385113, 38634.42048369221, 27947.86026069938, 28099.0, 28130.156095317172, 28296.858515708114, 28415.289617758895], "value": 20640.31545660936, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [374.1880120139297, 393.4511356657463, 407.2283023670144, 410.46024477811676, 414.31844615607326, 14065.859341406584, 18071.45785626432, 18972.715409268836, 19344.516387090312, 19429.611407771838, 18251.0, 18560.90719546404, 18802.0, 18896.905515472437, 19121.52196195096, 5648.802291919784, 5709.343425506078, 5782.392848750884, 5827.912581311284, 5831.533477321804, 5636.210930469717, 5696.287964004499, 5747.281589801254, 5755.338136114358, 5756.769729210827, 5675.1203563447525, 5678.829635110933, 5729.341125770548, 5729.369769325371, 5778.6243894146955, 5592.5246354059955, 5746.9712651436475, 5754.625949313302, 5758.222639943596, 5771.105478650816, 5016.598672106259, 5041.798328066873, 5056.494350564951, 5096.923546146811, 5145.253938178943, 22705.545889082292, 22956.54086918269, 23006.654900176512, 23055.884720576458, 23109.422264443525, 2426.9150579729803, 2438.67077944477, 2573.6268241104935, 2738.411241583049, 2957.1719918422878, 14312.21282829444, 14388.208648524327, 14494.275286235752, 14495.347709352998, 14527.927360363235, 1892.1579896945864, 1921.0874834453523, 1977.574821413403, 1993.3720877923552, 2038.551518665891, 84121.57939210265, 85467.57266213628, 86630.56684716536, 87007.0, 87140.99999999936, 9092.363534552518, 9760.658376956773, 9818.165455936325, 10322.142014437473, 10671.89328106709, 13096.279704616338, 13143.0, 13152.539661111816, 13158.0, 13170.143940643828, 7783.494072885244, 7830.334421574116, 7976.162502937224, 8081.313088387553, 8122.593870306461, 7645.0, 7684.731034413769, 7762.7671169865, 7783.260590243918, 8193.426460147732, 3957.584453632385, 4033.9394909076386, 4058.5738497457933, 4126.525449573338, 4147.0, 1941.223510595773, 1943.3684052682934, 1943.426689126711, 1958.8687408411581, 1991.422487478615, 875.6366108065209, 969.9951500242595, 1005.9094681478556, 1056.3820165203442, 1114.2868564118971, 18344.357947471774, 18789.154488048072, 19323.130459129374, 19432.80567194338, 20007.59984800296, 972.2027937091517, 977.5014742481386, 1003.3428104591504, 1014.9543270552695, 1054.9789004219872, 10313.742156445998, 10843.83734243987, 10848.240623156304, 10872.0, 10872.836907446395, 433299.0, 478697.0, 506588.0, 527614.0, 527813.0, 94392.52803736075, 96113.0, 96160.0, 96205.5189724047, 96608.0339196613, 958.3770549142973, 982.0425085541683, 989.8515222716507, 994.8507723841337, 1003.9247056470648, 16510.587235319214, 16592.917035414746, 16687.198567588115, 17282.65434691274, 17744.822551774832, 39265.411018834166, 40943.38584921288, 42952.0, 44050.559494404646, 45701.0, 53971.46028539664, 60751.392486074576, 61659.38340616716, 62627.37372626215, 63280.73438531296, 8448.915510844812, 8464.830703385775, 8510.31917446615, 8560.400771946153, 8740.73777786642, 11739.941300293443, 12884.742305153657, 13098.083134180515, 13482.597475064566, 14067.929660352042, 10988.945055274993, 11256.21206515536, 11910.702232444259, 11957.701057473632, 12002.279863208236, 11432.371219583003, 11503.654890353302, 11820.349880756641, 11832.822507662564, 11837.408129593658, 11885.28688278706, 12075.939620301842, 12150.08874334446, 12209.69475763113, 12490.063245256824, 8097.959510202411, 8159.673613055411, 8290.29532489721, 8303.709370172015, 8356.122607126408, 9279.536023198949, 11516.884831151581, 11524.481398337262, 11578.478968446609, 11676.182667213554], "value": 9204.173958073272, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1332.780091284938, 1475.6384685751989, 1513.8334783173848, 1646.1357787161746, 1777.5200695812132, 8680.175383338581, 9036.548172591369, 9141.680041198568, 9316.208122309596, 9355.06449355064, 9261.212796912254, 9326.90673093269, 9327.207187389064, 9330.580123894424, 9370.0, 2372.845765025272, 2407.939801504968, 2408.048820715825, 2409.265174121892, 2412.4089598048504, 2312.9537409251807, 2369.3721163891582, 2388.6178211486167, 2393.688820453339, 2396.25716028031, 2320.060375547906, 2321.3036089173265, 2332.5801355755957, 2362.208660098869, 2367.2779802160335, 2246.9888550152414, 2249.2127755285683, 2255.842091053627, 2282.942926426844, 2313.8611683298886, 2274.4882401459704, 2274.6701728249477, 2275.4311422144465, 2279.065583110933, 2283.337832028726, 9073.954630226872, 9146.725598231997, 9227.307951903567, 9293.442393456347, 9313.161815436642, 5286.392064912546, 5483.259759932398, 5486.478784515504, 5488.17677348397, 5488.670679759187, 3446.4657978013447, 3450.46517789743, 3514.2620049789575, 3514.6661067198575, 3516.033090899997, 1194.8088305871106, 1204.9759004819941, 1222.6576558563615, 1228.5854865884435, 1253.8056601226824, 12955.48178072876, 13003.869961300456, 13059.542915997894, 13065.738685226243, 13066.673333166651, 4368.104538569649, 4613.792379342937, 4669.0428462165855, 4688.367070445446, 4716.95283047172, 10206.4386458744, 10238.18094552434, 10238.744031399126, 10248.282620216662, 10255.07704306601, 5381.704006279614, 5406.54044406222, 5417.83746487606, 5418.864528386822, 5421.0, 4091.734037287567, 4405.647548196201, 4541.455025396974, 4982.950170498321, 5052.671576347526, 3854.4411060396087, 3967.583403742623, 3997.600239975979, 4004.199160167978, 4066.044479547304, 1130.5647325779469, 1174.1428757007432, 1179.5281887245171, 1181.639599922032, 1188.2751521572006, 854.9700760473478, 929.0848514213494, 929.6746138851348, 944.9527523623791, 952.0812416018575, 5988.221531200916, 5995.610285331527, 6055.757769689251, 6061.6666083365835, 6076.574639775174, 447.5278581096909, 449.64478062331045, 461.2251417618433, 464.66311923854937, 474.1347041649004, 3947.921041579152, 4054.3310353791885, 4071.1654110907193, 4092.529359123679, 4094.931099194369, 11340.149488788375, 11691.123165762601, 11770.234934729215, 11801.114916381306, 11827.17209795306, 11578.76842463146, 11583.594574190032, 11598.94200528992, 11652.825207621892, 11660.0, 8659.177378149066, 8705.347098967603, 8707.956460217658, 8720.520371379635, 8753.824923501494, 5673.319201695823, 5680.40355762639, 5793.565482588739, 5841.357450680337, 5916.556258280732, 10338.483075846329, 10525.526351314056, 10531.368117912949, 10556.049955504042, 10634.0, 9666.709998700051, 10932.289401188897, 10937.179711521827, 10966.670999870017, 10981.066609337977, 7468.365188958782, 7638.923610763822, 7731.226877312224, 7906.407019473448, 7910.644021019183, 8529.530875801891, 8906.287497000354, 8947.865782013405, 8970.820583588162, 8975.506347150707, 7847.725329613436, 8166.183381661786, 8190.50856948585, 8221.136780637948, 8335.0, 7964.721234756756, 8119.18808119207, 8120.431569790058, 8169.101398846241, 8330.583470826556, 7339.669714862951, 7464.850702986018, 7471.290227428385, 7473.43949203801, 7476.813079673052, 5268.1834315681135, 5311.0, 5313.415524292402, 5336.359636843604, 5503.944960550343, 5354.892902142014, 5363.2759577456545, 5393.325834270716, 5435.945640543702, 5678.0], "value": 4653.021571881176, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [329.1475079543979, 332.84023668639054, 338.1816005267254, 341.12331308537057, 342.07127648434493, 5239.397469291032, 5255.76349064292, 5281.867953301169, 5304.01875653004, 5312.548433383157, 4924.950750492503, 5029.270755740425, 5181.35233095863, 5217.713025783581, 5225.817096401626, 4134.0, 4151.418801367811, 4162.354835000579, 4187.623113919746, 4205.13794672093, 4123.958760412403, 4163.438710483569, 4186.769727664977, 4192.5597812229735, 4196.790160491979, 3942.349512330462, 3961.722679412442, 4114.917701645965, 4125.669946404296, 4166.500019997605, 4111.424400583921, 4112.259793237216, 4113.4035564843225, 4145.357469592218, 4149.730267532631, 3666.944995825065, 3673.2837096765875, 3675.5405574303213, 3678.5953545110015, 3684.6499582539614, 5030.597552195815, 5071.695698258116, 5115.641905066647, 5125.256837758541, 5157.432682404932, 4687.507811679793, 4692.436907571079, 4694.929576056362, 4695.272232803921, 4703.600193983515, 5388.655934668393, 5391.460853914617, 5407.756650950717, 5416.8104116356135, 5467.644603100785, 3748.6063963283736, 3951.7826519541413, 4019.733783858075, 4025.295573274665, 4034.11249525104, 5633.352164501094, 5657.6322539035245, 5663.093904975225, 5663.858403539944, 5664.376918538957, 4052.4124002019544, 4065.634092931591, 4066.430699702044, 4082.183563287295, 4083.4686992377265, 3922.6861851052417, 4116.567760385176, 4130.215259100762, 4138.0689344897155, 4146.1914926589625, 4651.930221046687, 4652.185867473178, 4660.370849935215, 4661.184292748755, 4675.4155730533685, 5454.181872719124, 5482.698451585121, 5487.38122253936, 5518.586106042063, 5573.637713548606, 1351.5269655620455, 1407.7677183264852, 1428.6214153249398, 1430.3348942741468, 1431.2128329418779, 904.4889637354873, 925.4863550729275, 931.1340453378288, 933.3140141995627, 935.7274107214183, 4722.1972264714395, 4763.285507173951, 4765.618750499952, 4785.210440277316, 4816.0, 4604.493505714368, 4974.90050198994, 4990.8253211137435, 5003.674761140514, 5011.298418221452, 4651.0, 4659.883502912454, 4722.315264286659, 4769.712177712067, 4807.399075115611, 2672.835003647052, 2676.866156692158, 2678.906238281651, 2685.516607010718, 2690.0584795321874, 5119.436861945183, 5160.5550445875215, 5393.6763794172475, 5860.882782344329, 5883.17635531026, 5737.971310143506, 5758.222639943638, 5759.481646651821, 5786.739596718074, 5796.971015144897, 5660.745266462936, 5785.8553536161935, 5849.61977471463, 5852.824415267549, 5895.852603684856, 5579.7489112990825, 5632.225848857597, 5634.464725851038, 5641.238432811518, 5660.575456840671, 5611.466910643482, 5613.887722245614, 5629.240052592848, 5639.436056394327, 5649.943500564942, 5643.492085712305, 5786.971065144648, 5789.594728368974, 5802.0119638387105, 5877.23595932526, 4053.858114965962, 4060.16766562848, 4060.715749897479, 4067.349224124126, 4073.938890916579, 5482.342118945592, 5528.51216952381, 5596.300462442195, 5611.747471363717, 5722.284714410699, 5495.780168793203, 5507.284053073075, 5515.124857548452, 5519.972400137974, 5520.36515800672, 5280.7359632019015, 5497.175423686479, 5547.4175211603815, 5590.133529302964, 5592.748326325243, 5438.15708565173, 5472.480114389126, 5472.589555783253, 5477.808276710455, 5508.3114610673665, 5497.285352904097, 5569.5519165018195, 5604.710916489149, 5616.185653080199, 5631.1271752878365, 5189.221616757516, 5333.653312534673, 5389.56883449331, 5473.397926228032, 5481.054225749802], "value": 4150.558310896444, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [811.1645005644186, 840.134661298862, 841.0345222276962, 861.1904809479086, 868.4875923205308, 15454.459093931715, 16670.583235419104, 16702.665946681074, 16712.58218544537, 16734.74897876533, 15120.168390738505, 15227.543173704778, 15231.84768152318, 15248.618784530392, 15270.0, 662.4931927075767, 787.3189690917372, 792.5324058805304, 803.6463955859432, 808.6805711743872, 802.9839403211932, 819.3117781063905, 820.1839170025833, 820.2904487618227, 821.1172989036779, 859.3898332184157, 863.4775960543875, 864.2869632553137, 864.9870251946226, 865.1867244789877, 694.1773997812583, 833.5415521463171, 840.9369297302727, 854.2055888024136, 864.1660797330575, 626.2266101364811, 629.7481007596953, 630.8864404407204, 630.9621422714606, 631.1195881744986, 14977.475788347465, 15045.548633541011, 15098.16960067196, 15145.772813407697, 15153.696926061528, 13821.0, 13903.86096139046, 13915.98218258357, 13990.230537320444, 14125.788113178207, 13079.580277648665, 13177.868221317856, 13210.471581136839, 13241.271730054843, 13718.725625487534, 4415.646748260131, 4427.911441771146, 4437.0682156747125, 4632.490426053131, 4663.114008338405, 75989.0, 76020.0, 79489.20510794876, 80227.59886200531, 82269.0, 11498.482568284448, 11571.710707232387, 11603.245789023686, 11679.357635330138, 11954.940225298991, 21557.0, 21590.892045539673, 21607.02768375427, 21638.675419868716, 21667.891660541598, 8647.221750042527, 8752.431091979, 8794.692185773467, 8916.484757056995, 9061.275097992146, 4707.058588282357, 4709.693869898446, 4921.926171107436, 4927.704337739747, 4989.950100498949, 3648.7628304160144, 3753.60587138352, 3757.229767897574, 3758.6805121564425, 3763.473113764075, 636.78667646339, 647.0488382078337, 651.4299987510927, 655.9409653131241, 657.1883723601348, 671.4762485261504, 705.4708968273794, 723.8950352198901, 725.419664268583, 736.5309392760053, 9084.591193396313, 9849.803003939882, 10021.348612340174, 10188.0, 10194.184465242912, 572.9341125770507, 617.8146556033172, 680.0581195044898, 688.61437594947, 696.5054811084086, 4474.619657329164, 4685.4143232095985, 4710.9764451177525, 4713.31656909753, 4781.0, 67194.0, 83172.58413707893, 88842.55578722066, 113269.0, 117925.0, 95946.0, 99003.0, 101483.0, 102180.48909755403, 108621.37067943987, 83560.0, 85330.57334713411, 87008.0, 87379.56310218408, 89896.0, 9215.953920230357, 9242.306826987868, 9379.671711490339, 9428.764280893032, 9491.905080949102, 46648.0, 52651.0, 53793.46206538041, 53928.0, 55423.16865247105, 83206.0, 83563.0, 83631.16368836477, 84301.0, 85255.0, 11940.820887686517, 12005.879941200825, 12099.697507562381, 12480.313582753035, 12634.873651263737, 12984.285864277555, 13038.608841734764, 13106.934465327613, 13169.868301316865, 13737.450501979809, 12134.817977730518, 12585.874141258837, 12682.936585317015, 12864.871351286367, 12896.29070401137, 12067.879321207027, 12556.748865022832, 12612.180208286432, 12723.745525089262, 13109.60671179866, 11988.64034078979, 11995.460204291003, 12440.253584784941, 12477.438515266653, 12513.499460021862, 10553.366797992145, 10834.404107774148, 11056.778864422828, 11080.889191107986, 11206.775864482828, 9510.85733713981, 9758.560864761244, 9822.65620703272, 10505.31715438494, 10558.260921735406], "value": 7545.328250620748, "unit": "score"}], "name": "dromaeo_css", "value": 7273.812693224738, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 114.0, 111.0, 109.0, 112.0, 111.0, 109.0, 110.0, 111.0, 113.0], "value": 110.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 118.0, 118.0, 182.0, 122.0, 125.0, 143.0, 117.0, 157.0, 116.0], "value": 134.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 161.0, 160.0, 159.0, 159.0, 161.0, 160.0, 161.0, 161.0], "value": 160.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 75.0, 129.0, 75.0, 76.0, 75.0, 74.0, 98.0, 74.0], "value": 82.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 113.0, 85.0, 83.0, 85.0, 133.0, 84.0, 85.0, 136.0], "value": 97.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 145.0, 146.0, 145.0, 146.0, 145.0, 146.0, 145.0, 146.0], "value": 145.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 94.0, 95.0, 94.0, 94.0, 94.0, 94.0, 95.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 52.0, 56.0, 53.0, 55.0, 52.0, 62.0, 52.0, 54.0, 52.0], "value": 54.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 62.0, 61.0, 63.0, 62.0, 62.0, 61.0, 62.0, 61.0], "value": 61.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 85.0, 75.0, 75.0, 75.0, 76.0, 76.0, 75.0, 75.0, 84.0], "value": 77.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 120.0, 119.0, 123.0, 127.0, 120.0, 120.0, 121.0, 164.0, 134.0], "value": 126.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 153.0, 154.0, 154.0, 151.0, 153.0, 155.0, 155.0, 154.0, 156.0], "value": 153.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 64.0, 62.0, 62.0, 62.0, 64.0, 63.0, 62.0, 61.0], "value": 62.7, "unit": "score"}], "name": "kraken", "value": 1478.1, "alertThreshold": 2.0}]} 13:28:04 INFO - Return code: 0 13:28:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:28:04 INFO - # TBPL SUCCESS # 13:28:04 INFO - Running post-action listener: _resource_record_post_action 13:28:04 INFO - [mozharness: 2016-07-21 20:28:04.495145Z] Finished run-tests step (success) 13:28:04 INFO - Running post-run listener: _resource_record_post_run 13:28:04 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 0; Write bytes: 566353920; Read time: 0; Write time: 527952 13:28:04 INFO - TinderboxPrint: CPU usage
13.0% 13:28:04 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 13:28:04 INFO - TinderboxPrint: I/O write bytes / time
566,353,920 / 527,952 13:28:04 INFO - TinderboxPrint: CPU idle
8,273.8 (87.0%) 13:28:04 INFO - TinderboxPrint: CPU user
1,195.6 (12.6%) 13:28:04 INFO - TinderboxPrint: Swap in / out
0 / 0 13:28:04 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 0; Write bytes: 272084992; Read time: 0; Write time: 265428 13:28:04 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 294268928; Read time: 0; Write time: 262524 13:28:05 INFO - Running post-run listener: _upload_blobber_files 13:28:05 INFO - Blob upload gear active. 13:28:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:28:05 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 13:28:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:28:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:28:05 INFO - (blobuploader) - INFO - Open directory for files ... 13:28:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:28:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:28:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:28:19 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:28:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:28:19 INFO - (blobuploader) - INFO - Done attempting. 13:28:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:28:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:28:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:28:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:28:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:28:20 INFO - (blobuploader) - INFO - Done attempting. 13:28:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:28:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:28:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:28:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:28:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:28:21 INFO - (blobuploader) - INFO - Done attempting. 13:28:21 INFO - (blobuploader) - INFO - Iteration through files over. 13:28:21 INFO - Return code: 0 13:28:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:28:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:28:21 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8d500794cd512c522f3cee965dedb15c017b31e9730bee1884eb2bfa4dedcbe96da912d0075f28a36d463744a3a5734bac5b8c97cfdb4f9cd806db7349262b27", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6bbecf57c442ec01bbe9f50b2ba9a7deedfd3b0ccaf00d8fa8de4210933d19dec5a93345b7b10f1ce1c46ac8fa47716bc3f316766f577dc0b737dc7af58b731c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6022071452891dd7715a7346d490cd339070d18c012f7e117d30474c0c844b720477197b3af2d681018023835f36399dc255061375bc93ae574bc6ce83f317ad"} 13:28:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:28:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:28:21 INFO - Contents: 13:28:21 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8d500794cd512c522f3cee965dedb15c017b31e9730bee1884eb2bfa4dedcbe96da912d0075f28a36d463744a3a5734bac5b8c97cfdb4f9cd806db7349262b27", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6bbecf57c442ec01bbe9f50b2ba9a7deedfd3b0ccaf00d8fa8de4210933d19dec5a93345b7b10f1ce1c46ac8fa47716bc3f316766f577dc0b737dc7af58b731c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6022071452891dd7715a7346d490cd339070d18c012f7e117d30474c0c844b720477197b3af2d681018023835f36399dc255061375bc93ae574bc6ce83f317ad"} 13:28:21 INFO - Running post-run listener: copy_logs_to_upload_dir 13:28:21 INFO - Copying logs to upload dir... 13:28:21 INFO - mkdir: /builds/slave/test/build/upload/logs 13:28:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.052136 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-07-21 13:28:20.088863) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-21 13:28:20.092820) ========= 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=3a3620fb28aea1604ab609ef000001d2-1469131657.602276-1239246029 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/8d500794cd512c522f3cee965dedb15c017b31e9730bee1884eb2bfa4dedcbe96da912d0075f28a36d463744a3a5734bac5b8c97cfdb4f9cd806db7349262b27", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6bbecf57c442ec01bbe9f50b2ba9a7deedfd3b0ccaf00d8fa8de4210933d19dec5a93345b7b10f1ce1c46ac8fa47716bc3f316766f577dc0b737dc7af58b731c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6022071452891dd7715a7346d490cd339070d18c012f7e117d30474c0c844b720477197b3af2d681018023835f36399dc255061375bc93ae574bc6ce83f317ad"} build_url:https://queue.taskcluster.net/v1/task/aCafWlUuSdixsZLCLGTS9Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011393 build_url: 'https://queue.taskcluster.net/v1/task/aCafWlUuSdixsZLCLGTS9Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8d500794cd512c522f3cee965dedb15c017b31e9730bee1884eb2bfa4dedcbe96da912d0075f28a36d463744a3a5734bac5b8c97cfdb4f9cd806db7349262b27", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6bbecf57c442ec01bbe9f50b2ba9a7deedfd3b0ccaf00d8fa8de4210933d19dec5a93345b7b10f1ce1c46ac8fa47716bc3f316766f577dc0b737dc7af58b731c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6022071452891dd7715a7346d490cd339070d18c012f7e117d30474c0c844b720477197b3af2d681018023835f36399dc255061375bc93ae574bc6ce83f317ad"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-21 13:28:20.118575) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 13:28:20.118909) ========= 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=3a3620fb28aea1604ab609ef000001d2-1469131657.602276-1239246029 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004534 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 13:28:20.202414) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-21 13:28:20.202773) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-21 13:28:20.203159) ========= ========= Total master_lag: 0.16 =========