builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-020 starttime: 1470809769.96 results: success (0) buildid: 20160809203014 builduid: 2d030529ccfd4ee8871c9efb91c2ba63 revision: d8d09f4544be39ec9c880c7e006b281251c8a60e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-09 23:16:09.960921) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-09 23:16:09.961335) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-09 23:16:09.961603) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-09 23:16:09.994641) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 23:16:09.994904) ========= 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=af724c981e2a0f424dbabf99000001e7-1470809129.142214-1583716776 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-09 23:16:09-- 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% 38.0M=0s 2016-08-09 23:16:10 (38.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.117476 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 23:16:10.129989) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 23:16:10.130287) ========= 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=af724c981e2a0f424dbabf99000001e7-1470809129.142214-1583716776 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020276 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 23:16:10.183090) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-09 23:16:10.183430) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev d8d09f4544be39ec9c880c7e006b281251c8a60e --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 d8d09f4544be39ec9c880c7e006b281251c8a60e --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=af724c981e2a0f424dbabf99000001e7-1470809129.142214-1583716776 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-09 23:16:10,220 truncating revision to first 12 chars 2016-08-09 23:16:10,220 Setting DEBUG logging. 2016-08-09 23:16:10,220 attempt 1/10 2016-08-09 23:16:10,220 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/d8d09f4544be?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-09 23:16:11,632 unpacking tar archive at: fx-team-d8d09f4544be/testing/mozharness/ program finished with exit code 0 elapsedTime=1.752189 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-09 23:16:11.949502) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-09 23:16:11.949794) ========= script_repo_revision: d8d09f4544be39ec9c880c7e006b281251c8a60e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-09 23:16:11.950148) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-09 23:16:11.950419) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-09 23:16:11.961740) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-08-09 23:16:11.962004) ========= /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=af724c981e2a0f424dbabf99000001e7-1470809129.142214-1583716776 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:16:12 INFO - MultiFileLogger online at 20160809 23:16:12 in /builds/slave/test 23:16:12 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 23:16:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:16:12 INFO - {'append_to_log': False, 23:16:12 INFO - 'base_work_dir': '/builds/slave/test', 23:16:12 INFO - 'blob_upload_branch': 'Fx-Team', 23:16:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:16:12 INFO - 'branch': 'Fx-Team', 23:16:12 INFO - 'buildbot_json_path': 'buildprops.json', 23:16:12 INFO - 'config_files': ('talos/linux_config.py',), 23:16:12 INFO - 'default_actions': ('clobber', 23:16:12 INFO - 'read-buildbot-config', 23:16:12 INFO - 'download-and-extract', 23:16:12 INFO - 'populate-webroot', 23:16:12 INFO - 'create-virtualenv', 23:16:12 INFO - 'install', 23:16:12 INFO - 'run-tests'), 23:16:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:16:12 INFO - 'download_minidump_stackwalk': True, 23:16:12 INFO - 'download_symbols': 'ondemand', 23:16:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:16:12 INFO - 'tooltool.py': '/tools/tooltool.py', 23:16:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:16:12 INFO - '/tools/misc-python/virtualenv.py')}, 23:16:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:16:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:16:12 INFO - 'installer_path': 'installer.exe', 23:16:12 INFO - 'log_level': 'info', 23:16:12 INFO - 'log_name': 'talos', 23:16:12 INFO - 'log_to_console': True, 23:16:12 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:16:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:16:12 INFO - 'opt_config_files': (), 23:16:12 INFO - 'pip_index': False, 23:16:12 INFO - 'sps_profile': False, 23:16:12 INFO - 'sps_profile_interval': 0, 23:16:12 INFO - 'suite': 'dromaeojs', 23:16:12 INFO - 'system_bits': '32', 23:16:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:16:12 INFO - 'title': 'talos-linux64-ix-020', 23:16:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:16:12 INFO - 'use_talos_json': True, 23:16:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:16:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:16:12 INFO - 'work_dir': 'build'} 23:16:12 INFO - [mozharness: 2016-08-10 06:16:12.094813Z] Running clobber step. 23:16:12 INFO - Running pre-action listener: _resource_record_pre_action 23:16:12 INFO - Running main action method: clobber 23:16:12 INFO - rmtree: /builds/slave/test/build 23:16:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:16:13 INFO - Running post-action listener: _resource_record_post_action 23:16:13 INFO - [mozharness: 2016-08-10 06:16:13.056629Z] Finished clobber step (success) 23:16:13 INFO - [mozharness: 2016-08-10 06:16:13.056732Z] Running read-buildbot-config step. 23:16:13 INFO - Running pre-action listener: _resource_record_pre_action 23:16:13 INFO - Running main action method: read_buildbot_config 23:16:13 INFO - Using buildbot properties: 23:16:13 INFO - { 23:16:13 INFO - "project": "", 23:16:13 INFO - "product": "firefox", 23:16:13 INFO - "script_repo_revision": "production", 23:16:13 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 23:16:13 INFO - "repository": "", 23:16:13 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 23:16:13 INFO - "buildid": "20160809203014", 23:16:13 INFO - "pgo_build": "True", 23:16:13 INFO - "basedir": "/builds/slave/test", 23:16:13 INFO - "buildnumber": 353, 23:16:13 INFO - "slavename": "talos-linux64-ix-020", 23:16:13 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 23:16:13 INFO - "platform": "ubuntu64_hw", 23:16:13 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 23:16:13 INFO - "branch": "fx-team", 23:16:13 INFO - "repo_path": "integration/fx-team", 23:16:13 INFO - "revision": "d8d09f4544be39ec9c880c7e006b281251c8a60e", 23:16:13 INFO - "stage_platform": "linux64-pgo", 23:16:13 INFO - "builduid": "2d030529ccfd4ee8871c9efb91c2ba63", 23:16:13 INFO - "slavebuilddir": "test" 23:16:13 INFO - } 23:16:13 INFO - Found installer url https://queue.taskcluster.net/v1/task/Bx1HG7suR9S32CFMhYJS4w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 23:16:13 INFO - Running post-action listener: _resource_record_post_action 23:16:13 INFO - [mozharness: 2016-08-10 06:16:13.059175Z] Finished read-buildbot-config step (success) 23:16:13 INFO - [mozharness: 2016-08-10 06:16:13.059264Z] Running download-and-extract step. 23:16:13 INFO - Running pre-action listener: _resource_record_pre_action 23:16:13 INFO - Running main action method: download_and_extract 23:16:13 INFO - mkdir: /builds/slave/test/build/tests 23:16:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:16:13 INFO - trying https://queue.taskcluster.net/v1/task/Bx1HG7suR9S32CFMhYJS4w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 23:16:13 INFO - Downloading https://queue.taskcluster.net/v1/task/Bx1HG7suR9S32CFMhYJS4w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 23:16:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Bx1HG7suR9S32CFMhYJS4w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 23:16:13 INFO - Downloaded 1361 bytes. 23:16:13 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 23:16:13 INFO - Using the following test package requirements: 23:16:13 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 23:16:13 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:16:13 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 23:16:13 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:16:13 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 23:16:13 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:16:13 INFO - u'jsshell-linux-x86_64.zip'], 23:16:13 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:16:13 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 23:16:13 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 23:16:13 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:16:13 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 23:16:13 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:16:13 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 23:16:13 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:16:13 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 23:16:13 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:16:13 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 23:16:13 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:16:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:16:13 INFO - trying https://queue.taskcluster.net/v1/task/Bx1HG7suR9S32CFMhYJS4w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 23:16:13 INFO - Downloading https://queue.taskcluster.net/v1/task/Bx1HG7suR9S32CFMhYJS4w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 23:16:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Bx1HG7suR9S32CFMhYJS4w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:16:14 INFO - Downloaded 21831161 bytes. 23:16:14 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:16:14 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 23:16:15 INFO - Return code: 0 23:16:15 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 23:16:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:16:15 INFO - trying https://queue.taskcluster.net/v1/task/Bx1HG7suR9S32CFMhYJS4w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 23:16:15 INFO - Downloading https://queue.taskcluster.net/v1/task/Bx1HG7suR9S32CFMhYJS4w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 23:16:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Bx1HG7suR9S32CFMhYJS4w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:16:16 INFO - Downloaded 21831161 bytes. 23:16:16 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:16:16 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 23:16:18 INFO - Return code: 0 23:16:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:16:18 INFO - trying https://queue.taskcluster.net/v1/task/Bx1HG7suR9S32CFMhYJS4w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 23:16:18 INFO - Downloading https://queue.taskcluster.net/v1/task/Bx1HG7suR9S32CFMhYJS4w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 23:16:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Bx1HG7suR9S32CFMhYJS4w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 23:16:18 INFO - Downloaded 14413723 bytes. 23:16:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:16:18 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 23:16:18 INFO - Return code: 0 23:16:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:16:19 INFO - trying https://queue.taskcluster.net/v1/task/Bx1HG7suR9S32CFMhYJS4w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 23:16:19 INFO - Downloading https://queue.taskcluster.net/v1/task/Bx1HG7suR9S32CFMhYJS4w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 23:16:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Bx1HG7suR9S32CFMhYJS4w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 23:16:34 INFO - Downloaded 59325157 bytes. 23:16:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Bx1HG7suR9S32CFMhYJS4w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 23:16:34 INFO - mkdir: /builds/slave/test/properties 23:16:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:16:34 INFO - Writing to file /builds/slave/test/properties/build_url 23:16:34 INFO - Contents: 23:16:34 INFO - build_url:https://queue.taskcluster.net/v1/task/Bx1HG7suR9S32CFMhYJS4w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 23:16:35 INFO - Running post-action listener: _resource_record_post_action 23:16:35 INFO - Running post-action listener: set_extra_try_arguments 23:16:35 INFO - [mozharness: 2016-08-10 06:16:35.396991Z] Finished download-and-extract step (success) 23:16:35 INFO - [mozharness: 2016-08-10 06:16:35.397223Z] Running populate-webroot step. 23:16:35 INFO - Running pre-action listener: _resource_record_pre_action 23:16:35 INFO - Running main action method: populate_webroot 23:16:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:16:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:16:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:16:35 INFO - '--tppagecycles', 23:16:35 INFO - '7'], 23:16:35 INFO - 'tests': ['tsvgm']}}, 23:16:35 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:16:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:16:35 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:16:35 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:16:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:16:35 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:16:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:16:35 INFO - 'talos_options': ['--disable-e10s'], 23:16:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:16:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:16:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:16:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:16:35 INFO - 'talos_options': ['--disable-e10s'], 23:16:35 INFO - 'tests': ['damp', 'tps']}, 23:16:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:16:35 INFO - 'tests': ['damp', 'tps']}, 23:16:35 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:16:35 INFO - 'tests': ['dromaeo_dom']}, 23:16:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:16:35 INFO - 'g4': {'talos_options': ['--disable-e10s'], 23:16:35 INFO - 'tests': ['basic_compositor_video']}, 23:16:35 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 23:16:35 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:16:35 INFO - 'tests': ['a11yr', 23:16:35 INFO - 'ts_paint', 23:16:35 INFO - 'tpaint', 23:16:35 INFO - 'sessionrestore', 23:16:35 INFO - 'sessionrestore_no_auto_restore', 23:16:35 INFO - 'tabpaint']}, 23:16:35 INFO - 'other-e10s': {'tests': ['a11yr', 23:16:35 INFO - 'ts_paint', 23:16:35 INFO - 'tpaint', 23:16:35 INFO - 'sessionrestore', 23:16:35 INFO - 'sessionrestore_no_auto_restore', 23:16:35 INFO - 'tabpaint']}, 23:16:35 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:16:35 INFO - 'ts_paint', 23:16:35 INFO - 'tpaint', 23:16:35 INFO - 'sessionrestore', 23:16:35 INFO - 'sessionrestore_no_auto_restore', 23:16:35 INFO - 'tabpaint']}, 23:16:35 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:16:35 INFO - 'ts_paint', 23:16:35 INFO - 'tpaint', 23:16:35 INFO - 'sessionrestore', 23:16:35 INFO - 'sessionrestore_no_auto_restore', 23:16:35 INFO - 'tabpaint']}, 23:16:35 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:16:35 INFO - 'tests': ['a11yr', 23:16:35 INFO - 'ts_paint', 23:16:35 INFO - 'tpaint', 23:16:35 INFO - 'sessionrestore', 23:16:35 INFO - 'sessionrestore_no_auto_restore', 23:16:35 INFO - 'tabpaint']}, 23:16:35 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:16:35 INFO - 'tests': ['a11yr', 23:16:35 INFO - 'ts_paint', 23:16:35 INFO - 'tpaint', 23:16:35 INFO - 'sessionrestore', 23:16:35 INFO - 'sessionrestore_no_auto_restore', 23:16:35 INFO - 'tabpaint']}, 23:16:35 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:16:35 INFO - 'tests': ['tsvgx', 23:16:35 INFO - 'tsvgr_opacity', 23:16:35 INFO - 'tart', 23:16:35 INFO - 'tscrollx', 23:16:35 INFO - 'cart']}, 23:16:35 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:16:35 INFO - 'tsvgr_opacity', 23:16:35 INFO - 'tart', 23:16:35 INFO - 'tscrollx', 23:16:35 INFO - 'cart']}, 23:16:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:16:35 INFO - 'talos_options': ['--disable-e10s'], 23:16:35 INFO - 'tests': ['tp5o']}, 23:16:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:16:35 INFO - 'tests': ['tp5o']}, 23:16:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:16:35 INFO - 'talos_options': ['--disable-e10s', 23:16:35 INFO - '--xperf_path', 23:16:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:16:35 INFO - 'tests': ['tp5n']}, 23:16:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:16:35 INFO - 'talos_options': ['--xperf_path', 23:16:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:16:35 INFO - 'tests': ['tp5n']}}, 23:16:35 INFO - 'talos.zip': {'path': '', 23:16:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:16:35 INFO - Running post-action listener: _resource_record_post_action 23:16:35 INFO - [mozharness: 2016-08-10 06:16:35.418246Z] Finished populate-webroot step (success) 23:16:35 INFO - [mozharness: 2016-08-10 06:16:35.418336Z] Running create-virtualenv step. 23:16:35 INFO - Running pre-action listener: _resource_record_pre_action 23:16:35 INFO - Running main action method: create_virtualenv 23:16:35 INFO - Creating virtualenv /builds/slave/test/build/venv 23:16:35 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 23:16:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:16:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:16:35 INFO - Using real prefix '/usr' 23:16:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:16:36 INFO - Installing distribute.............................................................................................................................................................................................done. 23:16:37 INFO - Installing pip.................done. 23:16:38 INFO - Return code: 0 23:16:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:16:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:16:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:16:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:16:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:16:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16:38 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 0x20ac030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x220f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x236d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x236b3b0>, '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 0x236c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x236c740>, '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': 'af724c981e2a0f424dbabf99000001e7-1470809129.142214-1583716776', '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 23:16:38 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 23:16:38 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 23:16:38 INFO - Using env: {'DISPLAY': ':0', 23:16:38 INFO - 'HOME': '/home/cltbld', 23:16:38 INFO - 'LANG': 'en_US.UTF-8', 23:16:38 INFO - 'LANGUAGE': 'en_US:en', 23:16:38 INFO - 'LOGNAME': 'cltbld', 23:16:38 INFO - 'MAIL': '/var/mail/cltbld', 23:16:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:16:38 INFO - 'MOZ_NO_REMOTE': '1', 23:16:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:16:38 INFO - 'NO_EM_RESTART': '1', 23:16:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:16:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:16:38 INFO - 'PWD': '/builds/slave/test', 23:16:38 INFO - 'SHELL': '/bin/bash', 23:16:38 INFO - 'SHLVL': '1', 23:16:38 INFO - 'TERM': 'linux', 23:16:38 INFO - 'TMOUT': '86400', 23:16:38 INFO - 'USER': 'cltbld', 23:16:38 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1470809129.142214-1583716776', 23:16:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:16:38 INFO - '_': '/tools/buildbot/bin/python'} 23:16:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:16:38 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 23:16:38 INFO - Cleaning up... 23:16:38 INFO - Return code: 0 23:16:38 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23:16:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:16:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:16:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:16:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:16:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16:38 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 0x20ac030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x220f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x236d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x236b3b0>, '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 0x236c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x236c740>, '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': 'af724c981e2a0f424dbabf99000001e7-1470809129.142214-1583716776', '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 23:16:38 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 23:16:38 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 23:16:38 INFO - Using env: {'DISPLAY': ':0', 23:16:38 INFO - 'HOME': '/home/cltbld', 23:16:38 INFO - 'LANG': 'en_US.UTF-8', 23:16:38 INFO - 'LANGUAGE': 'en_US:en', 23:16:38 INFO - 'LOGNAME': 'cltbld', 23:16:38 INFO - 'MAIL': '/var/mail/cltbld', 23:16:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:16:38 INFO - 'MOZ_NO_REMOTE': '1', 23:16:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:16:38 INFO - 'NO_EM_RESTART': '1', 23:16:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:16:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:16:38 INFO - 'PWD': '/builds/slave/test', 23:16:38 INFO - 'SHELL': '/bin/bash', 23:16:38 INFO - 'SHLVL': '1', 23:16:38 INFO - 'TERM': 'linux', 23:16:38 INFO - 'TMOUT': '86400', 23:16:38 INFO - 'USER': 'cltbld', 23:16:38 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1470809129.142214-1583716776', 23:16:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:16:38 INFO - '_': '/tools/buildbot/bin/python'} 23:16:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:16:38 INFO - Downloading/unpacking psutil>=3.1.1 23:16:38 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 23:16:38 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 23:16:38 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 23:16:38 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 23:16:38 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 23:16:38 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 23:16:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:16:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:16:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:16:40 INFO - Installing collected packages: psutil 23:16:40 INFO - Running setup.py install for psutil 23:16:40 INFO - building 'psutil._psutil_linux' extension 23:16:40 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 23:16:40 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 23:16:40 INFO - building 'psutil._psutil_posix' extension 23:16:40 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 23:16:40 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 23:16:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:16:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:16:40 INFO - Successfully installed psutil 23:16:40 INFO - Cleaning up... 23:16:40 INFO - Return code: 0 23:16:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 23:16:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:16:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:16:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:16:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:16:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ac030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x220f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x236d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x236b3b0>, '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 0x236c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x236c740>, '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': 'af724c981e2a0f424dbabf99000001e7-1470809129.142214-1583716776', '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 23:16:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 23:16:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 23:16:40 INFO - Using env: {'DISPLAY': ':0', 23:16:40 INFO - 'HOME': '/home/cltbld', 23:16:40 INFO - 'LANG': 'en_US.UTF-8', 23:16:40 INFO - 'LANGUAGE': 'en_US:en', 23:16:40 INFO - 'LOGNAME': 'cltbld', 23:16:40 INFO - 'MAIL': '/var/mail/cltbld', 23:16:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:16:40 INFO - 'MOZ_NO_REMOTE': '1', 23:16:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:16:40 INFO - 'NO_EM_RESTART': '1', 23:16:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:16:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:16:40 INFO - 'PWD': '/builds/slave/test', 23:16:40 INFO - 'SHELL': '/bin/bash', 23:16:40 INFO - 'SHLVL': '1', 23:16:40 INFO - 'TERM': 'linux', 23:16:40 INFO - 'TMOUT': '86400', 23:16:40 INFO - 'USER': 'cltbld', 23:16:40 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1470809129.142214-1583716776', 23:16:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:16:40 INFO - '_': '/tools/buildbot/bin/python'} 23:16:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:16:41 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:16:41 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 23:16:41 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 23:16:41 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 23:16:41 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 23:16:41 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 23:16:41 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 23:16:43 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:16:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:16:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 23:16:43 INFO - Installing collected packages: mozsystemmonitor 23:16:43 INFO - Running setup.py install for mozsystemmonitor 23:16:43 INFO - Successfully installed mozsystemmonitor 23:16:43 INFO - Cleaning up... 23:16:43 INFO - Return code: 0 23:16:43 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 23:16:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:16:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:16:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:16:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:16:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16:43 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 0x20ac030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x220f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x236d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x236b3b0>, '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 0x236c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x236c740>, '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': 'af724c981e2a0f424dbabf99000001e7-1470809129.142214-1583716776', '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 23:16:43 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 23:16:43 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 23:16:43 INFO - Using env: {'DISPLAY': ':0', 23:16:43 INFO - 'HOME': '/home/cltbld', 23:16:43 INFO - 'LANG': 'en_US.UTF-8', 23:16:43 INFO - 'LANGUAGE': 'en_US:en', 23:16:43 INFO - 'LOGNAME': 'cltbld', 23:16:43 INFO - 'MAIL': '/var/mail/cltbld', 23:16:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:16:43 INFO - 'MOZ_NO_REMOTE': '1', 23:16:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:16:43 INFO - 'NO_EM_RESTART': '1', 23:16:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:16:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:16:43 INFO - 'PWD': '/builds/slave/test', 23:16:43 INFO - 'SHELL': '/bin/bash', 23:16:43 INFO - 'SHLVL': '1', 23:16:43 INFO - 'TERM': 'linux', 23:16:43 INFO - 'TMOUT': '86400', 23:16:43 INFO - 'USER': 'cltbld', 23:16:43 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1470809129.142214-1583716776', 23:16:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:16:43 INFO - '_': '/tools/buildbot/bin/python'} 23:16:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:16:43 INFO - Downloading/unpacking jsonschema==2.5.1 23:16:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:16:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:16:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:16:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:16:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:16:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:16:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:16:45 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 23:16:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:16:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:16:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:16:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:16:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:16:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:16:45 INFO - Downloading functools32-3.2.3-2.tar.gz 23:16:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:16:45 INFO - warning: no files found matching '*.txt' 23:16:45 INFO - no previously-included directories found matching 'build' 23:16:45 INFO - no previously-included directories found matching 'dist' 23:16:45 INFO - no previously-included directories found matching '.git*' 23:16:45 INFO - Installing collected packages: jsonschema, functools32 23:16:45 INFO - Running setup.py install for functools32 23:16:45 INFO - warning: no files found matching '*.txt' 23:16:45 INFO - no previously-included directories found matching 'build' 23:16:45 INFO - no previously-included directories found matching 'dist' 23:16:45 INFO - no previously-included directories found matching '.git*' 23:16:45 INFO - Successfully installed jsonschema functools32 23:16:45 INFO - Cleaning up... 23:16:45 INFO - Return code: 0 23:16:45 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 23:16:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:16:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:16:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:16:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:16:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ac030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x220f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x236d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x236b3b0>, '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 0x236c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x236c740>, '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': 'af724c981e2a0f424dbabf99000001e7-1470809129.142214-1583716776', '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 23:16:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 23:16:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 23:16:45 INFO - Using env: {'DISPLAY': ':0', 23:16:45 INFO - 'HOME': '/home/cltbld', 23:16:45 INFO - 'LANG': 'en_US.UTF-8', 23:16:45 INFO - 'LANGUAGE': 'en_US:en', 23:16:45 INFO - 'LOGNAME': 'cltbld', 23:16:45 INFO - 'MAIL': '/var/mail/cltbld', 23:16:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:16:45 INFO - 'MOZ_NO_REMOTE': '1', 23:16:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:16:45 INFO - 'NO_EM_RESTART': '1', 23:16:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:16:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:16:45 INFO - 'PWD': '/builds/slave/test', 23:16:45 INFO - 'SHELL': '/bin/bash', 23:16:45 INFO - 'SHLVL': '1', 23:16:45 INFO - 'TERM': 'linux', 23:16:45 INFO - 'TMOUT': '86400', 23:16:45 INFO - 'USER': 'cltbld', 23:16:45 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1470809129.142214-1583716776', 23:16:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:16:45 INFO - '_': '/tools/buildbot/bin/python'} 23:16:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:16:46 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 23:16:46 INFO - Cleaning up... 23:16:46 INFO - Return code: 0 23:16:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:16: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:16:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:16:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:16:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:16:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16:46 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 0x20ac030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x220f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x236d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x236b3b0>, '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 0x236c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x236c740>, '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': 'af724c981e2a0f424dbabf99000001e7-1470809129.142214-1583716776', '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 23:16:46 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 23:16:46 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 23:16:46 INFO - Using env: {'DISPLAY': ':0', 23:16:46 INFO - 'HOME': '/home/cltbld', 23:16:46 INFO - 'LANG': 'en_US.UTF-8', 23:16:46 INFO - 'LANGUAGE': 'en_US:en', 23:16:46 INFO - 'LOGNAME': 'cltbld', 23:16:46 INFO - 'MAIL': '/var/mail/cltbld', 23:16:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:16:46 INFO - 'MOZ_NO_REMOTE': '1', 23:16:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:16:46 INFO - 'NO_EM_RESTART': '1', 23:16:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:16:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:16:46 INFO - 'PWD': '/builds/slave/test', 23:16:46 INFO - 'SHELL': '/bin/bash', 23:16:46 INFO - 'SHLVL': '1', 23:16:46 INFO - 'TERM': 'linux', 23:16:46 INFO - 'TMOUT': '86400', 23:16:46 INFO - 'USER': 'cltbld', 23:16:46 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1470809129.142214-1583716776', 23:16:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:16:46 INFO - '_': '/tools/buildbot/bin/python'} 23:16:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:16:46 INFO - Downloading/unpacking blobuploader==1.2.4 23:16:46 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 23:16:46 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 23:16:46 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 23:16:46 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 23:16:46 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 23:16:46 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 23:16:48 INFO - Downloading blobuploader-1.2.4.tar.gz 23:16:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:16:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:16:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:16:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:16:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:16:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:16:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:16:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:16:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:16:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:16:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:16:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:16:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:16:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:16:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:16:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:16:48 INFO - Downloading docopt-0.6.1.tar.gz 23:16:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:16:48 INFO - Installing collected packages: blobuploader, requests, docopt 23:16:48 INFO - Running setup.py install for blobuploader 23:16:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:16:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:16:48 INFO - Running setup.py install for requests 23:16:49 INFO - Running setup.py install for docopt 23:16:49 INFO - Successfully installed blobuploader requests docopt 23:16:49 INFO - Cleaning up... 23:16:49 INFO - Return code: 0 23:16:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:16:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:16:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:16:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:16:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:16:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ac030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x220f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x236d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x236b3b0>, '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 0x236c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x236c740>, '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': 'af724c981e2a0f424dbabf99000001e7-1470809129.142214-1583716776', '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 23:16:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 23:16:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 23:16:49 INFO - Using env: {'DISPLAY': ':0', 23:16:49 INFO - 'HOME': '/home/cltbld', 23:16:49 INFO - 'LANG': 'en_US.UTF-8', 23:16:49 INFO - 'LANGUAGE': 'en_US:en', 23:16:49 INFO - 'LOGNAME': 'cltbld', 23:16:49 INFO - 'MAIL': '/var/mail/cltbld', 23:16:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:16:49 INFO - 'MOZ_NO_REMOTE': '1', 23:16:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:16:49 INFO - 'NO_EM_RESTART': '1', 23:16:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:16:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:16:49 INFO - 'PWD': '/builds/slave/test', 23:16:49 INFO - 'SHELL': '/bin/bash', 23:16:49 INFO - 'SHLVL': '1', 23:16:49 INFO - 'TERM': 'linux', 23:16:49 INFO - 'TMOUT': '86400', 23:16:49 INFO - 'USER': 'cltbld', 23:16:49 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1470809129.142214-1583716776', 23:16:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:16:49 INFO - '_': '/tools/buildbot/bin/python'} 23:16:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:16:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:16:49 INFO - Running setup.py (path:/tmp/pip-sQBj2M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:16:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:16:49 INFO - Running setup.py (path:/tmp/pip-VcBobG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:16:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:16:49 INFO - Running setup.py (path:/tmp/pip-SjmUC2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:16:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:16:49 INFO - Running setup.py (path:/tmp/pip-h2Ztwk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:16:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:16:49 INFO - Running setup.py (path:/tmp/pip-Sg1RWr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:16:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:16:50 INFO - Running setup.py (path:/tmp/pip-sS6eJP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:16:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:16:50 INFO - Running setup.py (path:/tmp/pip-42BuHF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:16:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:16:50 INFO - Running setup.py (path:/tmp/pip-rZrvHr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:16:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:16:50 INFO - Running setup.py (path:/tmp/pip-IxAvZR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:16:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:16:50 INFO - Running setup.py (path:/tmp/pip-NuwrCp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:16:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:16:50 INFO - Running setup.py (path:/tmp/pip-z8TEdl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:16:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:16:50 INFO - Running setup.py (path:/tmp/pip-UcgMP7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:16:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:16:50 INFO - Running setup.py (path:/tmp/pip-VgwnAy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:16:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:16:50 INFO - Running setup.py (path:/tmp/pip-S1GBEL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:16:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:16:50 INFO - Running setup.py (path:/tmp/pip-h9rRL6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:16:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:16:50 INFO - Running setup.py (path:/tmp/pip-Wn0wMm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:16:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:16:50 INFO - Running setup.py (path:/tmp/pip-WDCL1A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:16:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:16:50 INFO - Running setup.py install for manifestparser 23:16:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:16:50 INFO - Running setup.py install for mozcrash 23:16:51 INFO - Running setup.py install for mozdebug 23:16:51 INFO - Running setup.py install for mozdevice 23:16:51 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:16:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:16:51 INFO - Running setup.py install for mozfile 23:16:51 INFO - Running setup.py install for mozhttpd 23:16:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:16:51 INFO - Running setup.py install for mozinfo 23:16:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:16:51 INFO - Running setup.py install for mozInstall 23:16:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:16:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:16:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:16:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:16:51 INFO - Running setup.py install for mozleak 23:16:51 INFO - Running setup.py install for mozlog 23:16:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:16:51 INFO - Running setup.py install for moznetwork 23:16:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:16:51 INFO - Running setup.py install for mozprocess 23:16:52 INFO - Running setup.py install for mozprofile 23:16:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:16:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:16:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:16:52 INFO - Running setup.py install for mozrunner 23:16:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:16:52 INFO - Running setup.py install for mozscreenshot 23:16:52 INFO - Running setup.py install for moztest 23:16:52 INFO - Running setup.py install for mozversion 23:16:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:16:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:16:52 INFO - Cleaning up... 23:16:52 INFO - Return code: 0 23:16:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:16:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:16:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:16:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:16:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:16:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ac030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x220f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x236d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x236b3b0>, '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 0x236c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x236c740>, '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': 'af724c981e2a0f424dbabf99000001e7-1470809129.142214-1583716776', '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 23:16:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 23:16:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 23:16:52 INFO - Using env: {'DISPLAY': ':0', 23:16:52 INFO - 'HOME': '/home/cltbld', 23:16:52 INFO - 'LANG': 'en_US.UTF-8', 23:16:52 INFO - 'LANGUAGE': 'en_US:en', 23:16:52 INFO - 'LOGNAME': 'cltbld', 23:16:52 INFO - 'MAIL': '/var/mail/cltbld', 23:16:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:16:52 INFO - 'MOZ_NO_REMOTE': '1', 23:16:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:16:52 INFO - 'NO_EM_RESTART': '1', 23:16:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:16:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:16:52 INFO - 'PWD': '/builds/slave/test', 23:16:52 INFO - 'SHELL': '/bin/bash', 23:16:52 INFO - 'SHLVL': '1', 23:16:52 INFO - 'TERM': 'linux', 23:16:52 INFO - 'TMOUT': '86400', 23:16:52 INFO - 'USER': 'cltbld', 23:16:52 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1470809129.142214-1583716776', 23:16:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:16:52 INFO - '_': '/tools/buildbot/bin/python'} 23:16:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:16:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:16:52 INFO - Running setup.py (path:/tmp/pip-Z_CjeL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:16:52 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 23:16:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:16:52 INFO - Running setup.py (path:/tmp/pip-N2509r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:16:53 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)) 23:16:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:16:53 INFO - Running setup.py (path:/tmp/pip-GnWYmW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:16:53 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)) 23:16:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:16:53 INFO - Running setup.py (path:/tmp/pip-8W8TCO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:16:53 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)) 23:16:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:16:53 INFO - Running setup.py (path:/tmp/pip-lRuG1b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:16:53 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)) 23:16:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:16:53 INFO - Running setup.py (path:/tmp/pip-Qm98Nc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:16:53 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)) 23:16:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:16:53 INFO - Running setup.py (path:/tmp/pip-1Xmlv2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:16:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 23:16:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:16:53 INFO - Running setup.py (path:/tmp/pip-gmt5Tj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:16:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 23:16:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:16:53 INFO - Running setup.py (path:/tmp/pip-mJdx7h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:16:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 23:16:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:16:54 INFO - Running setup.py (path:/tmp/pip-fiBexh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:16:54 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)) 23:16:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:16:54 INFO - Running setup.py (path:/tmp/pip-Jn5TxI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:16:54 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)) 23:16:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:16:54 INFO - Running setup.py (path:/tmp/pip-Bg207P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:16:54 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)) 23:16:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:16:54 INFO - Running setup.py (path:/tmp/pip-BeKv_w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:16:54 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)) 23:16:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:16:54 INFO - Running setup.py (path:/tmp/pip-h268R6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:16:54 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)) 23:16:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:16:54 INFO - Running setup.py (path:/tmp/pip-Kc2fEn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:16:54 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)) 23:16:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:16:54 INFO - Running setup.py (path:/tmp/pip-f92VWr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:16:54 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)) 23:16:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:16:54 INFO - Running setup.py (path:/tmp/pip-muLAr7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:16:54 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)) 23:16:54 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)) 23:16:54 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)) 23:16:54 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)) 23:16:54 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)) 23:16:54 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)) 23:16:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:16:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:16:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:16:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:16:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:16:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:16:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:16:56 INFO - Downloading blessings-1.6.tar.gz 23:16:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:16:56 INFO - Installing collected packages: blessings 23:16:56 INFO - Running setup.py install for blessings 23:16:56 INFO - Successfully installed blessings 23:16:56 INFO - Cleaning up... 23:16:56 INFO - Return code: 0 23:16:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:16:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:16:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:16:56 INFO - Reading from file tmpfile_stdout 23:16:56 INFO - Current package versions: 23:16:56 INFO - argparse == 1.2.1 23:16:56 INFO - blessings == 1.6 23:16:56 INFO - blobuploader == 1.2.4 23:16:56 INFO - docopt == 0.6.1 23:16:56 INFO - functools32 == 3.2.3-2 23:16:56 INFO - jsonschema == 2.5.1 23:16:56 INFO - manifestparser == 1.1 23:16:56 INFO - mozInstall == 1.12 23:16:56 INFO - mozcrash == 0.17 23:16:56 INFO - mozdebug == 0.1 23:16:56 INFO - mozdevice == 0.48 23:16:56 INFO - mozfile == 1.2 23:16:56 INFO - mozhttpd == 0.7 23:16:56 INFO - mozinfo == 0.9 23:16:56 INFO - mozleak == 0.1 23:16:56 INFO - mozlog == 3.3 23:16:56 INFO - moznetwork == 0.27 23:16:56 INFO - mozprocess == 0.23 23:16:56 INFO - mozprofile == 0.28 23:16:56 INFO - mozrunner == 6.12 23:16:56 INFO - mozscreenshot == 0.1 23:16:56 INFO - mozsystemmonitor == 0.3 23:16:56 INFO - moztest == 0.7 23:16:56 INFO - mozversion == 1.4 23:16:56 INFO - psutil == 3.1.1 23:16:56 INFO - requests == 1.2.3 23:16:56 INFO - wsgiref == 0.1.2 23:16:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:16:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:16:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:16:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:16:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:16:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ac030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x220f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x236d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x236b3b0>, '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 0x236c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x236c740>, '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': 'af724c981e2a0f424dbabf99000001e7-1470809129.142214-1583716776', '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 23:16:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 23:16:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 23:16:56 INFO - Using env: {'DISPLAY': ':0', 23:16:56 INFO - 'HOME': '/home/cltbld', 23:16:56 INFO - 'LANG': 'en_US.UTF-8', 23:16:56 INFO - 'LANGUAGE': 'en_US:en', 23:16:56 INFO - 'LOGNAME': 'cltbld', 23:16:56 INFO - 'MAIL': '/var/mail/cltbld', 23:16:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:16:56 INFO - 'MOZ_NO_REMOTE': '1', 23:16:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:16:56 INFO - 'NO_EM_RESTART': '1', 23:16:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:16:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:16:56 INFO - 'PWD': '/builds/slave/test', 23:16:56 INFO - 'SHELL': '/bin/bash', 23:16:56 INFO - 'SHLVL': '1', 23:16:56 INFO - 'TERM': 'linux', 23:16:56 INFO - 'TMOUT': '86400', 23:16:56 INFO - 'USER': 'cltbld', 23:16:56 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1470809129.142214-1583716776', 23:16:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:16:56 INFO - '_': '/tools/buildbot/bin/python'} 23:16:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:16:57 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)) 23:16:57 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)) 23:16:57 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)) 23:16:57 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)) 23:16:57 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)) 23:16:57 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)) 23:16:57 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)) 23:16:57 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)) 23:16:57 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)) 23:16:57 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)) 23:16:57 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)) 23:16:57 INFO - Cleaning up... 23:16:57 INFO - Return code: 0 23:16:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:16:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:16:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:16:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:16:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:16:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ac030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x220f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x236d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x236b3b0>, '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 0x236c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x236c740>, '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': 'af724c981e2a0f424dbabf99000001e7-1470809129.142214-1583716776', '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 23:16:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 23:16:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 23:16:57 INFO - Using env: {'DISPLAY': ':0', 23:16:57 INFO - 'HOME': '/home/cltbld', 23:16:57 INFO - 'LANG': 'en_US.UTF-8', 23:16:57 INFO - 'LANGUAGE': 'en_US:en', 23:16:57 INFO - 'LOGNAME': 'cltbld', 23:16:57 INFO - 'MAIL': '/var/mail/cltbld', 23:16:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:16:57 INFO - 'MOZ_NO_REMOTE': '1', 23:16:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:16:57 INFO - 'NO_EM_RESTART': '1', 23:16:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:16:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:16:57 INFO - 'PWD': '/builds/slave/test', 23:16:57 INFO - 'SHELL': '/bin/bash', 23:16:57 INFO - 'SHLVL': '1', 23:16:57 INFO - 'TERM': 'linux', 23:16:57 INFO - 'TMOUT': '86400', 23:16:57 INFO - 'USER': 'cltbld', 23:16:57 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1470809129.142214-1583716776', 23:16:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:16:57 INFO - '_': '/tools/buildbot/bin/python'} 23:16:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:16:57 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 23:16:57 INFO - Cleaning up... 23:16:57 INFO - Return code: 0 23:16:57 INFO - Running post-action listener: _resource_record_post_action 23:16:57 INFO - Running post-action listener: _start_resource_monitoring 23:16:57 INFO - Starting resource monitoring. 23:16:57 INFO - [mozharness: 2016-08-10 06:16:57.374323Z] Finished create-virtualenv step (success) 23:16:57 INFO - [mozharness: 2016-08-10 06:16:57.374805Z] Running install step. 23:16:57 INFO - Running pre-action listener: _resource_record_pre_action 23:16:57 INFO - Running main action method: install 23:16:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:16:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:16:57 INFO - Reading from file tmpfile_stdout 23:16:57 INFO - Detecting whether we're running mozinstall >=1.0... 23:16:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:16:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:16:57 INFO - Reading from file tmpfile_stdout 23:16:57 INFO - Output received: 23:16:57 INFO - Usage: mozinstall [options] installer 23:16:57 INFO - Options: 23:16:57 INFO - -h, --help show this help message and exit 23:16:57 INFO - -d DEST, --destination=DEST 23:16:57 INFO - Directory to install application into. [default: 23:16:57 INFO - "/builds/slave/test"] 23:16:57 INFO - --app=APP Application being installed. [default: firefox] 23:16:57 INFO - mkdir: /builds/slave/test/build/application 23:16:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 23:16:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 23:17:14 INFO - Reading from file tmpfile_stdout 23:17:14 INFO - Output received: 23:17:14 INFO - /builds/slave/test/build/application/firefox/firefox 23:17:14 INFO - Running post-action listener: _resource_record_post_action 23:17:14 INFO - [mozharness: 2016-08-10 06:17:14.492854Z] Finished install step (success) 23:17:14 INFO - [mozharness: 2016-08-10 06:17:14.493098Z] Running run-tests step. 23:17:14 INFO - Running pre-action listener: _resource_record_pre_action 23:17:14 INFO - Running main action method: run_tests 23:17:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:17:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:17:14 INFO - Python 2.7.3 23:17:14 INFO - Return code: 0 23:17:14 INFO - grabbing minidump binary from tooltool 23:17:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:17:14 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 0x236b3b0>, '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 0x236c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x236c740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:17:14 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 23:17:14 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 23:17:14 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 23:17:14 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:17:14 INFO - Return code: 0 23:17:14 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:17:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:17:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:17:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:17:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:17:14 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/Bx1HG7suR9S32CFMhYJS4w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 23:17:14 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/Bx1HG7suR9S32CFMhYJS4w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-020 --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 23:17:14 INFO - Using env: {'DISPLAY': ':0', 23:17:14 INFO - 'HOME': '/home/cltbld', 23:17:14 INFO - 'LANG': 'en_US.UTF-8', 23:17:14 INFO - 'LANGUAGE': 'en_US:en', 23:17:14 INFO - 'LOGNAME': 'cltbld', 23:17:14 INFO - 'MAIL': '/var/mail/cltbld', 23:17:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:17:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:17:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:17:14 INFO - 'MOZ_NO_REMOTE': '1', 23:17:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:17:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:17:14 INFO - 'NO_EM_RESTART': '1', 23:17:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:17:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:17:14 INFO - 'PWD': '/builds/slave/test', 23:17:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:17:14 INFO - 'SHELL': '/bin/bash', 23:17:14 INFO - 'SHLVL': '1', 23:17:14 INFO - 'TERM': 'linux', 23:17:14 INFO - 'TMOUT': '86400', 23:17:14 INFO - 'USER': 'cltbld', 23:17:14 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1470809129.142214-1583716776', 23:17:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:17:14 INFO - '_': '/tools/buildbot/bin/python'} 23:17:14 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/Bx1HG7suR9S32CFMhYJS4w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 23:17:14 INFO - mozversion application_buildid: 20160809203014 23:17:14 INFO - mozversion application_changeset: d8d09f4544be39ec9c880c7e006b281251c8a60e 23:17:14 INFO - mozversion application_display_name: Nightly 23:17:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:17:14 INFO - mozversion application_name: Firefox 23:17:14 INFO - mozversion application_remotingname: firefox 23:17:14 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 23:17:14 INFO - mozversion application_vendor: Mozilla 23:17:14 INFO - mozversion application_version: 51.0a1 23:17:14 INFO - mozversion platform_buildid: 20160809203014 23:17:14 INFO - mozversion platform_changeset: d8d09f4544be39ec9c880c7e006b281251c8a60e 23:17:14 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 23:17:14 INFO - mozversion platform_version: 51.0a1 23:17:14 INFO - using testdate: 1470809834 23:17:14 INFO - actual date: 1470809834 23:17:14 INFO - starting webserver on 'localhost:58577' 23:17:14 INFO - SUITE-START | Running 2 tests 23:17:14 INFO - TEST-START | dromaeo_css 23:17:14 INFO - operating with platform_type : linux_ 23:17:14 INFO - Initialising browser for dromaeo_css test... 23:17:14 INFO - TEST-INFO | started process 29568 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0YQdcz/profile http://localhost:58577/getInfo.html) 23:17:19 INFO - PROCESS | 29568 | __metrics Screen width/height:1600/1200 23:17:19 INFO - PROCESS | 29568 | colorDepth:24 23:17:19 INFO - PROCESS | 29568 | Browser inner width/height: 1024/697 23:17:19 INFO - PROCESS | 29568 | __metrics 23:17:20 INFO - PROCESS | 29568 | 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" 23:17:20 INFO - PROCESS | 29568 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:17:21 INFO - TEST-INFO | 29568: exit 0 23:17:21 INFO - Browser initialized. 23:17:21 INFO - Running cycle 1/1 for dromaeo_css test... 23:17:21 INFO - TEST-INFO | started process 29649 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0YQdcz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:17:32 INFO - PROCESS | 29649 | RSS: Main: 155848704 23:17:32 INFO - PROCESS | 29649 | 23:18:24 INFO - PROCESS | 29649 | 1470809904207 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] 23:20:34 INFO - PROCESS | 29649 | Cycle 1(1): loaded http://localhost:58577/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58577/tests/dromaeo/cssquery-ext.html) 23:20:35 INFO - PROCESS | 29649 | RSS: Main: 274710528 23:20:35 INFO - PROCESS | 29649 | 23:23:38 INFO - PROCESS | 29649 | Cycle 1(1): loaded http://localhost:58577/tests/dromaeo/cssquery-ext.html (next: http://localhost:58577/tests/dromaeo/cssquery-jquery.html) 23:23:38 INFO - PROCESS | 29649 | RSS: Main: 242003968 23:23:38 INFO - PROCESS | 29649 | 23:26:40 INFO - PROCESS | 29649 | Cycle 1(1): loaded http://localhost:58577/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58577/tests/dromaeo/cssquery-mootools.html) 23:26:41 INFO - PROCESS | 29649 | RSS: Main: 185888768 23:26:41 INFO - PROCESS | 29649 | 23:29:43 INFO - PROCESS | 29649 | Cycle 1(1): loaded http://localhost:58577/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58577/tests/dromaeo/cssquery-prototype.html) 23:29:44 INFO - PROCESS | 29649 | RSS: Main: 184360960 23:29:44 INFO - PROCESS | 29649 | 23:32:46 INFO - PROCESS | 29649 | Cycle 1(1): loaded http://localhost:58577/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58577/tests/dromaeo/cssquery-yui.html) 23:32:47 INFO - PROCESS | 29649 | RSS: Main: 184741888 23:32:47 INFO - PROCESS | 29649 | 23:35:50 INFO - PROCESS | 29649 | Cycle 1(1): loaded http://localhost:58577/tests/dromaeo/cssquery-yui.html (next: http://localhost:58577/tests/dromaeo/cssquery-dojo.html) 23:35:50 INFO - PROCESS | 29649 | RSS: Main: 275914752 23:35:50 INFO - PROCESS | 29649 | 23:35:50 INFO - PROCESS | 29649 | __start_tp_report 23:35:50 INFO - PROCESS | 29649 | _x_x_mozilla_page_load 23:35:50 INFO - PROCESS | 29649 | _x_x_mozilla_page_load_details 23:35:50 INFO - PROCESS | 29649 | |i|pagename|runs| 23:35:50 INFO - PROCESS | 29649 | |0;dojo.html;3109.0206584925745;3109.973708676137;3132.1856317357488;3153.180173154979;3164.1614972032403;5341.278927344807;5347.572194224463;5410.972945135279;5426.62013659044;5439.102548079562;5334;5399.163129714891;5401.540869026137;5410.621256512036;5430.3755068167075;4900.068986892488;4910.2143657014885;4931.876703082434;4942.777575009133;5082.339295891529;5002.949970500303;5023.045621331935;5037.748112594356;5038.445770965191;5040.546350828425;4770.976145119287;4815.398075240595;4818.68678535894;4882.145624515713;4925.778339974692;4879.414470263591;4887.364642596475;4894.388201474816;4900.166971614834;4901.509849015106;4845.030993801219;4859.489753575895;4863.635227357927;4867.318575399447;4872.439669438025;5352.892942141136;5371.865703357408;5393.487618676219;5436.700981446019;5507.146392309199;5801.854953626151;5838.824835254949;5899.882002359929;5901.527877769769;5903.26209223847;5890.705464726747;5924.555658325643;5932.317783454915;5940.34656187819;5943;5324.068288049614;5345.786168553253;5467.6719396836315;5486.780528778884;5487.176923461433;5980.9401905980385;6019.217501724747;6024.186734790835;6031.035034394476;6035.547333949883;5562.610617256834;5737.569682273846;5763.991301522216;5766.509846662997;5773.509251713652;5660.320761508646;5780.566457515703;5787.218725472091;5788;5788.942110578841;5707;5762.481376676119;5769.336526299446;5777.364489906107;5789.971050144806;5753.1370294456165;5784.1034639630925;5792.044312688444;5792.247007888947;5795.88408231833;4430.645548356124;4433.756143412079;4447.221736196153;4478.686491945533;4498.077894031716;3988.2422339755353;3991.980040099781;3996.2207369562657;4032.334664780337;4035.0114222015795;5346.091164501966;5562.499375056264;5565.916511252334;5567.331920169606;5570.721463926788;5689.118186681071;5750.338711048199;5810.50610698087;5812.680302583399;5926.436988486087;5522.9447705523235;5531.25328080712;5531.446855314436;5533.529649979716;5534.916976245359;5008.574271186917;5019.52314530119;5020.447750747415;5027.069992051483;5080.669756465818;5888.352281249059;5965.463108320272;6011.48902343297;6017.217761691128;6135.447809697149;5853.946289667901;5857.853553661193;5859.296884373903;5860.853478663067;5861.032929566573;6063.878722425438;6068.4841788448475;6070.514358851369;6070.726817293321;6091.543134264859;5597.216389705363;5631.1271752878365;5685.118806584986;5690.800821971211;5789.652620842763;5740.942590574041;5772;5783.450572195635;5787.045137552257;5788.363280039276;5594.272744543184;5635.605507614428;5647.717614119196;5650.124230744241;5650.35020972577;5507.0637991542335;5548.029094908295;5549.195366671729;5561.63849349791;5629.662220266797;5511.586631002771;5515.145152501369;5520.227168196536;5524.4199359066715;5525.723713814213;5612.270404847343;5618.2415373924;5661.320641523043;5667.688277144632;5672.035753921926;5459.672419654833;5465;5481.725913704378;5496.230527726201;5571.1086226203615 23:35:50 INFO - PROCESS | 29649 | |1;ext.html;568.4514443561965;591.5208680968415;609.8109586028335;619.0837560410595;622.3589702606316;43304;44727.55272447275;44793.55206447934;44903;48162.51837481624;45470.77264613672;45950;45999;46034.539654603446;46035.84910377242;8908.73273801787;9052.683156089506;9061.275097992178;9061.909380906172;9065.728028159167;8878.778030549223;8968.372213945026;8976.551172441385;8976.820463590724;8977.596008179647;9006.729798106067;9036.186743193111;9046.457212567235;9052.683156089539;9056.818863622724;8937.195652391283;8977.461352318816;8980.057094005166;8983.640654373818;8983.955080224558;8857.468551886843;8912.910870891274;8918.866217006751;8920.152585504367;8920.464772113693;42841.35737963933;43184.352234716505;43191.35212971808;43208.351874721906;43239.56760432387;3661.8169091545315;3881.86413475527;3948.960510394888;4117.135401565675;4439.134368798085;32467.837660811543;32990.83504582486;33457.33085338304;33503.832480837686;34184.65815341865;3894.246343225929;4119;4344.782760861945;4427.6015158635555;4488.842890498817;370779;373344;374450;376509;376779;61294.38705612887;61985;62081.68959155175;62181.37818621846;62215.37784622186;36691.81654091766;37590.43614345787;37624.24751505009;39156.412653810214;39166.80416597899;17523.649527009642;17731.202095905715;17742.822571774115;17751.556211094827;17757.822421775618;12416.379181041093;12443.875561244453;12447.93776031132;12448.439820208112;12461.06542009353;19687.40937771869;19774.90112549428;19839.404817855488;19882.204711811366;20031.599368012558;7332.046833911664;7376.188619251878;7394.007236092557;7443.181250062489;7468.439867009996;952.2334520710895;1019.324273781324;1060.931039482431;1102.459794700591;1141.7830612183825;29885.40229195404;29974.250643733645;30287;30571.694283057328;31039.224019399695;910.886139232596;1084.322298563398;1106.4910141334915;1109.6005438042298;1113.9888601113885;15606.609834753996;16031.438899638457;16130.677386452206;16412.425565105164;16649.25078371476;534152;539192;542011;542083.5791642033;542098;59355.109673354935;59905.40094598998;59912.70043649754;59912.70043649841;60179.39820601825;1227.3679055286534;1247.058470854499;1327.084311824857;1394.5188909826093;1407.7254935287726;27650.446991060468;30247.546286805275;30386.69613303927;31518.842405788742;31973;46649.766751166026;47090.293645594655;47130.293045603656;47206.055878882915;47222;406877;408300;409084;409631;410257;28656.85372585073;29670.851645741634;29718;29805.850970745007;31057.844710776302;48235.45292291291;48350.5164948346;48735.75632121817;49270.26094608512;49384.75307623583;40298.59701402948;41529.37705934353;42502.362464563674;42564.787176063925;42673.33845277415;40243;41280.79359603183;41565;41583.7920810394;42936.57063429326;35047.299054018265;35812.74655387049;35890.46164307485;35942.460863087595;35952.64047359597;35124.12189695278;36266.27467450689;37009.62990370062;37645;40266.59733402746;26178.345541361618;26341.473170536097;26361.868190658923;26538.071167509046;26577.46845063049 23:35:50 INFO - PROCESS | 29649 | |2;jquery.html;376.70240509997103;391.4617401073522;403.5762449428101;406.7417190084296;415.42671113862883;13866.584002479929;17611.911940440295;19388.806111938877;19764.60470790587;19768.20927162912;19253.422397328104;19267.22931082755;19267.32564360248;19503.70744438831;19510.804891951077;5541.5843811714085;5561.888762224753;5740.684262365568;5743.942560574404;5757.68332741699;5585.190147428621;5706.885862282752;5715.828525144252;5720.370759216483;5722.7424765885635;5462.371827239878;5659.122835960433;5690.800821971232;5703.201551782754;5705.115707065412;5671.035923892948;5717.085266357404;5722.685252311121;5725.026745453283;5728.656280623176;4983.6013118950395;5075.4163271223915;5084.805070808357;5123.2315152727015;5138.2806407103035;22658.433539161488;22982.655260171112;23127.3061808146;23152;23307.31965823935;2280.350100221429;2446.266120163944;2477.677901872745;2589.2750029991635;2767.2805070681766;14080.295985200699;14274.286285685674;14584.927075364556;14918.850811491964;15232.923835380752;1921.1834970137636;1948.4641723526001;1972.1322618048157;1981.791911849264;2037.602667479842;55727.44272557263;71653.64173179101;73315.26684733138;80359.19640803576;83063.5846820768;10496.160307175407;10624.193887039222;10688.305260158066;10724.73188170302;11051.944740276247;15086.471973481095;15089.54731358061;15092.622684432978;15127.848721512644;15132.621684457756;8282.378821588405;8490.683943988692;8525;8655.134486551295;8675.956620216859;8328.792325112825;8353.164683531599;8527.360447966428;8610.182032706884;8636.611352489153;6422.229332480132;6524.64114473699;6603.438707709803;6650.334966503311;6677.799666010027;1879.9624007519774;1942.5726340205133;1954.2378472395776;1957.8825270483533;1958.7845337012918;886.5079880666292;948.9478078705599;1042.525650828871;1055.1927775251938;1106.115107913666;17008.234629441704;18895.338663147;19171.233150674096;19868.304609338604;20260.696089558667;906.777839429344;965.7826988927435;990.8513722941616;1013.6249587652616;1014.5079636376352;10270.486475676187;10593.205509586658;10703.678889633167;10751.462426878625;10866.348019118877;411908;467953;468608;473575;513278;97093;100142.4992875031;102763;103761;105897;952.1288021460425;987.8863930648067;1022.7596514819012;1029.4029462911494;1065.2383545764815;16275.647389241954;16323.428679996143;17066.232019559397;17225.138743063046;17723.82276177222;42246.57753422426;42450;43421;43740.781296093315;43770.12459750724;56605.433945660014;57928.4207157923;58992;59224.1116383246;60583.69708151431;8483;8537.402381833212;8560.74317770443;8728.258098061482;8815.074417186102;11250.943745281222;12001.099917506048;12098.576549820715;12112.333821639542;12373;10351.43067131315;10432.68701938943;10591.629292974709;10725.195610329412;10976.835347469634;10704.785904282027;10727.409992450179;10769.40768257722;10794.460276986276;10802.351858888178;10146.797064058825;10432.165426765689;10544.683659490227;10625.9468702656;10863.837042444211;8261.586920653823;8454.365922555957;8695.434796738191;8757.430767000125;8884.955575222082;8295.875561866456;10136.645217417356;10610.734731631772;10693.572257109628;10983.176261780238 23:35:50 INFO - PROCESS | 29649 | |3;mootools.html;1369.5959691890891;1473.1529370611895;1546.0491797544512;1622.472696373679;1789.8747087703857;8796;9277.489738064412;9291.11734385234;9307.208887244575;9311.115444032814;9179.173874351307;9305.302102342335;9311.76720581984;9312.767180820483;9314.90685093149;2452.276578409369;2476.1704828882257;2477.8884950177194;2478.368016155887;2479.665245191903;2305.7949450264146;2414.263649586875;2414.8551086934754;2416.4804567018086;2417.226487523993;2416.9879150604224;2439.292605144506;2444.511097780442;2446.217210492634;2449.2040086971715;2354.1878052072007;2375.3111597636666;2387.5941090014653;2388.7491813359607;2396.772306630867;2319.617263151578;2320.582295186866;2327.883605819702;2331.5570041692026;2331.825113116523;8946.194842464145;9124.635014599407;9220.677276295364;9226.630934762601;9274.582643781046;5456.454354564512;5623.156526521014;5631.71841407928;5633.295838020247;5636.15457681347;3506.3863823830984;3508.386032444312;3568.9107772305642;3573.285342931398;3601.243738814852;1121.9887801121965;1122.6407549584055;1134.3137401871832;1140.6635042662351;1163.6043745126613;12966.351682415841;13046.152000119962;13067.673308167372;13075.28085955272;13086.607401777961;4719.9292010619865;4723.357929115761;4783.354247176656;4869.196582563837;4878.0975519529;10066.295359324777;10068.04353586408;10069.496525173712;10069.597216111273;10070.899291006996;5468.671879687232;5477.260569823103;5477.589180811376;5481;5485.698286594195;4104.979475102606;4499.932501012488;4609.124266389375;4982.451930287665;5096.159133742965;3984.242993831163;4000.2599519089063;4079.918401631951;4081.9795901020307;4088.6524645405475;1179.4515550269166;1213.0598785940967;1215.7568486302775;1226.3500344817262;1242.4781591731314;946.5693109635099;948.1940350701987;948.3598570964572;948.79126592151;994.6866736977829;5739.7704091836695;5830.679312637761;5941.197938278277;5979.5814292999075;6147.754089836446;473.41769623363456;475.6551500162424;476.3212422298211;477.32696897374535;478.40916468161794;4050.1697152083752;4064.1058967027207;4069.898252543651;4098.7950602469755;4234.9364759528635;11409.201355905174;11692.123090768226;11744.29534227932;11757.88242117585;11815;11626.70933226676;11634.53461861533;11637.825432618518;11655.358955257543;11659.76680466386;8149;8446.282066024456;8458.36562257833;8583.785405364915;8658.87011694825;6021.789237376671;6123.877522449615;6144.293406258159;6247.781327653511;6258.812235632939;10342.689719308433;10738.302010369302;10787.6224332148;10801.24391292602;10860.565577377132;9774.413535187912;10999.120070394509;11027;11066.833997490205;11068.225224234226;7613.619319034137;7715.768526944201;7801.414893882868;7968.641411136628;7969.402294827795;8453.915460845314;8706.695265665672;8815.074417186102;8918.643254269757;8985.595648195716;8055.1944805521325;8152.551609661526;8164.224398682116;8200;8341.20758527939;7919.643616037177;7955.204479551999;7982.6008699565955;8024.117347091698;8061.919380806117;7177.856442871009;7217.747378841926;7222.34998850085;7233;7235.2764723527225;5048.873778155576;5214.713190774544;5247;5300.761465734128;5406.83779486616;5303.204519322133;5322.547583455294;5404.7297635118875;5460.099083651153;5462.371827239918 23:35:50 INFO - PROCESS | 29649 | |4;prototype.html;336.26861576072037;339.1994892054751;345.5180023866705;345.54905847868537;348.445970906259;5233.973830130849;5285.867853303669;5293.444188360225;5298.7350632468415;5310.575153987681;5198.09033419152;5215.947840521603;5229.424763276036;5235.528802407783;5241.9213711794355;4081.1225586498895;4110.198511290285;4171.958280417202;4191.476065491821;4232.555581663927;4131.772752498611;4145.730527515701;4179.853705120321;4183.6653067754505;4191.455110835603;4083.97958010211;4085.632293093621;4135.421041054255;4140.917181656365;4156.314208155651;3906.7655940643654;3985.9402108968097;4088.672906167529;4137.979310103446;4139.482564679415;3690.7231957603285;3691.2986532559;3693.076730817296;3693.630636936312;3711.164987877733;5057.69653820772;5063.721495317756;5115.744212789383;5134.0758663440565;5144.588432925394;4490.461144662629;4633.814647414099;4714.6935449196035;4754.106545508991;4793.137235297645;5421.810236641699;5426.806102657409;5431.402545719968;5442.537384322337;5454.699991500466;4051.4125451809323;4057.8435145983253;4081.673466122733;4089.325261331877;4108.876733697994;5603.571089372224;5608.158776183564;5614.831555053355;5679.375268720438;5708.40061793514;4165.875023749292;4171.019810344566;4174.373843923436;4186.120914607966;4204.936925946114;4252.4259225004225;4256.297710877732;4256.8297268109545;4257.042165512735;4257.297545904891;4667.6265898728025;4686.3204835299375;4724.929126063112;4765.0231702500905;4789.401324834395;5475.780968761205;5486.341639003345;5494;5494.203340515603;5521.4478552144465;1448.507507447473;1469.382859199139;1469.992650036743;1470.1767010474168;1471.2129010979074;902.8849371026777;942.6182396129578;951.2009911674088;956.7799406136488;972.5672075926145;4737.976310118427;4740.928886066643;4751.073540659608;4762.499937506581;4800.5199480051715;4932.975335123301;4960.883801144786;4973.676711013773;4976.2286845539;5001.499850015042;4562.361269422284;4742.5731684148595;4750.596199323028;4765.213739732905;4793.209120495079;2634.499445105424;2645.603159526048;2654.615080813271;2657.4321150521287;2658.8566916225823;5156.458571849977;5163.896722065538;5180.689158650418;5203.569018519862;5220.642632915469;4835.879103022453;5033.748312584356;5053.36832895888;5095.668781529189;5105.668131571436;5165.9483405165465;5171.534561889448;5174.922376164361;5185.559227465707;5196.908649183713;5014.749262536931;5031.698098114125;5048.570871475966;5079.847604571869;5084.694918304914;4756.9524304756505;4874.366332376769;4909.582685471775;4911.361523001987;4941.604671626189;5065.214891691794;5107.361579802525;5123.692578445305;5136.691798492103;5159.329287192641;3777.8866634001024;3818.770873747584;3823.2353529293696;3837.5394952605866;3846.9038274043373;5064.29099926018;5084.720340381315;5255.553277971415;5655.88688226225;5659.6321239119325;5519.199716041071;5525.254090697865;5527.153515939214;5530.91703624454;5532.253145825262;5534.723263836872;5536.584756143225;5539.639923404966;5567.526760225426;5569.721513924206;5210.707288792919;5481.671099734029;5511.311086114236;5520.503154716095;5523.171524271392;5311.203319502106;5394.487523685244;5544.667319960815;5588.832335029955;5607.523360514402;5470.753816078206;5494.2857428534035;5513.228148059195;5517.420670829505;5518.2826232589505 23:35:50 INFO - PROCESS | 29649 | |5;yui.html;717.8133685241836;726.6548389514979;761.5866056204299;800.4276941986482;811.233384451693;14023.789643155347;15219.315130819099;15225.16261605614;15313.923430382833;15374.077555346674;13290.667733306673;13310.933445332785;13312.26782526963;13315.267660278681;13327.866721332784;647.757091090841;789.5933594198964;789.8933643958078;820.7045463633087;825.6697321071559;817.1093508076195;823.4976664234842;830.2030051150903;830.2361827119034;830.3647709502205;863.1756672377865;864.006392648453;865.5628907401754;867.4838471109712;867.7310033889482;680.2585182151479;863.6718047142109;864.2524216552699;864.4726716702806;864.6800683747023;601.0323379359228;621.8134559632138;622.4273668225244;624.8375422390166;625.3746253746253;12441.253524788452;12469.127161098726;12486.75026499465;12489.562865299671;12510.31193284369;14198.574042778733;14225.430982760678;14335.354909029118;14816.185109818956;15166.545003649799;12399.628011159679;12529.248245105322;12781.233126012468;13024.739505209938;13381.732365352736;4390.275604525282;4390.429244198266;4452.577005184502;4453.532379100213;4619.353290539327;67754;69582.30417695809;69666;76834.23165768327;76920.23079769187;11821.645350639494;11846.960188564717;11962.880371196177;12044.21712588679;12160.209586377034;21588.35234942954;21807.454813629785;21819.781802181777;21826.236081737065;21909.671354929687;8621.655133794704;8825.249853762502;8835.072317406708;8854.38019338653;8859.778505537413;4864.927026094611;4901.607871370282;4901.828436004723;4977.626677999165;5055.039542486916;3556.964430355715;3636.5272514572935;3690.6493883081066;3692.1138926657945;3702.3520883845217;621.5897507644933;625.2653132569213;627.9231118631569;633.882731694638;636.7198432689602;702.6416527570873;709.4395427612128;739.4010851210537;745.5526683989563;754.5208792416745;9982.550785214682;10176;10411.531481083219;10488.213383996232;10502.947485262524;713.4352004543761;718.7735863203179;724.9166345870187;757.4130049211905;761.9238076192447;4956.752162391866;4970.701757894538;5037.722925239147;5073.188289873677;5076.949230507722;116236;128268.35865820611;128806;131237;132941;68290;83117;84287;93362.06637933533;106999.4650026745;62112.9999999991;71043;83799.5810020946;85013;86607.56696216478;9884.209263258777;10359.430231337348;10560.630377936735;10575.506628976158;10700.357978521313;48359.758201208766;48360.75819620879;48769.51230487791;50173;50503.747481262355;64540;66666.33333666601;71107.64446177737;71870;73619;13575.456981720621;13895.444182232597;13915.58253252404;14057;14157.646058848612;15830.60423489422;16082;16655.333786648884;16852.915735421244;16871.7469237964;14830.555083347517;15019.474318398803;15471.458498952483;15727.370905164124;15957.281922313292;14366.497172599327;14523.636909077357;14567.19325359149;14582.85417145815;14923.626909327353;14099.788503172666;14434.278286085444;14440.277986100864;14606.12363258208;15059.096454212782;11567.617413894772;12069.27584344942;12142.817857732318;12185.939070304592;12268.877311226774;10036.397816131055;12114.606820215435;12133.272003679807;12164.073550212179;12545.686357841127 23:35:50 INFO - PROCESS | 29649 | __end_tp_report 23:35:50 INFO - PROCESS | 29649 | __start_cc_report 23:35:50 INFO - PROCESS | 29649 | _x_x_mozilla_cycle_collect,1074 23:35:50 INFO - PROCESS | 29649 | __end_cc_report 23:35:50 INFO - PROCESS | 29649 | __startTimestamp1470810950842__endTimestamp 23:35:50 INFO - PROCESS | 29649 | 23:35:50 INFO - PROCESS | 29649 | ------- Summary: start ------- 23:35:50 INFO - PROCESS | 29649 | Number of tests: 6 23:35:50 INFO - PROCESS | 29649 | 23:35:50 INFO - PROCESS | 29649 | [#0] dojo.html Cycles:165 Average:5386.90 Median:5549.20 stddev:613.35 (11.1%) stddev-sans-first:588.63 23:35:50 INFO - PROCESS | 29649 | Values: 3109.0 3110.0 3132.2 3153.2 3164.2 5341.3 5347.6 5411.0 5426.6 5439.1 5334.0 5399.2 5401.5 5410.6 5430.4 4900.1 4910.2 4931.9 4942.8 5082.3 5002.9 5023.0 5037.7 5038.4 5040.5 4771.0 4815.4 4818.7 4882.1 4925.8 4879.4 4887.4 4894.4 4900.2 4901.5 4845.0 4859.5 4863.6 4867.3 4872.4 5352.9 5371.9 5393.5 5436.7 5507.1 5801.9 5838.8 5899.9 5901.5 5903.3 5890.7 5924.6 5932.3 5940.3 5943.0 5324.1 5345.8 5467.7 5486.8 5487.2 5980.9 6019.2 6024.2 6031.0 6035.5 5562.6 5737.6 5764.0 5766.5 5773.5 5660.3 5780.6 5787.2 5788.0 5788.9 5707.0 5762.5 5769.3 5777.4 5790.0 5753.1 5784.1 5792.0 5792.2 5795.9 4430.6 4433.8 4447.2 4478.7 4498.1 3988.2 3992.0 3996.2 4032.3 4035.0 5346.1 5562.5 5565.9 5567.3 5570.7 5689.1 5750.3 5810.5 5812.7 5926.4 5522.9 5531.3 5531.4 5533.5 5534.9 5008.6 5019.5 5020.4 5027.1 5080.7 5888.4 5965.5 6011.5 6017.2 6135.4 5853.9 5857.9 5859.3 5860.9 5861.0 6063.9 6068.5 6070.5 6070.7 6091.5 5597.2 5631.1 5685.1 5690.8 5789.7 5740.9 5772.0 5783.5 5787.0 5788.4 5594.3 5635.6 5647.7 5650.1 5650.4 5507.1 5548.0 5549.2 5561.6 5629.7 5511.6 5515.1 5520.2 5524.4 5525.7 5612.3 5618.2 5661.3 5667.7 5672.0 5459.7 5465.0 5481.7 5496.2 5571.1 23:35:50 INFO - PROCESS | 29649 | 23:35:50 INFO - PROCESS | 29649 | [#1] ext.html Cycles:180 Average:59734.14 Median:22699.90 stddev:118433.04 (521.7%) stddev-sans-first:118681.96 23:35:50 INFO - PROCESS | 29649 | Values: 568.5 591.5 609.8 619.1 622.4 43304.0 44727.6 44793.6 44903.0 48162.5 45470.8 45950.0 45999.0 46034.5 46035.8 8908.7 9052.7 9061.3 9061.9 9065.7 8878.8 8968.4 8976.6 8976.8 8977.6 9006.7 9036.2 9046.5 9052.7 9056.8 8937.2 8977.5 8980.1 8983.6 8984.0 8857.5 8912.9 8918.9 8920.2 8920.5 42841.4 43184.4 43191.4 43208.4 43239.6 3661.8 3881.9 3949.0 4117.1 4439.1 32467.8 32990.8 33457.3 33503.8 34184.7 3894.2 4119.0 4344.8 4427.6 4488.8 370779.0 373344.0 374450.0 376509.0 376779.0 61294.4 61985.0 62081.7 62181.4 62215.4 36691.8 37590.4 37624.2 39156.4 39166.8 17523.6 17731.2 17742.8 17751.6 17757.8 12416.4 12443.9 12447.9 12448.4 12461.1 19687.4 19774.9 19839.4 19882.2 20031.6 7332.0 7376.2 7394.0 7443.2 7468.4 952.2 1019.3 1060.9 1102.5 1141.8 29885.4 29974.3 30287.0 30571.7 31039.2 910.9 1084.3 1106.5 1109.6 1114.0 15606.6 16031.4 16130.7 16412.4 16649.3 534152.0 539192.0 542011.0 542083.6 542098.0 59355.1 59905.4 59912.7 59912.7 60179.4 1227.4 1247.1 1327.1 1394.5 1407.7 27650.4 30247.5 30386.7 31518.8 31973.0 46649.8 47090.3 47130.3 47206.1 47222.0 406877.0 408300.0 409084.0 409631.0 410257.0 28656.9 29670.9 29718.0 29805.9 31057.8 48235.5 48350.5 48735.8 49270.3 49384.8 40298.6 41529.4 42502.4 42564.8 42673.3 40243.0 41280.8 41565.0 41583.8 42936.6 35047.3 35812.7 35890.5 35942.5 35952.6 35124.1 36266.3 37009.6 37645.0 40266.6 26178.3 26341.5 26361.9 26538.1 26577.5 23:35:50 INFO - PROCESS | 29649 | 23:35:50 INFO - PROCESS | 29649 | [#2] jquery.html Cycles:180 Average:28433.17 Median:23229.66 stddev:77467.07 (333.5%) stddev-sans-first:77655.74 23:35:50 INFO - PROCESS | 29649 | Values: 376.7 391.5 403.6 406.7 415.4 13866.6 17611.9 19388.8 19764.6 19768.2 19253.4 19267.2 19267.3 19503.7 19510.8 5541.6 5561.9 5740.7 5743.9 5757.7 5585.2 5706.9 5715.8 5720.4 5722.7 5462.4 5659.1 5690.8 5703.2 5705.1 5671.0 5717.1 5722.7 5725.0 5728.7 4983.6 5075.4 5084.8 5123.2 5138.3 22658.4 22982.7 23127.3 23152.0 23307.3 2280.4 2446.3 2477.7 2589.3 2767.3 14080.3 14274.3 14584.9 14918.9 15232.9 1921.2 1948.5 1972.1 1981.8 2037.6 55727.4 71653.6 73315.3 80359.2 83063.6 10496.2 10624.2 10688.3 10724.7 11051.9 15086.5 15089.5 15092.6 15127.8 15132.6 8282.4 8490.7 8525.0 8655.1 8676.0 8328.8 8353.2 8527.4 8610.2 8636.6 6422.2 6524.6 6603.4 6650.3 6677.8 1880.0 1942.6 1954.2 1957.9 1958.8 886.5 948.9 1042.5 1055.2 1106.1 17008.2 18895.3 19171.2 19868.3 20260.7 906.8 965.8 990.9 1013.6 1014.5 10270.5 10593.2 10703.7 10751.5 10866.3 411908.0 467953.0 468608.0 473575.0 513278.0 97093.0 100142.5 102763.0 103761.0 105897.0 952.1 987.9 1022.8 1029.4 1065.2 16275.6 16323.4 17066.2 17225.1 17723.8 42246.6 42450.0 43421.0 43740.8 43770.1 56605.4 57928.4 58992.0 59224.1 60583.7 8483.0 8537.4 8560.7 8728.3 8815.1 11250.9 12001.1 12098.6 12112.3 12373.0 10351.4 10432.7 10591.6 10725.2 10976.8 10704.8 10727.4 10769.4 10794.5 10802.4 10146.8 10432.2 10544.7 10625.9 10863.8 8261.6 8454.4 8695.4 8757.4 8885.0 8295.9 10136.6 10610.7 10693.6 10983.2 23:35:50 INFO - PROCESS | 29649 | 23:35:50 INFO - PROCESS | 29649 | [#3] mootools.html Cycles:180 Average:6009.00 Median:475.99 stddev:3503.13 (736.0%) stddev-sans-first:3495.61 23:35:50 INFO - PROCESS | 29649 | Values: 1369.6 1473.2 1546.0 1622.5 1789.9 8796.0 9277.5 9291.1 9307.2 9311.1 9179.2 9305.3 9311.8 9312.8 9314.9 2452.3 2476.2 2477.9 2478.4 2479.7 2305.8 2414.3 2414.9 2416.5 2417.2 2417.0 2439.3 2444.5 2446.2 2449.2 2354.2 2375.3 2387.6 2388.7 2396.8 2319.6 2320.6 2327.9 2331.6 2331.8 8946.2 9124.6 9220.7 9226.6 9274.6 5456.5 5623.2 5631.7 5633.3 5636.2 3506.4 3508.4 3568.9 3573.3 3601.2 1122.0 1122.6 1134.3 1140.7 1163.6 12966.4 13046.2 13067.7 13075.3 13086.6 4719.9 4723.4 4783.4 4869.2 4878.1 10066.3 10068.0 10069.5 10069.6 10070.9 5468.7 5477.3 5477.6 5481.0 5485.7 4105.0 4499.9 4609.1 4982.5 5096.2 3984.2 4000.3 4079.9 4082.0 4088.7 1179.5 1213.1 1215.8 1226.4 1242.5 946.6 948.2 948.4 948.8 994.7 5739.8 5830.7 5941.2 5979.6 6147.8 473.4 475.7 476.3 477.3 478.4 4050.2 4064.1 4069.9 4098.8 4234.9 11409.2 11692.1 11744.3 11757.9 11815.0 11626.7 11634.5 11637.8 11655.4 11659.8 8149.0 8446.3 8458.4 8583.8 8658.9 6021.8 6123.9 6144.3 6247.8 6258.8 10342.7 10738.3 10787.6 10801.2 10860.6 9774.4 10999.1 11027.0 11066.8 11068.2 7613.6 7715.8 7801.4 7968.6 7969.4 8453.9 8706.7 8815.1 8918.6 8985.6 8055.2 8152.6 8164.2 8200.0 8341.2 7919.6 7955.2 7982.6 8024.1 8061.9 7177.9 7217.7 7222.3 7233.0 7235.3 5048.9 5214.7 5247.0 5300.8 5406.8 5303.2 5322.5 5404.7 5460.1 5462.4 23:35:50 INFO - PROCESS | 29649 | 23:35:50 INFO - PROCESS | 29649 | [#4] prototype.html Cycles:180 Average:4479.74 Median:5008.12 stddev:1268.34 (25.3%) stddev-sans-first:1233.18 23:35:50 INFO - PROCESS | 29649 | Values: 336.3 339.2 345.5 345.5 348.4 5234.0 5285.9 5293.4 5298.7 5310.6 5198.1 5215.9 5229.4 5235.5 5241.9 4081.1 4110.2 4172.0 4191.5 4232.6 4131.8 4145.7 4179.9 4183.7 4191.5 4084.0 4085.6 4135.4 4140.9 4156.3 3906.8 3985.9 4088.7 4138.0 4139.5 3690.7 3691.3 3693.1 3693.6 3711.2 5057.7 5063.7 5115.7 5134.1 5144.6 4490.5 4633.8 4714.7 4754.1 4793.1 5421.8 5426.8 5431.4 5442.5 5454.7 4051.4 4057.8 4081.7 4089.3 4108.9 5603.6 5608.2 5614.8 5679.4 5708.4 4165.9 4171.0 4174.4 4186.1 4204.9 4252.4 4256.3 4256.8 4257.0 4257.3 4667.6 4686.3 4724.9 4765.0 4789.4 5475.8 5486.3 5494.0 5494.2 5521.4 1448.5 1469.4 1470.0 1470.2 1471.2 902.9 942.6 951.2 956.8 972.6 4738.0 4740.9 4751.1 4762.5 4800.5 4933.0 4960.9 4973.7 4976.2 5001.5 4562.4 4742.6 4750.6 4765.2 4793.2 2634.5 2645.6 2654.6 2657.4 2658.9 5156.5 5163.9 5180.7 5203.6 5220.6 4835.9 5033.7 5053.4 5095.7 5105.7 5165.9 5171.5 5174.9 5185.6 5196.9 5014.7 5031.7 5048.6 5079.8 5084.7 4757.0 4874.4 4909.6 4911.4 4941.6 5065.2 5107.4 5123.7 5136.7 5159.3 3777.9 3818.8 3823.2 3837.5 3846.9 5064.3 5084.7 5255.6 5655.9 5659.6 5519.2 5525.3 5527.2 5530.9 5532.3 5534.7 5536.6 5539.6 5567.5 5569.7 5210.7 5481.7 5511.3 5520.5 5523.2 5311.2 5394.5 5544.7 5588.8 5607.5 5470.8 5494.3 5513.2 5517.4 5518.3 23:35:50 INFO - PROCESS | 29649 | 23:35:50 INFO - PROCESS | 29649 | [#5] yui.html Cycles:180 Average:20512.39 Median:4421.50 stddev:29371.51 (664.3%) stddev-sans-first:29416.30 23:35:50 INFO - PROCESS | 29649 | Values: 717.8 726.7 761.6 800.4 811.2 14023.8 15219.3 15225.2 15313.9 15374.1 13290.7 13310.9 13312.3 13315.3 13327.9 647.8 789.6 789.9 820.7 825.7 817.1 823.5 830.2 830.2 830.4 863.2 864.0 865.6 867.5 867.7 680.3 863.7 864.3 864.5 864.7 601.0 621.8 622.4 624.8 625.4 12441.3 12469.1 12486.8 12489.6 12510.3 14198.6 14225.4 14335.4 14816.2 15166.5 12399.6 12529.2 12781.2 13024.7 13381.7 4390.3 4390.4 4452.6 4453.5 4619.4 67754.0 69582.3 69666.0 76834.2 76920.2 11821.6 11847.0 11962.9 12044.2 12160.2 21588.4 21807.5 21819.8 21826.2 21909.7 8621.7 8825.2 8835.1 8854.4 8859.8 4864.9 4901.6 4901.8 4977.6 5055.0 3557.0 3636.5 3690.6 3692.1 3702.4 621.6 625.3 627.9 633.9 636.7 702.6 709.4 739.4 745.6 754.5 9982.6 10176.0 10411.5 10488.2 10502.9 713.4 718.8 724.9 757.4 761.9 4956.8 4970.7 5037.7 5073.2 5076.9 116236.0 128268.4 128806.0 131237.0 132941.0 68290.0 83117.0 84287.0 93362.1 106999.5 62113.0 71043.0 83799.6 85013.0 86607.6 9884.2 10359.4 10560.6 10575.5 10700.4 48359.8 48360.8 48769.5 50173.0 50503.7 64540.0 66666.3 71107.6 71870.0 73619.0 13575.5 13895.4 13915.6 14057.0 14157.6 15830.6 16082.0 16655.3 16852.9 16871.7 14830.6 15019.5 15471.5 15727.4 15957.3 14366.5 14523.6 14567.2 14582.9 14923.6 14099.8 14434.3 14440.3 14606.1 15059.1 11567.6 12069.3 12142.8 12185.9 12268.9 10036.4 12114.6 12133.3 12164.1 12545.7 23:35:50 INFO - PROCESS | 29649 | -------- Summary: end -------- 23:35:50 INFO - PROCESS | 29649 | 23:35:51 INFO - TEST-INFO | 29649: exit 0 23:35:51 INFO - TEST-OK | dromaeo_css | took 1116907ms 23:35:51 INFO - TEST-START | kraken 23:35:51 INFO - operating with platform_type : linux_ 23:35:51 INFO - Initialising browser for kraken test... 23:35:51 INFO - TEST-INFO | started process 29836 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0bVfA3/profile http://localhost:58577/getInfo.html) 23:35:55 INFO - PROCESS | 29836 | __metrics Screen width/height:1600/1200 23:35:55 INFO - PROCESS | 29836 | colorDepth:24 23:35:55 INFO - PROCESS | 29836 | Browser inner width/height: 1024/697 23:35:55 INFO - PROCESS | 29836 | __metrics 23:35:56 INFO - PROCESS | 29836 | 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" 23:35:56 INFO - PROCESS | 29836 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:35:57 INFO - TEST-INFO | 29836: exit 0 23:35:57 INFO - Browser initialized. 23:35:57 INFO - Running cycle 1/1 for kraken test... 23:35:57 INFO - TEST-INFO | started process 29920 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0bVfA3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:36:09 INFO - PROCESS | 29920 | RSS: Main: 155672576 23:36:09 INFO - PROCESS | 29920 | 23:36:11 INFO - PROCESS | 29920 | Cycle 1(1): loaded http://localhost:58577/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58577/tests/kraken/driver.html?testName=audio-beat-detection) 23:36:12 INFO - PROCESS | 29920 | RSS: Main: 211664896 23:36:12 INFO - PROCESS | 29920 | 23:36:15 INFO - PROCESS | 29920 | Cycle 1(1): loaded http://localhost:58577/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58577/tests/kraken/driver.html?testName=audio-dft) 23:36:15 INFO - PROCESS | 29920 | RSS: Main: 190935040 23:36:16 INFO - PROCESS | 29920 | 23:36:19 INFO - PROCESS | 29920 | Cycle 1(1): loaded http://localhost:58577/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58577/tests/kraken/driver.html?testName=audio-fft) 23:36:19 INFO - PROCESS | 29920 | RSS: Main: 268029952 23:36:19 INFO - PROCESS | 29920 | 23:36:21 INFO - PROCESS | 29920 | Cycle 1(1): loaded http://localhost:58577/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58577/tests/kraken/driver.html?testName=audio-oscillator) 23:36:22 INFO - PROCESS | 29920 | RSS: Main: 178368512 23:36:22 INFO - PROCESS | 29920 | 23:36:24 INFO - PROCESS | 29920 | Cycle 1(1): loaded http://localhost:58577/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58577/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:36:25 INFO - PROCESS | 29920 | RSS: Main: 182968320 23:36:25 INFO - PROCESS | 29920 | 23:36:28 INFO - PROCESS | 29920 | Cycle 1(1): loaded http://localhost:58577/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58577/tests/kraken/driver.html?testName=imaging-darkroom) 23:36:28 INFO - PROCESS | 29920 | RSS: Main: 217169920 23:36:28 INFO - PROCESS | 29920 | 23:36:32 INFO - PROCESS | 29920 | Cycle 1(1): loaded http://localhost:58577/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58577/tests/kraken/driver.html?testName=imaging-desaturate) 23:36:32 INFO - PROCESS | 29920 | RSS: Main: 217657344 23:36:32 INFO - PROCESS | 29920 | 23:36:35 INFO - PROCESS | 29920 | Cycle 1(1): loaded http://localhost:58577/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58577/tests/kraken/driver.html?testName=json-parse-financial) 23:36:36 INFO - PROCESS | 29920 | RSS: Main: 217980928 23:36:36 INFO - PROCESS | 29920 | 23:36:37 INFO - PROCESS | 29920 | Cycle 1(1): loaded http://localhost:58577/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58577/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:36:38 INFO - PROCESS | 29920 | RSS: Main: 180441088 23:36:38 INFO - PROCESS | 29920 | 23:36:39 INFO - PROCESS | 29920 | Cycle 1(1): loaded http://localhost:58577/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58577/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:36:40 INFO - PROCESS | 29920 | RSS: Main: 188211200 23:36:40 INFO - PROCESS | 29920 | 23:36:42 INFO - PROCESS | 29920 | Cycle 1(1): loaded http://localhost:58577/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58577/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:36:43 INFO - PROCESS | 29920 | RSS: Main: 192712704 23:36:43 INFO - PROCESS | 29920 | 23:36:45 INFO - PROCESS | 29920 | Cycle 1(1): loaded http://localhost:58577/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58577/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:36:46 INFO - PROCESS | 29920 | RSS: Main: 186019840 23:36:46 INFO - PROCESS | 29920 | 23:36:49 INFO - PROCESS | 29920 | Cycle 1(1): loaded http://localhost:58577/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58577/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:36:49 INFO - PROCESS | 29920 | RSS: Main: 191225856 23:36:49 INFO - PROCESS | 29920 | 23:36:51 INFO - PROCESS | 29920 | Cycle 1(1): loaded http://localhost:58577/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58577/tests/kraken/driver.html?testName=ai-astar) 23:36:51 INFO - PROCESS | 29920 | RSS: Main: 242208768 23:36:51 INFO - PROCESS | 29920 | 23:36:51 INFO - PROCESS | 29920 | __start_tp_report 23:36:51 INFO - PROCESS | 29920 | _x_x_mozilla_page_load 23:36:51 INFO - PROCESS | 29920 | _x_x_mozilla_page_load_details 23:36:51 INFO - PROCESS | 29920 | |i|pagename|runs| 23:36:51 INFO - PROCESS | 29920 | |0;ai-astar;102;113;111;110;121;111;109;110;109;111 23:36:51 INFO - PROCESS | 29920 | |1;audio-beat-detection;150;118;120;197;119;119;141;117;150;118 23:36:51 INFO - PROCESS | 29920 | |2;audio-dft;160;158;159;160;162;161;162;161;161;161 23:36:51 INFO - PROCESS | 29920 | |3;audio-fft;85;76;75;117;75;76;74;73;113;74 23:36:51 INFO - PROCESS | 29920 | |4;audio-oscillator;85;84;120;84;83;84;114;83;85;133 23:36:51 INFO - PROCESS | 29920 | |5;imaging-gaussian-blur;117;117;117;117;117;116;117;117;117;116 23:36:51 INFO - PROCESS | 29920 | |6;imaging-darkroom;146;146;146;145;146;146;145;146;145;146 23:36:51 INFO - PROCESS | 29920 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;95 23:36:51 INFO - PROCESS | 29920 | |8;json-parse-financial;50;51;51;50;49;51;49;50;49;49 23:36:51 INFO - PROCESS | 29920 | |9;json-stringify-tinderbox;59;60;61;60;60;61;60;61;60;61 23:36:51 INFO - PROCESS | 29920 | |10;stanford-crypto-aes;76;76;75;81;82;76;76;75;75;80 23:36:51 INFO - PROCESS | 29920 | |11;stanford-crypto-ccm;121;121;120;119;120;128;119;130;136;134 23:36:51 INFO - PROCESS | 29920 | |12;stanford-crypto-pbkdf2;157;157;163;159;156;156;156;158;156;157 23:36:51 INFO - PROCESS | 29920 | |13;stanford-crypto-sha256-iterative;63;62;64;62;62;63;64;62;61;62 23:36:51 INFO - PROCESS | 29920 | __end_tp_report 23:36:51 INFO - PROCESS | 29920 | __start_cc_report 23:36:51 INFO - PROCESS | 29920 | _x_x_mozilla_cycle_collect,1681 23:36:51 INFO - PROCESS | 29920 | __end_cc_report 23:36:51 INFO - PROCESS | 29920 | __startTimestamp1470811011538__endTimestamp 23:36:51 INFO - PROCESS | 29920 | 23:36:51 INFO - PROCESS | 29920 | ------- Summary: start ------- 23:36:51 INFO - PROCESS | 29920 | Number of tests: 14 23:36:51 INFO - PROCESS | 29920 | 23:36:51 INFO - PROCESS | 29920 | [#0] ai-astar Cycles:10 Average:110.70 Median:111.00 stddev:4.64 (4.2%) stddev-sans-first:3.71 23:36:51 INFO - PROCESS | 29920 | Values: 102.0 113.0 111.0 110.0 121.0 111.0 109.0 110.0 109.0 111.0 23:36:51 INFO - PROCESS | 29920 | 23:36:51 INFO - PROCESS | 29920 | [#1] audio-beat-detection Cycles:10 Average:134.90 Median:130.50 stddev:25.75 (19.7%) stddev-sans-first:26.73 23:36:51 INFO - PROCESS | 29920 | Values: 150.0 118.0 120.0 197.0 119.0 119.0 141.0 117.0 150.0 118.0 23:36:51 INFO - PROCESS | 29920 | 23:36:51 INFO - PROCESS | 29920 | [#2] audio-dft Cycles:10 Average:160.50 Median:161.00 stddev:1.27 (0.8%) stddev-sans-first:1.33 23:36:51 INFO - PROCESS | 29920 | Values: 160.0 158.0 159.0 160.0 162.0 161.0 162.0 161.0 161.0 161.0 23:36:51 INFO - PROCESS | 29920 | 23:36:51 INFO - PROCESS | 29920 | [#3] audio-fft Cycles:10 Average:83.80 Median:75.00 stddev:16.80 (22.4%) stddev-sans-first:17.82 23:36:51 INFO - PROCESS | 29920 | Values: 85.0 76.0 75.0 117.0 75.0 76.0 74.0 73.0 113.0 74.0 23:36:51 INFO - PROCESS | 29920 | 23:36:51 INFO - PROCESS | 29920 | [#4] audio-oscillator Cycles:10 Average:95.50 Median:84.00 stddev:19.09 (22.7%) stddev-sans-first:19.86 23:36:51 INFO - PROCESS | 29920 | Values: 85.0 84.0 120.0 84.0 83.0 84.0 114.0 83.0 85.0 133.0 23:36:51 INFO - PROCESS | 29920 | 23:36:51 INFO - PROCESS | 29920 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 23:36:51 INFO - PROCESS | 29920 | Values: 117.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 116.0 23:36:51 INFO - PROCESS | 29920 | 23:36:51 INFO - PROCESS | 29920 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 23:36:51 INFO - PROCESS | 29920 | Values: 146.0 146.0 146.0 145.0 146.0 146.0 145.0 146.0 145.0 146.0 23:36:51 INFO - PROCESS | 29920 | 23:36:51 INFO - PROCESS | 29920 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 23:36:51 INFO - PROCESS | 29920 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 23:36:51 INFO - PROCESS | 29920 | 23:36:51 INFO - PROCESS | 29920 | [#8] json-parse-financial Cycles:10 Average:49.90 Median:50.00 stddev:0.88 (1.8%) stddev-sans-first:0.93 23:36:51 INFO - PROCESS | 29920 | Values: 50.0 51.0 51.0 50.0 49.0 51.0 49.0 50.0 49.0 49.0 23:36:51 INFO - PROCESS | 29920 | 23:36:51 INFO - PROCESS | 29920 | [#9] json-stringify-tinderbox Cycles:10 Average:60.30 Median:60.50 stddev:0.67 (1.1%) stddev-sans-first:0.53 23:36:51 INFO - PROCESS | 29920 | Values: 59.0 60.0 61.0 60.0 60.0 61.0 60.0 61.0 60.0 61.0 23:36:51 INFO - PROCESS | 29920 | 23:36:51 INFO - PROCESS | 29920 | [#10] stanford-crypto-aes Cycles:10 Average:77.20 Median:76.00 stddev:2.70 (3.6%) stddev-sans-first:2.83 23:36:51 INFO - PROCESS | 29920 | Values: 76.0 76.0 75.0 81.0 82.0 76.0 76.0 75.0 75.0 80.0 23:36:51 INFO - PROCESS | 29920 | 23:36:51 INFO - PROCESS | 29920 | [#11] stanford-crypto-ccm Cycles:10 Average:124.80 Median:124.50 stddev:6.58 (5.3%) stddev-sans-first:6.83 23:36:51 INFO - PROCESS | 29920 | Values: 121.0 121.0 120.0 119.0 120.0 128.0 119.0 130.0 136.0 134.0 23:36:51 INFO - PROCESS | 29920 | 23:36:51 INFO - PROCESS | 29920 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.50 Median:157.00 stddev:2.17 (1.4%) stddev-sans-first:2.30 23:36:51 INFO - PROCESS | 29920 | Values: 157.0 157.0 163.0 159.0 156.0 156.0 156.0 158.0 156.0 157.0 23:36:51 INFO - PROCESS | 29920 | 23:36:51 INFO - PROCESS | 29920 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.50 Median:62.50 stddev:0.97 (1.6%) stddev-sans-first:1.01 23:36:51 INFO - PROCESS | 29920 | Values: 63.0 62.0 64.0 62.0 62.0 63.0 64.0 62.0 61.0 62.0 23:36:51 INFO - PROCESS | 29920 | -------- Summary: end -------- 23:36:51 INFO - PROCESS | 29920 | 23:36:52 INFO - TEST-INFO | 29920: exit 0 23:36:52 INFO - TEST-OK | kraken | took 60920ms 23:36:52 INFO - SUITE-END | took 1177s 23:36:52 INFO - Completed test suite (00:19:37) 23:36:52 INFO - javascript benchmark 23:36:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3109.0206584925745, 3109.973708676137, 3132.1856317357488, 3153.180173154979, 3164.1614972032403, 5341.278927344807, 5347.572194224463, 5410.972945135279, 5426.62013659044, 5439.102548079562, 5334.0, 5399.163129714891, 5401.540869026137, 5410.621256512036, 5430.3755068167075, 4900.068986892488, 4910.2143657014885, 4931.876703082434, 4942.777575009133, 5082.339295891529, 5002.949970500303, 5023.045621331935, 5037.748112594356, 5038.445770965191, 5040.546350828425, 4770.976145119287, 4815.398075240595, 4818.68678535894, 4882.145624515713, 4925.778339974692, 4879.414470263591, 4887.364642596475, 4894.388201474816, 4900.166971614834, 4901.509849015106, 4845.030993801219, 4859.489753575895, 4863.635227357927, 4867.318575399447, 4872.439669438025, 5352.892942141136, 5371.865703357408, 5393.487618676219, 5436.700981446019, 5507.146392309199, 5801.854953626151, 5838.824835254949, 5899.882002359929, 5901.527877769769, 5903.26209223847, 5890.705464726747, 5924.555658325643, 5932.317783454915, 5940.34656187819, 5943.0, 5324.068288049614, 5345.786168553253, 5467.6719396836315, 5486.780528778884, 5487.176923461433, 5980.9401905980385, 6019.217501724747, 6024.186734790835, 6031.035034394476, 6035.547333949883, 5562.610617256834, 5737.569682273846, 5763.991301522216, 5766.509846662997, 5773.509251713652, 5660.320761508646, 5780.566457515703, 5787.218725472091, 5788.0, 5788.942110578841, 5707.0, 5762.481376676119, 5769.336526299446, 5777.364489906107, 5789.971050144806, 5753.1370294456165, 5784.1034639630925, 5792.044312688444, 5792.247007888947, 5795.88408231833, 4430.645548356124, 4433.756143412079, 4447.221736196153, 4478.686491945533, 4498.077894031716, 3988.2422339755353, 3991.980040099781, 3996.2207369562657, 4032.334664780337, 4035.0114222015795, 5346.091164501966, 5562.499375056264, 5565.916511252334, 5567.331920169606, 5570.721463926788, 5689.118186681071, 5750.338711048199, 5810.50610698087, 5812.680302583399, 5926.436988486087, 5522.9447705523235, 5531.25328080712, 5531.446855314436, 5533.529649979716, 5534.916976245359, 5008.574271186917, 5019.52314530119, 5020.447750747415, 5027.069992051483, 5080.669756465818, 5888.352281249059, 5965.463108320272, 6011.48902343297, 6017.217761691128, 6135.447809697149, 5853.946289667901, 5857.853553661193, 5859.296884373903, 5860.853478663067, 5861.032929566573, 6063.878722425438, 6068.4841788448475, 6070.514358851369, 6070.726817293321, 6091.543134264859, 5597.216389705363, 5631.1271752878365, 5685.118806584986, 5690.800821971211, 5789.652620842763, 5740.942590574041, 5772.0, 5783.450572195635, 5787.045137552257, 5788.363280039276, 5594.272744543184, 5635.605507614428, 5647.717614119196, 5650.124230744241, 5650.35020972577, 5507.0637991542335, 5548.029094908295, 5549.195366671729, 5561.63849349791, 5629.662220266797, 5511.586631002771, 5515.145152501369, 5520.227168196536, 5524.4199359066715, 5525.723713814213, 5612.270404847343, 5618.2415373924, 5661.320641523043, 5667.688277144632, 5672.035753921926, 5459.672419654833, 5465.0, 5481.725913704378, 5496.230527726201, 5571.1086226203615], "value": 5345.503770149864, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [568.4514443561965, 591.5208680968415, 609.8109586028335, 619.0837560410595, 622.3589702606316, 43304.0, 44727.55272447275, 44793.55206447934, 44903.0, 48162.51837481624, 45470.77264613672, 45950.0, 45999.0, 46034.539654603446, 46035.84910377242, 8908.73273801787, 9052.683156089506, 9061.275097992178, 9061.909380906172, 9065.728028159167, 8878.778030549223, 8968.372213945026, 8976.551172441385, 8976.820463590724, 8977.596008179647, 9006.729798106067, 9036.186743193111, 9046.457212567235, 9052.683156089539, 9056.818863622724, 8937.195652391283, 8977.461352318816, 8980.057094005166, 8983.640654373818, 8983.955080224558, 8857.468551886843, 8912.910870891274, 8918.866217006751, 8920.152585504367, 8920.464772113693, 42841.35737963933, 43184.352234716505, 43191.35212971808, 43208.351874721906, 43239.56760432387, 3661.8169091545315, 3881.86413475527, 3948.960510394888, 4117.135401565675, 4439.134368798085, 32467.837660811543, 32990.83504582486, 33457.33085338304, 33503.832480837686, 34184.65815341865, 3894.246343225929, 4119.0, 4344.782760861945, 4427.6015158635555, 4488.842890498817, 370779.0, 373344.0, 374450.0, 376509.0, 376779.0, 61294.38705612887, 61985.0, 62081.68959155175, 62181.37818621846, 62215.37784622186, 36691.81654091766, 37590.43614345787, 37624.24751505009, 39156.412653810214, 39166.80416597899, 17523.649527009642, 17731.202095905715, 17742.822571774115, 17751.556211094827, 17757.822421775618, 12416.379181041093, 12443.875561244453, 12447.93776031132, 12448.439820208112, 12461.06542009353, 19687.40937771869, 19774.90112549428, 19839.404817855488, 19882.204711811366, 20031.599368012558, 7332.046833911664, 7376.188619251878, 7394.007236092557, 7443.181250062489, 7468.439867009996, 952.2334520710895, 1019.324273781324, 1060.931039482431, 1102.459794700591, 1141.7830612183825, 29885.40229195404, 29974.250643733645, 30287.0, 30571.694283057328, 31039.224019399695, 910.886139232596, 1084.322298563398, 1106.4910141334915, 1109.6005438042298, 1113.9888601113885, 15606.609834753996, 16031.438899638457, 16130.677386452206, 16412.425565105164, 16649.25078371476, 534152.0, 539192.0, 542011.0, 542083.5791642033, 542098.0, 59355.109673354935, 59905.40094598998, 59912.70043649754, 59912.70043649841, 60179.39820601825, 1227.3679055286534, 1247.058470854499, 1327.084311824857, 1394.5188909826093, 1407.7254935287726, 27650.446991060468, 30247.546286805275, 30386.69613303927, 31518.842405788742, 31973.0, 46649.766751166026, 47090.293645594655, 47130.293045603656, 47206.055878882915, 47222.0, 406877.0, 408300.0, 409084.0, 409631.0, 410257.0, 28656.85372585073, 29670.851645741634, 29718.0, 29805.850970745007, 31057.844710776302, 48235.45292291291, 48350.5164948346, 48735.75632121817, 49270.26094608512, 49384.75307623583, 40298.59701402948, 41529.37705934353, 42502.362464563674, 42564.787176063925, 42673.33845277415, 40243.0, 41280.79359603183, 41565.0, 41583.7920810394, 42936.57063429326, 35047.299054018265, 35812.74655387049, 35890.46164307485, 35942.460863087595, 35952.64047359597, 35124.12189695278, 36266.27467450689, 37009.62990370062, 37645.0, 40266.59733402746, 26178.345541361618, 26341.473170536097, 26361.868190658923, 26538.071167509046, 26577.46845063049], "value": 19948.97572862445, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [376.70240509997103, 391.4617401073522, 403.5762449428101, 406.7417190084296, 415.42671113862883, 13866.584002479929, 17611.911940440295, 19388.806111938877, 19764.60470790587, 19768.20927162912, 19253.422397328104, 19267.22931082755, 19267.32564360248, 19503.70744438831, 19510.804891951077, 5541.5843811714085, 5561.888762224753, 5740.684262365568, 5743.942560574404, 5757.68332741699, 5585.190147428621, 5706.885862282752, 5715.828525144252, 5720.370759216483, 5722.7424765885635, 5462.371827239878, 5659.122835960433, 5690.800821971232, 5703.201551782754, 5705.115707065412, 5671.035923892948, 5717.085266357404, 5722.685252311121, 5725.026745453283, 5728.656280623176, 4983.6013118950395, 5075.4163271223915, 5084.805070808357, 5123.2315152727015, 5138.2806407103035, 22658.433539161488, 22982.655260171112, 23127.3061808146, 23152.0, 23307.31965823935, 2280.350100221429, 2446.266120163944, 2477.677901872745, 2589.2750029991635, 2767.2805070681766, 14080.295985200699, 14274.286285685674, 14584.927075364556, 14918.850811491964, 15232.923835380752, 1921.1834970137636, 1948.4641723526001, 1972.1322618048157, 1981.791911849264, 2037.602667479842, 55727.44272557263, 71653.64173179101, 73315.26684733138, 80359.19640803576, 83063.5846820768, 10496.160307175407, 10624.193887039222, 10688.305260158066, 10724.73188170302, 11051.944740276247, 15086.471973481095, 15089.54731358061, 15092.622684432978, 15127.848721512644, 15132.621684457756, 8282.378821588405, 8490.683943988692, 8525.0, 8655.134486551295, 8675.956620216859, 8328.792325112825, 8353.164683531599, 8527.360447966428, 8610.182032706884, 8636.611352489153, 6422.229332480132, 6524.64114473699, 6603.438707709803, 6650.334966503311, 6677.799666010027, 1879.9624007519774, 1942.5726340205133, 1954.2378472395776, 1957.8825270483533, 1958.7845337012918, 886.5079880666292, 948.9478078705599, 1042.525650828871, 1055.1927775251938, 1106.115107913666, 17008.234629441704, 18895.338663147, 19171.233150674096, 19868.304609338604, 20260.696089558667, 906.777839429344, 965.7826988927435, 990.8513722941616, 1013.6249587652616, 1014.5079636376352, 10270.486475676187, 10593.205509586658, 10703.678889633167, 10751.462426878625, 10866.348019118877, 411908.0, 467953.0, 468608.0, 473575.0, 513278.0, 97093.0, 100142.4992875031, 102763.0, 103761.0, 105897.0, 952.1288021460425, 987.8863930648067, 1022.7596514819012, 1029.4029462911494, 1065.2383545764815, 16275.647389241954, 16323.428679996143, 17066.232019559397, 17225.138743063046, 17723.82276177222, 42246.57753422426, 42450.0, 43421.0, 43740.781296093315, 43770.12459750724, 56605.433945660014, 57928.4207157923, 58992.0, 59224.1116383246, 60583.69708151431, 8483.0, 8537.402381833212, 8560.74317770443, 8728.258098061482, 8815.074417186102, 11250.943745281222, 12001.099917506048, 12098.576549820715, 12112.333821639542, 12373.0, 10351.43067131315, 10432.68701938943, 10591.629292974709, 10725.195610329412, 10976.835347469634, 10704.785904282027, 10727.409992450179, 10769.40768257722, 10794.460276986276, 10802.351858888178, 10146.797064058825, 10432.165426765689, 10544.683659490227, 10625.9468702656, 10863.837042444211, 8261.586920653823, 8454.365922555957, 8695.434796738191, 8757.430767000125, 8884.955575222082, 8295.875561866456, 10136.645217417356, 10610.734731631772, 10693.572257109628, 10983.176261780238], "value": 9248.754561835245, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1369.5959691890891, 1473.1529370611895, 1546.0491797544512, 1622.472696373679, 1789.8747087703857, 8796.0, 9277.489738064412, 9291.11734385234, 9307.208887244575, 9311.115444032814, 9179.173874351307, 9305.302102342335, 9311.76720581984, 9312.767180820483, 9314.90685093149, 2452.276578409369, 2476.1704828882257, 2477.8884950177194, 2478.368016155887, 2479.665245191903, 2305.7949450264146, 2414.263649586875, 2414.8551086934754, 2416.4804567018086, 2417.226487523993, 2416.9879150604224, 2439.292605144506, 2444.511097780442, 2446.217210492634, 2449.2040086971715, 2354.1878052072007, 2375.3111597636666, 2387.5941090014653, 2388.7491813359607, 2396.772306630867, 2319.617263151578, 2320.582295186866, 2327.883605819702, 2331.5570041692026, 2331.825113116523, 8946.194842464145, 9124.635014599407, 9220.677276295364, 9226.630934762601, 9274.582643781046, 5456.454354564512, 5623.156526521014, 5631.71841407928, 5633.295838020247, 5636.15457681347, 3506.3863823830984, 3508.386032444312, 3568.9107772305642, 3573.285342931398, 3601.243738814852, 1121.9887801121965, 1122.6407549584055, 1134.3137401871832, 1140.6635042662351, 1163.6043745126613, 12966.351682415841, 13046.152000119962, 13067.673308167372, 13075.28085955272, 13086.607401777961, 4719.9292010619865, 4723.357929115761, 4783.354247176656, 4869.196582563837, 4878.0975519529, 10066.295359324777, 10068.04353586408, 10069.496525173712, 10069.597216111273, 10070.899291006996, 5468.671879687232, 5477.260569823103, 5477.589180811376, 5481.0, 5485.698286594195, 4104.979475102606, 4499.932501012488, 4609.124266389375, 4982.451930287665, 5096.159133742965, 3984.242993831163, 4000.2599519089063, 4079.918401631951, 4081.9795901020307, 4088.6524645405475, 1179.4515550269166, 1213.0598785940967, 1215.7568486302775, 1226.3500344817262, 1242.4781591731314, 946.5693109635099, 948.1940350701987, 948.3598570964572, 948.79126592151, 994.6866736977829, 5739.7704091836695, 5830.679312637761, 5941.197938278277, 5979.5814292999075, 6147.754089836446, 473.41769623363456, 475.6551500162424, 476.3212422298211, 477.32696897374535, 478.40916468161794, 4050.1697152083752, 4064.1058967027207, 4069.898252543651, 4098.7950602469755, 4234.9364759528635, 11409.201355905174, 11692.123090768226, 11744.29534227932, 11757.88242117585, 11815.0, 11626.70933226676, 11634.53461861533, 11637.825432618518, 11655.358955257543, 11659.76680466386, 8149.0, 8446.282066024456, 8458.36562257833, 8583.785405364915, 8658.87011694825, 6021.789237376671, 6123.877522449615, 6144.293406258159, 6247.781327653511, 6258.812235632939, 10342.689719308433, 10738.302010369302, 10787.6224332148, 10801.24391292602, 10860.565577377132, 9774.413535187912, 10999.120070394509, 11027.0, 11066.833997490205, 11068.225224234226, 7613.619319034137, 7715.768526944201, 7801.414893882868, 7968.641411136628, 7969.402294827795, 8453.915460845314, 8706.695265665672, 8815.074417186102, 8918.643254269757, 8985.595648195716, 8055.1944805521325, 8152.551609661526, 8164.224398682116, 8200.0, 8341.20758527939, 7919.643616037177, 7955.204479551999, 7982.6008699565955, 8024.117347091698, 8061.919380806117, 7177.856442871009, 7217.747378841926, 7222.34998850085, 7233.0, 7235.2764723527225, 5048.873778155576, 5214.713190774544, 5247.0, 5300.761465734128, 5406.83779486616, 5303.204519322133, 5322.547583455294, 5404.7297635118875, 5460.099083651153, 5462.371827239918], "value": 4689.9428764526565, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [336.26861576072037, 339.1994892054751, 345.5180023866705, 345.54905847868537, 348.445970906259, 5233.973830130849, 5285.867853303669, 5293.444188360225, 5298.7350632468415, 5310.575153987681, 5198.09033419152, 5215.947840521603, 5229.424763276036, 5235.528802407783, 5241.9213711794355, 4081.1225586498895, 4110.198511290285, 4171.958280417202, 4191.476065491821, 4232.555581663927, 4131.772752498611, 4145.730527515701, 4179.853705120321, 4183.6653067754505, 4191.455110835603, 4083.97958010211, 4085.632293093621, 4135.421041054255, 4140.917181656365, 4156.314208155651, 3906.7655940643654, 3985.9402108968097, 4088.672906167529, 4137.979310103446, 4139.482564679415, 3690.7231957603285, 3691.2986532559, 3693.076730817296, 3693.630636936312, 3711.164987877733, 5057.69653820772, 5063.721495317756, 5115.744212789383, 5134.0758663440565, 5144.588432925394, 4490.461144662629, 4633.814647414099, 4714.6935449196035, 4754.106545508991, 4793.137235297645, 5421.810236641699, 5426.806102657409, 5431.402545719968, 5442.537384322337, 5454.699991500466, 4051.4125451809323, 4057.8435145983253, 4081.673466122733, 4089.325261331877, 4108.876733697994, 5603.571089372224, 5608.158776183564, 5614.831555053355, 5679.375268720438, 5708.40061793514, 4165.875023749292, 4171.019810344566, 4174.373843923436, 4186.120914607966, 4204.936925946114, 4252.4259225004225, 4256.297710877732, 4256.8297268109545, 4257.042165512735, 4257.297545904891, 4667.6265898728025, 4686.3204835299375, 4724.929126063112, 4765.0231702500905, 4789.401324834395, 5475.780968761205, 5486.341639003345, 5494.0, 5494.203340515603, 5521.4478552144465, 1448.507507447473, 1469.382859199139, 1469.992650036743, 1470.1767010474168, 1471.2129010979074, 902.8849371026777, 942.6182396129578, 951.2009911674088, 956.7799406136488, 972.5672075926145, 4737.976310118427, 4740.928886066643, 4751.073540659608, 4762.499937506581, 4800.5199480051715, 4932.975335123301, 4960.883801144786, 4973.676711013773, 4976.2286845539, 5001.499850015042, 4562.361269422284, 4742.5731684148595, 4750.596199323028, 4765.213739732905, 4793.209120495079, 2634.499445105424, 2645.603159526048, 2654.615080813271, 2657.4321150521287, 2658.8566916225823, 5156.458571849977, 5163.896722065538, 5180.689158650418, 5203.569018519862, 5220.642632915469, 4835.879103022453, 5033.748312584356, 5053.36832895888, 5095.668781529189, 5105.668131571436, 5165.9483405165465, 5171.534561889448, 5174.922376164361, 5185.559227465707, 5196.908649183713, 5014.749262536931, 5031.698098114125, 5048.570871475966, 5079.847604571869, 5084.694918304914, 4756.9524304756505, 4874.366332376769, 4909.582685471775, 4911.361523001987, 4941.604671626189, 5065.214891691794, 5107.361579802525, 5123.692578445305, 5136.691798492103, 5159.329287192641, 3777.8866634001024, 3818.770873747584, 3823.2353529293696, 3837.5394952605866, 3846.9038274043373, 5064.29099926018, 5084.720340381315, 5255.553277971415, 5655.88688226225, 5659.6321239119325, 5519.199716041071, 5525.254090697865, 5527.153515939214, 5530.91703624454, 5532.253145825262, 5534.723263836872, 5536.584756143225, 5539.639923404966, 5567.526760225426, 5569.721513924206, 5210.707288792919, 5481.671099734029, 5511.311086114236, 5520.503154716095, 5523.171524271392, 5311.203319502106, 5394.487523685244, 5544.667319960815, 5588.832335029955, 5607.523360514402, 5470.753816078206, 5494.2857428534035, 5513.228148059195, 5517.420670829505, 5518.2826232589505], "value": 4085.09773437546, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [717.8133685241836, 726.6548389514979, 761.5866056204299, 800.4276941986482, 811.233384451693, 14023.789643155347, 15219.315130819099, 15225.16261605614, 15313.923430382833, 15374.077555346674, 13290.667733306673, 13310.933445332785, 13312.26782526963, 13315.267660278681, 13327.866721332784, 647.757091090841, 789.5933594198964, 789.8933643958078, 820.7045463633087, 825.6697321071559, 817.1093508076195, 823.4976664234842, 830.2030051150903, 830.2361827119034, 830.3647709502205, 863.1756672377865, 864.006392648453, 865.5628907401754, 867.4838471109712, 867.7310033889482, 680.2585182151479, 863.6718047142109, 864.2524216552699, 864.4726716702806, 864.6800683747023, 601.0323379359228, 621.8134559632138, 622.4273668225244, 624.8375422390166, 625.3746253746253, 12441.253524788452, 12469.127161098726, 12486.75026499465, 12489.562865299671, 12510.31193284369, 14198.574042778733, 14225.430982760678, 14335.354909029118, 14816.185109818956, 15166.545003649799, 12399.628011159679, 12529.248245105322, 12781.233126012468, 13024.739505209938, 13381.732365352736, 4390.275604525282, 4390.429244198266, 4452.577005184502, 4453.532379100213, 4619.353290539327, 67754.0, 69582.30417695809, 69666.0, 76834.23165768327, 76920.23079769187, 11821.645350639494, 11846.960188564717, 11962.880371196177, 12044.21712588679, 12160.209586377034, 21588.35234942954, 21807.454813629785, 21819.781802181777, 21826.236081737065, 21909.671354929687, 8621.655133794704, 8825.249853762502, 8835.072317406708, 8854.38019338653, 8859.778505537413, 4864.927026094611, 4901.607871370282, 4901.828436004723, 4977.626677999165, 5055.039542486916, 3556.964430355715, 3636.5272514572935, 3690.6493883081066, 3692.1138926657945, 3702.3520883845217, 621.5897507644933, 625.2653132569213, 627.9231118631569, 633.882731694638, 636.7198432689602, 702.6416527570873, 709.4395427612128, 739.4010851210537, 745.5526683989563, 754.5208792416745, 9982.550785214682, 10176.0, 10411.531481083219, 10488.213383996232, 10502.947485262524, 713.4352004543761, 718.7735863203179, 724.9166345870187, 757.4130049211905, 761.9238076192447, 4956.752162391866, 4970.701757894538, 5037.722925239147, 5073.188289873677, 5076.949230507722, 116236.0, 128268.35865820611, 128806.0, 131237.0, 132941.0, 68290.0, 83117.0, 84287.0, 93362.06637933533, 106999.4650026745, 62112.9999999991, 71043.0, 83799.5810020946, 85013.0, 86607.56696216478, 9884.209263258777, 10359.430231337348, 10560.630377936735, 10575.506628976158, 10700.357978521313, 48359.758201208766, 48360.75819620879, 48769.51230487791, 50173.0, 50503.747481262355, 64540.0, 66666.33333666601, 71107.64446177737, 71870.0, 73619.0, 13575.456981720621, 13895.444182232597, 13915.58253252404, 14057.0, 14157.646058848612, 15830.60423489422, 16082.0, 16655.333786648884, 16852.915735421244, 16871.7469237964, 14830.555083347517, 15019.474318398803, 15471.458498952483, 15727.370905164124, 15957.281922313292, 14366.497172599327, 14523.636909077357, 14567.19325359149, 14582.85417145815, 14923.626909327353, 14099.788503172666, 14434.278286085444, 14440.277986100864, 14606.12363258208, 15059.096454212782, 11567.617413894772, 12069.27584344942, 12142.817857732318, 12185.939070304592, 12268.877311226774, 10036.397816131055, 12114.606820215435, 12133.272003679807, 12164.073550212179, 12545.686357841127], "value": 7689.355469755284, "unit": "score"}], "name": "dromaeo_css", "value": 7250.7522975367665, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 113.0, 111.0, 110.0, 121.0, 111.0, 109.0, 110.0, 109.0, 111.0], "value": 110.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 118.0, 120.0, 197.0, 119.0, 119.0, 141.0, 117.0, 150.0, 118.0], "value": 134.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 158.0, 159.0, 160.0, 162.0, 161.0, 162.0, 161.0, 161.0, 161.0], "value": 160.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 76.0, 75.0, 117.0, 75.0, 76.0, 74.0, 73.0, 113.0, 74.0], "value": 83.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 120.0, 84.0, 83.0, 84.0, 114.0, 83.0, 85.0, 133.0], "value": 95.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 116.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 145.0, 146.0, 146.0, 145.0, 146.0, 145.0, 146.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 51.0, 51.0, 50.0, 49.0, 51.0, 49.0, 50.0, 49.0, 49.0], "value": 49.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 61.0, 60.0, 60.0, 61.0, 60.0, 61.0, 60.0, 61.0], "value": 60.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 81.0, 82.0, 76.0, 76.0, 75.0, 75.0, 80.0], "value": 77.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 121.0, 120.0, 119.0, 120.0, 128.0, 119.0, 130.0, 136.0, 134.0], "value": 124.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 157.0, 163.0, 159.0, 156.0, 156.0, 156.0, 158.0, 156.0, 157.0], "value": 157.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 64.0, 62.0, 62.0, 63.0, 64.0, 62.0, 61.0, 62.0], "value": 62.5, "unit": "score"}], "name": "kraken", "value": 1475.1000000000001, "alertThreshold": 2.0}]} 23:36:52 INFO - Return code: 0 23:36:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 23:36:52 INFO - # TBPL SUCCESS # 23:36:52 INFO - Running post-action listener: _resource_record_post_action 23:36:52 INFO - [mozharness: 2016-08-10 06:36:52.818651Z] Finished run-tests step (success) 23:36:52 INFO - Running post-run listener: _resource_record_post_run 23:36:52 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 40960; Write bytes: 305942528; Read time: 80; Write time: 236616 23:36:52 INFO - TinderboxPrint: CPU usage
13.1% 23:36:52 INFO - TinderboxPrint: I/O read bytes / time
40,960 / 80 23:36:52 INFO - TinderboxPrint: I/O write bytes / time
305,942,528 / 236,616 23:36:52 INFO - TinderboxPrint: CPU idle
8,289.2 (86.9%) 23:36:52 INFO - TinderboxPrint: CPU user
1,202.3 (12.6%) 23:36:52 INFO - TinderboxPrint: Swap in / out
0 / 0 23:36:52 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 36864; Write bytes: 13844480; Read time: 60; Write time: 2396 23:36:52 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 0; Write bytes: 291536896; Read time: 0; Write time: 234128 23:36:53 INFO - Running post-run listener: _upload_blobber_files 23:36:53 INFO - Blob upload gear active. 23:36:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:36:53 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 23:36:53 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'] 23:36:53 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 23:36:53 INFO - (blobuploader) - INFO - Open directory for files ... 23:36:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:36:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:36:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:36:56 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:36:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:36:56 INFO - (blobuploader) - INFO - Done attempting. 23:36:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 23:36:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:36:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:36:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 23:36:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:36:57 INFO - (blobuploader) - INFO - Done attempting. 23:36:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 23:36:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:36:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:36:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 23:36:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:36:58 INFO - (blobuploader) - INFO - Done attempting. 23:36:58 INFO - (blobuploader) - INFO - Iteration through files over. 23:36:58 INFO - Return code: 0 23:36:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:36:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:36:58 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7c17d09fd969e16b0e386004d1304e118ef3138672beb8c57d66afe43b64741afb3f24834b3cd54aa1be81853ebd82d91503db259040ef7d2454dadce4d15007", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5875e33e044501e80d439aa78bcac0238afae9730b565e7311a904536a6b3d4b1fe10ed151d740393c3516f71ff742dec02caf4e15fb63b4f2f12b58fa91f543", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3872a13580687b32927d73e8c983cadc9780d772d2a79ab783e5649cc402e1e86c193bbff7703198e870f9b9b4806b805788973938135066db68cacae7adbe00"} 23:36:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:36:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:36:58 INFO - Contents: 23:36:58 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7c17d09fd969e16b0e386004d1304e118ef3138672beb8c57d66afe43b64741afb3f24834b3cd54aa1be81853ebd82d91503db259040ef7d2454dadce4d15007", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5875e33e044501e80d439aa78bcac0238afae9730b565e7311a904536a6b3d4b1fe10ed151d740393c3516f71ff742dec02caf4e15fb63b4f2f12b58fa91f543", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3872a13580687b32927d73e8c983cadc9780d772d2a79ab783e5649cc402e1e86c193bbff7703198e870f9b9b4806b805788973938135066db68cacae7adbe00"} 23:36:58 INFO - Running post-run listener: copy_logs_to_upload_dir 23:36:58 INFO - Copying logs to upload dir... 23:36:58 INFO - mkdir: /builds/slave/test/build/upload/logs 23:36:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.409473 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-08-09 23:36:58.382501) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-09 23:36:58.385647) ========= 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=af724c981e2a0f424dbabf99000001e7-1470809129.142214-1583716776 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/7c17d09fd969e16b0e386004d1304e118ef3138672beb8c57d66afe43b64741afb3f24834b3cd54aa1be81853ebd82d91503db259040ef7d2454dadce4d15007", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5875e33e044501e80d439aa78bcac0238afae9730b565e7311a904536a6b3d4b1fe10ed151d740393c3516f71ff742dec02caf4e15fb63b4f2f12b58fa91f543", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3872a13580687b32927d73e8c983cadc9780d772d2a79ab783e5649cc402e1e86c193bbff7703198e870f9b9b4806b805788973938135066db68cacae7adbe00"} build_url:https://queue.taskcluster.net/v1/task/Bx1HG7suR9S32CFMhYJS4w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011249 build_url: 'https://queue.taskcluster.net/v1/task/Bx1HG7suR9S32CFMhYJS4w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7c17d09fd969e16b0e386004d1304e118ef3138672beb8c57d66afe43b64741afb3f24834b3cd54aa1be81853ebd82d91503db259040ef7d2454dadce4d15007", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5875e33e044501e80d439aa78bcac0238afae9730b565e7311a904536a6b3d4b1fe10ed151d740393c3516f71ff742dec02caf4e15fb63b4f2f12b58fa91f543", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3872a13580687b32927d73e8c983cadc9780d772d2a79ab783e5649cc402e1e86c193bbff7703198e870f9b9b4806b805788973938135066db68cacae7adbe00"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-09 23:36:58.410413) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 23:36:58.410726) ========= 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=af724c981e2a0f424dbabf99000001e7-1470809129.142214-1583716776 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004423 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 23:36:58.496218) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-09 23:36:58.496528) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-09 23:36:58.496853) ========= ========= Total master_lag: 0.17 =========