builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-034 starttime: 1470593332.43 results: success (0) buildid: 20160807083018 builduid: 73ce509f9c814920b40831a18f3fd279 revision: 019bbc497f9ed565fda0de3479d2b6af015f5f83 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-07 11:08:52.425324) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-07 11:08:52.425995) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-07 11:08:52.426275) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-07 11:08:52.539529) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 11:08:52.539778) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1470591078.860452-889247057 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-07 11:08:52-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 86.4M=0s 2016-08-07 11:08:53 (86.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.134742 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 11:08:52.688923) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 11:08:52.689222) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1470591078.860452-889247057 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018892 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 11:08:52.743214) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 11:08:52.743555) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 019bbc497f9ed565fda0de3479d2b6af015f5f83 --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 019bbc497f9ed565fda0de3479d2b6af015f5f83 --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=d6bbd613908ccac0c6c9cb47000001f7-1470591078.860452-889247057 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-07 11:08:53,155 truncating revision to first 12 chars 2016-08-07 11:08:53,155 Setting DEBUG logging. 2016-08-07 11:08:53,155 attempt 1/10 2016-08-07 11:08:53,155 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/019bbc497f9e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-07 11:08:53,459 unpacking tar archive at: fx-team-019bbc497f9e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.609230 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 11:08:53.369473) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-07 11:08:53.369759) ========= script_repo_revision: 019bbc497f9ed565fda0de3479d2b6af015f5f83 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-07 11:08:53.370125) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-07 11:08:53.370395) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-07 11:08:53.378286) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-08-07 11:08:53.378587) ========= /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=d6bbd613908ccac0c6c9cb47000001f7-1470591078.860452-889247057 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:08:53 INFO - MultiFileLogger online at 20160807 11:08:53 in /builds/slave/test 11:08:53 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 11:08:53 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:08:53 INFO - {'append_to_log': False, 11:08:53 INFO - 'base_work_dir': '/builds/slave/test', 11:08:53 INFO - 'blob_upload_branch': 'Fx-Team', 11:08:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:08:53 INFO - 'branch': 'Fx-Team', 11:08:53 INFO - 'buildbot_json_path': 'buildprops.json', 11:08:53 INFO - 'config_files': ('talos/linux_config.py',), 11:08:53 INFO - 'default_actions': ('clobber', 11:08:53 INFO - 'read-buildbot-config', 11:08:53 INFO - 'download-and-extract', 11:08:53 INFO - 'populate-webroot', 11:08:53 INFO - 'create-virtualenv', 11:08:53 INFO - 'install', 11:08:53 INFO - 'run-tests'), 11:08:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:08:53 INFO - 'download_minidump_stackwalk': True, 11:08:53 INFO - 'download_symbols': 'ondemand', 11:08:53 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:08:53 INFO - 'tooltool.py': '/tools/tooltool.py', 11:08:53 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:08:53 INFO - '/tools/misc-python/virtualenv.py')}, 11:08:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:08:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:08:53 INFO - 'installer_path': 'installer.exe', 11:08:53 INFO - 'log_level': 'info', 11:08:53 INFO - 'log_name': 'talos', 11:08:53 INFO - 'log_to_console': True, 11:08:53 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:08:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:08:53 INFO - 'opt_config_files': (), 11:08:53 INFO - 'pip_index': False, 11:08:53 INFO - 'sps_profile': False, 11:08:53 INFO - 'sps_profile_interval': 0, 11:08:53 INFO - 'suite': 'dromaeojs', 11:08:53 INFO - 'system_bits': '32', 11:08:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:08:53 INFO - 'title': 'talos-linux64-ix-034', 11:08:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:08:53 INFO - 'use_talos_json': True, 11:08:53 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:08:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:08:53 INFO - 'work_dir': 'build'} 11:08:53 INFO - [mozharness: 2016-08-07 18:08:53.881033Z] Running clobber step. 11:08:53 INFO - Running pre-action listener: _resource_record_pre_action 11:08:53 INFO - Running main action method: clobber 11:08:53 INFO - rmtree: /builds/slave/test/build 11:08:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:08:54 INFO - Running post-action listener: _resource_record_post_action 11:08:54 INFO - [mozharness: 2016-08-07 18:08:54.335968Z] Finished clobber step (success) 11:08:54 INFO - [mozharness: 2016-08-07 18:08:54.336071Z] Running read-buildbot-config step. 11:08:54 INFO - Running pre-action listener: _resource_record_pre_action 11:08:54 INFO - Running main action method: read_buildbot_config 11:08:54 INFO - Using buildbot properties: 11:08:54 INFO - { 11:08:54 INFO - "project": "", 11:08:54 INFO - "product": "firefox", 11:08:54 INFO - "script_repo_revision": "production", 11:08:54 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 11:08:54 INFO - "repository": "", 11:08:54 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 11:08:54 INFO - "buildid": "20160807083018", 11:08:54 INFO - "pgo_build": "True", 11:08:54 INFO - "basedir": "/builds/slave/test", 11:08:54 INFO - "buildnumber": 959, 11:08:54 INFO - "slavename": "talos-linux64-ix-034", 11:08:54 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:08:54 INFO - "platform": "ubuntu64_hw", 11:08:54 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 11:08:54 INFO - "branch": "fx-team", 11:08:54 INFO - "repo_path": "integration/fx-team", 11:08:54 INFO - "revision": "019bbc497f9ed565fda0de3479d2b6af015f5f83", 11:08:54 INFO - "stage_platform": "linux64-pgo", 11:08:54 INFO - "builduid": "73ce509f9c814920b40831a18f3fd279", 11:08:54 INFO - "slavebuilddir": "test" 11:08:54 INFO - } 11:08:54 INFO - Found installer url https://queue.taskcluster.net/v1/task/C-X4E9QSTZiRRInGEGHaFw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 11:08:54 INFO - Running post-action listener: _resource_record_post_action 11:08:54 INFO - [mozharness: 2016-08-07 18:08:54.338542Z] Finished read-buildbot-config step (success) 11:08:54 INFO - [mozharness: 2016-08-07 18:08:54.338632Z] Running download-and-extract step. 11:08:54 INFO - Running pre-action listener: _resource_record_pre_action 11:08:54 INFO - Running main action method: download_and_extract 11:08:54 INFO - mkdir: /builds/slave/test/build/tests 11:08:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:08:54 INFO - trying https://queue.taskcluster.net/v1/task/C-X4E9QSTZiRRInGEGHaFw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 11:08:54 INFO - Downloading https://queue.taskcluster.net/v1/task/C-X4E9QSTZiRRInGEGHaFw/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 11:08:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/C-X4E9QSTZiRRInGEGHaFw/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 11:08:54 INFO - Downloaded 1361 bytes. 11:08:54 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 11:08:54 INFO - Using the following test package requirements: 11:08:54 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 11:08:54 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:08:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:08:54 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:08:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:08:54 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:08:54 INFO - u'jsshell-linux-x86_64.zip'], 11:08:54 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:08:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:08:54 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 11:08:54 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:08:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:08:54 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:08:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:08:54 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:08:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:08:54 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:08:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:08:54 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:08:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:08:54 INFO - trying https://queue.taskcluster.net/v1/task/C-X4E9QSTZiRRInGEGHaFw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 11:08:54 INFO - Downloading https://queue.taskcluster.net/v1/task/C-X4E9QSTZiRRInGEGHaFw/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 11:08:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/C-X4E9QSTZiRRInGEGHaFw/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 11:08:55 INFO - Downloaded 21828425 bytes. 11:08:55 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'] 11:08:55 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 11:08:57 INFO - Return code: 0 11:08:57 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 11:08: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')]} 11:08:57 INFO - trying https://queue.taskcluster.net/v1/task/C-X4E9QSTZiRRInGEGHaFw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 11:08:57 INFO - Downloading https://queue.taskcluster.net/v1/task/C-X4E9QSTZiRRInGEGHaFw/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 11:08:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/C-X4E9QSTZiRRInGEGHaFw/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 11:08:58 INFO - Downloaded 21828425 bytes. 11:08:58 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'] 11:08:58 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 11:08:59 INFO - Return code: 0 11:08:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:08:59 INFO - trying https://queue.taskcluster.net/v1/task/C-X4E9QSTZiRRInGEGHaFw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 11:08:59 INFO - Downloading https://queue.taskcluster.net/v1/task/C-X4E9QSTZiRRInGEGHaFw/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 11:08:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/C-X4E9QSTZiRRInGEGHaFw/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 11:09:00 INFO - Downloaded 14413723 bytes. 11:09:00 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'] 11:09:00 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 11:09:00 INFO - Return code: 0 11:09:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:09:00 INFO - trying https://queue.taskcluster.net/v1/task/C-X4E9QSTZiRRInGEGHaFw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 11:09:00 INFO - Downloading https://queue.taskcluster.net/v1/task/C-X4E9QSTZiRRInGEGHaFw/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 11:09:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/C-X4E9QSTZiRRInGEGHaFw/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 11:09:05 INFO - Downloaded 59974880 bytes. 11:09:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/C-X4E9QSTZiRRInGEGHaFw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 11:09:05 INFO - mkdir: /builds/slave/test/properties 11:09:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:09:05 INFO - Writing to file /builds/slave/test/properties/build_url 11:09:05 INFO - Contents: 11:09:05 INFO - build_url:https://queue.taskcluster.net/v1/task/C-X4E9QSTZiRRInGEGHaFw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 11:09:06 INFO - Running post-action listener: _resource_record_post_action 11:09:06 INFO - Running post-action listener: set_extra_try_arguments 11:09:06 INFO - [mozharness: 2016-08-07 18:09:06.339143Z] Finished download-and-extract step (success) 11:09:06 INFO - [mozharness: 2016-08-07 18:09:06.339377Z] Running populate-webroot step. 11:09:06 INFO - Running pre-action listener: _resource_record_pre_action 11:09:06 INFO - Running main action method: populate_webroot 11:09:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:09:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:09:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:09:06 INFO - '--tppagecycles', 11:09:06 INFO - '7'], 11:09:06 INFO - 'tests': ['tsvgm']}}, 11:09:06 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:09:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:09:06 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:09:06 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:09:06 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:09:06 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:09:06 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:09:06 INFO - 'talos_options': ['--disable-e10s'], 11:09:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:09:06 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:09:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:09:06 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:09:06 INFO - 'talos_options': ['--disable-e10s'], 11:09:06 INFO - 'tests': ['damp', 'tps']}, 11:09:06 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:09:06 INFO - 'tests': ['damp', 'tps']}, 11:09:06 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:09:06 INFO - 'tests': ['dromaeo_dom']}, 11:09:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:09:06 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:09:06 INFO - 'tests': ['basic_compositor_video']}, 11:09:06 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:09:06 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:09:06 INFO - 'tests': ['a11yr', 11:09:06 INFO - 'ts_paint', 11:09:06 INFO - 'tpaint', 11:09:06 INFO - 'sessionrestore', 11:09:06 INFO - 'sessionrestore_no_auto_restore', 11:09:06 INFO - 'tabpaint']}, 11:09:06 INFO - 'other-e10s': {'tests': ['a11yr', 11:09:06 INFO - 'ts_paint', 11:09:06 INFO - 'tpaint', 11:09:06 INFO - 'sessionrestore', 11:09:06 INFO - 'sessionrestore_no_auto_restore', 11:09:06 INFO - 'tabpaint']}, 11:09:06 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:09:06 INFO - 'ts_paint', 11:09:06 INFO - 'tpaint', 11:09:06 INFO - 'sessionrestore', 11:09:06 INFO - 'sessionrestore_no_auto_restore', 11:09:06 INFO - 'tabpaint']}, 11:09:06 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:09:06 INFO - 'ts_paint', 11:09:06 INFO - 'tpaint', 11:09:06 INFO - 'sessionrestore', 11:09:06 INFO - 'sessionrestore_no_auto_restore', 11:09:06 INFO - 'tabpaint']}, 11:09:06 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:09:06 INFO - 'tests': ['a11yr', 11:09:06 INFO - 'ts_paint', 11:09:06 INFO - 'tpaint', 11:09:06 INFO - 'sessionrestore', 11:09:06 INFO - 'sessionrestore_no_auto_restore', 11:09:06 INFO - 'tabpaint']}, 11:09:06 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:09:06 INFO - 'tests': ['a11yr', 11:09:06 INFO - 'ts_paint', 11:09:06 INFO - 'tpaint', 11:09:06 INFO - 'sessionrestore', 11:09:06 INFO - 'sessionrestore_no_auto_restore', 11:09:06 INFO - 'tabpaint']}, 11:09:06 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:09:06 INFO - 'tests': ['tsvgx', 11:09:06 INFO - 'tsvgr_opacity', 11:09:06 INFO - 'tart', 11:09:06 INFO - 'tscrollx', 11:09:06 INFO - 'cart']}, 11:09:06 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:09:06 INFO - 'tsvgr_opacity', 11:09:06 INFO - 'tart', 11:09:06 INFO - 'tscrollx', 11:09:06 INFO - 'cart']}, 11:09:06 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:09:06 INFO - 'talos_options': ['--disable-e10s'], 11:09:06 INFO - 'tests': ['tp5o']}, 11:09:06 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:09:06 INFO - 'tests': ['tp5o']}, 11:09:06 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:09:06 INFO - 'talos_options': ['--disable-e10s', 11:09:06 INFO - '--xperf_path', 11:09:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:09:06 INFO - 'tests': ['tp5n']}, 11:09:06 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:09:06 INFO - 'talos_options': ['--xperf_path', 11:09:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:09:06 INFO - 'tests': ['tp5n']}}, 11:09:06 INFO - 'talos.zip': {'path': '', 11:09:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:09:06 INFO - Running post-action listener: _resource_record_post_action 11:09:06 INFO - [mozharness: 2016-08-07 18:09:06.356571Z] Finished populate-webroot step (success) 11:09:06 INFO - [mozharness: 2016-08-07 18:09:06.356661Z] Running create-virtualenv step. 11:09:06 INFO - Running pre-action listener: _resource_record_pre_action 11:09:06 INFO - Running main action method: create_virtualenv 11:09:06 INFO - Creating virtualenv /builds/slave/test/build/venv 11:09:06 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 11:09:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:09:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:09:06 INFO - Using real prefix '/usr' 11:09:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:09:06 INFO - Installing distribute.............................................................................................................................................................................................done. 11:09:08 INFO - Installing pip.................done. 11:09:08 INFO - Return code: 0 11:09:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:09:08 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')]} 11:09:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:09:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:08 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')]} 11:09:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:09:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:08 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 0xbff030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xec0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xebe3b0>, '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 0xebf2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xebf740>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1470591078.860452-889247057', '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 11:09:08 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 11:09:08 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 11:09:08 INFO - Using env: {'DISPLAY': ':0', 11:09:08 INFO - 'HOME': '/home/cltbld', 11:09:08 INFO - 'LANG': 'en_US.UTF-8', 11:09:08 INFO - 'LANGUAGE': 'en_US:en', 11:09:08 INFO - 'LOGNAME': 'cltbld', 11:09:08 INFO - 'MAIL': '/var/mail/cltbld', 11:09:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:09:08 INFO - 'MOZ_NO_REMOTE': '1', 11:09:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:09:08 INFO - 'NO_EM_RESTART': '1', 11:09:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:09:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:09:08 INFO - 'PWD': '/builds/slave/test', 11:09:08 INFO - 'SHELL': '/bin/bash', 11:09:08 INFO - 'SHLVL': '1', 11:09:08 INFO - 'TERM': 'linux', 11:09:08 INFO - 'TMOUT': '86400', 11:09:08 INFO - 'USER': 'cltbld', 11:09:08 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1470591078.860452-889247057', 11:09:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:09:08 INFO - '_': '/tools/buildbot/bin/python'} 11:09:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:09:09 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 11:09:09 INFO - Cleaning up... 11:09:09 INFO - Return code: 0 11:09:09 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:09:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:09:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:09:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:09:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:09:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:09 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 0xbff030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xec0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xebe3b0>, '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 0xebf2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xebf740>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1470591078.860452-889247057', '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 11:09:09 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 11:09:09 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 11:09:09 INFO - Using env: {'DISPLAY': ':0', 11:09:09 INFO - 'HOME': '/home/cltbld', 11:09:09 INFO - 'LANG': 'en_US.UTF-8', 11:09:09 INFO - 'LANGUAGE': 'en_US:en', 11:09:09 INFO - 'LOGNAME': 'cltbld', 11:09:09 INFO - 'MAIL': '/var/mail/cltbld', 11:09:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:09:09 INFO - 'MOZ_NO_REMOTE': '1', 11:09:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:09:09 INFO - 'NO_EM_RESTART': '1', 11:09:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:09:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:09:09 INFO - 'PWD': '/builds/slave/test', 11:09:09 INFO - 'SHELL': '/bin/bash', 11:09:09 INFO - 'SHLVL': '1', 11:09:09 INFO - 'TERM': 'linux', 11:09:09 INFO - 'TMOUT': '86400', 11:09:09 INFO - 'USER': 'cltbld', 11:09:09 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1470591078.860452-889247057', 11:09:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:09:09 INFO - '_': '/tools/buildbot/bin/python'} 11:09:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:09:09 INFO - Downloading/unpacking psutil>=3.1.1 11:09:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:09:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:09:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:09:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:09:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:09:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:09:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:09:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:09:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:09:11 INFO - Installing collected packages: psutil 11:09:11 INFO - Running setup.py install for psutil 11:09:11 INFO - building 'psutil._psutil_linux' extension 11:09:11 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 11:09:11 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 11:09:11 INFO - building 'psutil._psutil_posix' extension 11:09:11 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 11:09:11 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 11:09:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:09:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:09:11 INFO - Successfully installed psutil 11:09:11 INFO - Cleaning up... 11:09:11 INFO - Return code: 0 11:09:11 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:09:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:09:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:09:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:09:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:09:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xbff030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xec0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xebe3b0>, '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 0xebf2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xebf740>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1470591078.860452-889247057', '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 11:09:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:09:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:09:11 INFO - Using env: {'DISPLAY': ':0', 11:09:11 INFO - 'HOME': '/home/cltbld', 11:09:11 INFO - 'LANG': 'en_US.UTF-8', 11:09:11 INFO - 'LANGUAGE': 'en_US:en', 11:09:11 INFO - 'LOGNAME': 'cltbld', 11:09:11 INFO - 'MAIL': '/var/mail/cltbld', 11:09:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:09:11 INFO - 'MOZ_NO_REMOTE': '1', 11:09:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:09:11 INFO - 'NO_EM_RESTART': '1', 11:09:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:09:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:09:11 INFO - 'PWD': '/builds/slave/test', 11:09:11 INFO - 'SHELL': '/bin/bash', 11:09:11 INFO - 'SHLVL': '1', 11:09:11 INFO - 'TERM': 'linux', 11:09:11 INFO - 'TMOUT': '86400', 11:09:11 INFO - 'USER': 'cltbld', 11:09:11 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1470591078.860452-889247057', 11:09:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:09:11 INFO - '_': '/tools/buildbot/bin/python'} 11:09:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:09:12 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:09:12 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 11:09:12 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 11:09:12 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 11:09:12 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 11:09:12 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 11:09:12 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 11:09:13 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:09:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:09:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:09:14 INFO - Installing collected packages: mozsystemmonitor 11:09:14 INFO - Running setup.py install for mozsystemmonitor 11:09:14 INFO - Successfully installed mozsystemmonitor 11:09:14 INFO - Cleaning up... 11:09:14 INFO - Return code: 0 11:09:14 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:09: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')]} 11:09:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:09:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09: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')]} 11:09:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:09:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:14 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 0xbff030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xec0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xebe3b0>, '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 0xebf2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xebf740>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1470591078.860452-889247057', '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 11:09:14 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 11:09:14 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 11:09:14 INFO - Using env: {'DISPLAY': ':0', 11:09:14 INFO - 'HOME': '/home/cltbld', 11:09:14 INFO - 'LANG': 'en_US.UTF-8', 11:09:14 INFO - 'LANGUAGE': 'en_US:en', 11:09:14 INFO - 'LOGNAME': 'cltbld', 11:09:14 INFO - 'MAIL': '/var/mail/cltbld', 11:09:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:09:14 INFO - 'MOZ_NO_REMOTE': '1', 11:09:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:09:14 INFO - 'NO_EM_RESTART': '1', 11:09:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:09:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:09:14 INFO - 'PWD': '/builds/slave/test', 11:09:14 INFO - 'SHELL': '/bin/bash', 11:09:14 INFO - 'SHLVL': '1', 11:09:14 INFO - 'TERM': 'linux', 11:09:14 INFO - 'TMOUT': '86400', 11:09:14 INFO - 'USER': 'cltbld', 11:09:14 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1470591078.860452-889247057', 11:09:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:09:14 INFO - '_': '/tools/buildbot/bin/python'} 11:09:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:09:14 INFO - Downloading/unpacking jsonschema==2.5.1 11:09:14 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 11:09:14 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 11:09:14 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 11:09:14 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 11:09:14 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 11:09:14 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 11:09:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:09:16 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:09:16 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 11:09:16 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 11:09:16 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 11:09:16 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 11:09:16 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 11:09:16 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 11:09:16 INFO - Downloading functools32-3.2.3-2.tar.gz 11:09:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:09:16 INFO - warning: no files found matching '*.txt' 11:09:16 INFO - no previously-included directories found matching 'build' 11:09:16 INFO - no previously-included directories found matching 'dist' 11:09:16 INFO - no previously-included directories found matching '.git*' 11:09:16 INFO - Installing collected packages: jsonschema, functools32 11:09:16 INFO - Running setup.py install for functools32 11:09:16 INFO - warning: no files found matching '*.txt' 11:09:16 INFO - no previously-included directories found matching 'build' 11:09:16 INFO - no previously-included directories found matching 'dist' 11:09:16 INFO - no previously-included directories found matching '.git*' 11:09:16 INFO - Successfully installed jsonschema functools32 11:09:16 INFO - Cleaning up... 11:09:16 INFO - Return code: 0 11:09:16 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:09:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:09:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:09:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:09:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:09:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:16 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 0xbff030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xec0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xebe3b0>, '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 0xebf2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xebf740>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1470591078.860452-889247057', '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 11:09:16 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 11:09:16 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 11:09:16 INFO - Using env: {'DISPLAY': ':0', 11:09:16 INFO - 'HOME': '/home/cltbld', 11:09:16 INFO - 'LANG': 'en_US.UTF-8', 11:09:16 INFO - 'LANGUAGE': 'en_US:en', 11:09:16 INFO - 'LOGNAME': 'cltbld', 11:09:16 INFO - 'MAIL': '/var/mail/cltbld', 11:09:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:09:16 INFO - 'MOZ_NO_REMOTE': '1', 11:09:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:09:16 INFO - 'NO_EM_RESTART': '1', 11:09:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:09:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:09:16 INFO - 'PWD': '/builds/slave/test', 11:09:16 INFO - 'SHELL': '/bin/bash', 11:09:16 INFO - 'SHLVL': '1', 11:09:16 INFO - 'TERM': 'linux', 11:09:16 INFO - 'TMOUT': '86400', 11:09:16 INFO - 'USER': 'cltbld', 11:09:16 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1470591078.860452-889247057', 11:09:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:09:16 INFO - '_': '/tools/buildbot/bin/python'} 11:09:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:09:16 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:09:16 INFO - Cleaning up... 11:09:16 INFO - Return code: 0 11:09:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:09:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:09:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:09:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:09:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:09:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:16 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 0xbff030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xec0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xebe3b0>, '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 0xebf2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xebf740>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1470591078.860452-889247057', '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 11:09:16 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 11:09:16 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 11:09:16 INFO - Using env: {'DISPLAY': ':0', 11:09:16 INFO - 'HOME': '/home/cltbld', 11:09:16 INFO - 'LANG': 'en_US.UTF-8', 11:09:16 INFO - 'LANGUAGE': 'en_US:en', 11:09:16 INFO - 'LOGNAME': 'cltbld', 11:09:16 INFO - 'MAIL': '/var/mail/cltbld', 11:09:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:09:16 INFO - 'MOZ_NO_REMOTE': '1', 11:09:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:09:16 INFO - 'NO_EM_RESTART': '1', 11:09:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:09:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:09:16 INFO - 'PWD': '/builds/slave/test', 11:09:16 INFO - 'SHELL': '/bin/bash', 11:09:16 INFO - 'SHLVL': '1', 11:09:16 INFO - 'TERM': 'linux', 11:09:16 INFO - 'TMOUT': '86400', 11:09:16 INFO - 'USER': 'cltbld', 11:09:16 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1470591078.860452-889247057', 11:09:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:09:16 INFO - '_': '/tools/buildbot/bin/python'} 11:09:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:09:17 INFO - Downloading/unpacking blobuploader==1.2.4 11:09:17 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 11:09:17 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 11:09:17 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 11:09:17 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 11:09:17 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 11:09:17 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 11:09:19 INFO - Downloading blobuploader-1.2.4.tar.gz 11:09:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:09:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:09:19 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 11:09:19 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 11:09:19 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 11:09:19 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 11:09:19 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 11:09:19 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 11:09:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:09:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:09:19 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 11:09:19 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 11:09:19 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 11:09:19 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 11:09:19 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 11:09:19 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 11:09:19 INFO - Downloading docopt-0.6.1.tar.gz 11:09:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:09:19 INFO - Installing collected packages: blobuploader, requests, docopt 11:09:19 INFO - Running setup.py install for blobuploader 11:09:19 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:09:19 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:09:19 INFO - Running setup.py install for requests 11:09:20 INFO - Running setup.py install for docopt 11:09:20 INFO - Successfully installed blobuploader requests docopt 11:09:20 INFO - Cleaning up... 11:09:20 INFO - Return code: 0 11:09:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:09:20 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')]} 11:09:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:09:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:20 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')]} 11:09:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:09:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:20 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 0xbff030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xec0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xebe3b0>, '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 0xebf2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xebf740>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1470591078.860452-889247057', '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 11:09:20 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 11:09:20 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 11:09:20 INFO - Using env: {'DISPLAY': ':0', 11:09:20 INFO - 'HOME': '/home/cltbld', 11:09:20 INFO - 'LANG': 'en_US.UTF-8', 11:09:20 INFO - 'LANGUAGE': 'en_US:en', 11:09:20 INFO - 'LOGNAME': 'cltbld', 11:09:20 INFO - 'MAIL': '/var/mail/cltbld', 11:09:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:09:20 INFO - 'MOZ_NO_REMOTE': '1', 11:09:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:09:20 INFO - 'NO_EM_RESTART': '1', 11:09:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:09:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:09:20 INFO - 'PWD': '/builds/slave/test', 11:09:20 INFO - 'SHELL': '/bin/bash', 11:09:20 INFO - 'SHLVL': '1', 11:09:20 INFO - 'TERM': 'linux', 11:09:20 INFO - 'TMOUT': '86400', 11:09:20 INFO - 'USER': 'cltbld', 11:09:20 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1470591078.860452-889247057', 11:09:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:09:20 INFO - '_': '/tools/buildbot/bin/python'} 11:09:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:09:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:09:20 INFO - Running setup.py (path:/tmp/pip-qA_C7n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:09:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:09:20 INFO - Running setup.py (path:/tmp/pip-j216jG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:09:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:09:20 INFO - Running setup.py (path:/tmp/pip-pxNRgd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:09:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:09:20 INFO - Running setup.py (path:/tmp/pip-Z0BWsW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:09:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:09:20 INFO - Running setup.py (path:/tmp/pip-ovzkYO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:09:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:09:21 INFO - Running setup.py (path:/tmp/pip-v8_tpt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:09:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:09:21 INFO - Running setup.py (path:/tmp/pip-oT4g2k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:09:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:09:21 INFO - Running setup.py (path:/tmp/pip-7LyWM1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:09:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:09:21 INFO - Running setup.py (path:/tmp/pip-ko7fH9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:09:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:09:21 INFO - Running setup.py (path:/tmp/pip-SR7dgi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:09:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:09:21 INFO - Running setup.py (path:/tmp/pip-LxQmC3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:09:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:09:21 INFO - Running setup.py (path:/tmp/pip-yuYcxH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:09:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:09:21 INFO - Running setup.py (path:/tmp/pip-zzvRUc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:09:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:09:21 INFO - Running setup.py (path:/tmp/pip-f2kIY9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:09:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:09:21 INFO - Running setup.py (path:/tmp/pip-NWoQnn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:09:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:09:21 INFO - Running setup.py (path:/tmp/pip-fwFvsI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:09:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:09:21 INFO - Running setup.py (path:/tmp/pip-5XzPTr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:09:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:09:21 INFO - Running setup.py install for manifestparser 11:09:21 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:09:21 INFO - Running setup.py install for mozcrash 11:09:22 INFO - Running setup.py install for mozdebug 11:09:22 INFO - Running setup.py install for mozdevice 11:09:22 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:09:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:09:22 INFO - Running setup.py install for mozfile 11:09:22 INFO - Running setup.py install for mozhttpd 11:09:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:09:22 INFO - Running setup.py install for mozinfo 11:09:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:09:22 INFO - Running setup.py install for mozInstall 11:09:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:09:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:09:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:09:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:09:22 INFO - Running setup.py install for mozleak 11:09:22 INFO - Running setup.py install for mozlog 11:09:22 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:09:22 INFO - Running setup.py install for moznetwork 11:09:22 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:09:22 INFO - Running setup.py install for mozprocess 11:09:23 INFO - Running setup.py install for mozprofile 11:09:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:09:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:09:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:09:23 INFO - Running setup.py install for mozrunner 11:09:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:09:23 INFO - Running setup.py install for mozscreenshot 11:09:23 INFO - Running setup.py install for moztest 11:09:23 INFO - Running setup.py install for mozversion 11:09:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:09:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:09:23 INFO - Cleaning up... 11:09:23 INFO - Return code: 0 11:09:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:09:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:09:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:09:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:09:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:09:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:23 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 0xbff030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xec0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xebe3b0>, '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 0xebf2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xebf740>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1470591078.860452-889247057', '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 11:09:23 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 11:09:23 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 11:09:23 INFO - Using env: {'DISPLAY': ':0', 11:09:23 INFO - 'HOME': '/home/cltbld', 11:09:23 INFO - 'LANG': 'en_US.UTF-8', 11:09:23 INFO - 'LANGUAGE': 'en_US:en', 11:09:23 INFO - 'LOGNAME': 'cltbld', 11:09:23 INFO - 'MAIL': '/var/mail/cltbld', 11:09:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:09:23 INFO - 'MOZ_NO_REMOTE': '1', 11:09:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:09:23 INFO - 'NO_EM_RESTART': '1', 11:09:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:09:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:09:23 INFO - 'PWD': '/builds/slave/test', 11:09:23 INFO - 'SHELL': '/bin/bash', 11:09:23 INFO - 'SHLVL': '1', 11:09:23 INFO - 'TERM': 'linux', 11:09:23 INFO - 'TMOUT': '86400', 11:09:23 INFO - 'USER': 'cltbld', 11:09:23 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1470591078.860452-889247057', 11:09:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:09:23 INFO - '_': '/tools/buildbot/bin/python'} 11:09:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:09:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:09:23 INFO - Running setup.py (path:/tmp/pip-Ezmpa1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:09:23 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)) 11:09:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:09:23 INFO - Running setup.py (path:/tmp/pip-tPvVXF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:09:24 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)) 11:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:09:24 INFO - Running setup.py (path:/tmp/pip-pzytlT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:09:24 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)) 11:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:09:24 INFO - Running setup.py (path:/tmp/pip-i0qCdd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:09:24 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)) 11:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:09:24 INFO - Running setup.py (path:/tmp/pip-lhvHYe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:09:24 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)) 11:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:09:24 INFO - Running setup.py (path:/tmp/pip-aUn1PC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:09:24 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)) 11:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:09:24 INFO - Running setup.py (path:/tmp/pip-vY53zj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:09:24 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)) 11:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:09:24 INFO - Running setup.py (path:/tmp/pip-GGR1lb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:09:24 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)) 11:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:09:24 INFO - Running setup.py (path:/tmp/pip-Rb_XsC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:09:24 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)) 11:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:09:24 INFO - Running setup.py (path:/tmp/pip-fF4EBc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:09:24 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)) 11:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:09:24 INFO - Running setup.py (path:/tmp/pip-R30Tfg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:09:24 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)) 11:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:09:24 INFO - Running setup.py (path:/tmp/pip-BAJ_gX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:09:24 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)) 11:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:09:24 INFO - Running setup.py (path:/tmp/pip-GDWiCA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:09:24 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)) 11:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:09:24 INFO - Running setup.py (path:/tmp/pip-mWA3tj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:09:24 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)) 11:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:09:24 INFO - Running setup.py (path:/tmp/pip-Torn6M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:09:24 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)) 11:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:09:24 INFO - Running setup.py (path:/tmp/pip-ZtQxBp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:09:25 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)) 11:09:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:09:25 INFO - Running setup.py (path:/tmp/pip-TqdCdF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:09:25 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)) 11:09:25 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)) 11:09:25 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)) 11:09:25 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)) 11:09:25 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)) 11:09:25 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)) 11:09:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:09:25 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 11:09:25 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 11:09:25 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 11:09:25 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 11:09:25 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 11:09:25 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 11:09:27 INFO - Downloading blessings-1.6.tar.gz 11:09:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:09:27 INFO - Installing collected packages: blessings 11:09:27 INFO - Running setup.py install for blessings 11:09:27 INFO - Successfully installed blessings 11:09:27 INFO - Cleaning up... 11:09:27 INFO - Return code: 0 11:09:27 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:09:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:09:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:09:28 INFO - Reading from file tmpfile_stdout 11:09:28 INFO - Current package versions: 11:09:28 INFO - argparse == 1.2.1 11:09:28 INFO - blessings == 1.6 11:09:28 INFO - blobuploader == 1.2.4 11:09:28 INFO - docopt == 0.6.1 11:09:28 INFO - functools32 == 3.2.3-2 11:09:28 INFO - jsonschema == 2.5.1 11:09:28 INFO - manifestparser == 1.1 11:09:28 INFO - mozInstall == 1.12 11:09:28 INFO - mozcrash == 0.17 11:09:28 INFO - mozdebug == 0.1 11:09:28 INFO - mozdevice == 0.48 11:09:28 INFO - mozfile == 1.2 11:09:28 INFO - mozhttpd == 0.7 11:09:28 INFO - mozinfo == 0.9 11:09:28 INFO - mozleak == 0.1 11:09:28 INFO - mozlog == 3.3 11:09:28 INFO - moznetwork == 0.27 11:09:28 INFO - mozprocess == 0.23 11:09:28 INFO - mozprofile == 0.28 11:09:28 INFO - mozrunner == 6.12 11:09:28 INFO - mozscreenshot == 0.1 11:09:28 INFO - mozsystemmonitor == 0.3 11:09:28 INFO - moztest == 0.7 11:09:28 INFO - mozversion == 1.4 11:09:28 INFO - psutil == 3.1.1 11:09:28 INFO - requests == 1.2.3 11:09:28 INFO - wsgiref == 0.1.2 11:09:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:09:28 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')]} 11:09:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:09:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:28 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')]} 11:09:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:09:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:28 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 0xbff030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xec0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xebe3b0>, '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 0xebf2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xebf740>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1470591078.860452-889247057', '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 11:09:28 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 11:09:28 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 11:09:28 INFO - Using env: {'DISPLAY': ':0', 11:09:28 INFO - 'HOME': '/home/cltbld', 11:09:28 INFO - 'LANG': 'en_US.UTF-8', 11:09:28 INFO - 'LANGUAGE': 'en_US:en', 11:09:28 INFO - 'LOGNAME': 'cltbld', 11:09:28 INFO - 'MAIL': '/var/mail/cltbld', 11:09:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:09:28 INFO - 'MOZ_NO_REMOTE': '1', 11:09:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:09:28 INFO - 'NO_EM_RESTART': '1', 11:09:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:09:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:09:28 INFO - 'PWD': '/builds/slave/test', 11:09:28 INFO - 'SHELL': '/bin/bash', 11:09:28 INFO - 'SHLVL': '1', 11:09:28 INFO - 'TERM': 'linux', 11:09:28 INFO - 'TMOUT': '86400', 11:09:28 INFO - 'USER': 'cltbld', 11:09:28 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1470591078.860452-889247057', 11:09:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:09:28 INFO - '_': '/tools/buildbot/bin/python'} 11:09:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:09:28 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)) 11:09:28 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)) 11:09:28 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)) 11:09:28 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)) 11:09:28 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)) 11:09:28 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)) 11:09:28 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)) 11:09:28 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)) 11:09:28 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)) 11:09:28 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)) 11:09:28 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)) 11:09:28 INFO - Cleaning up... 11:09:28 INFO - Return code: 0 11:09:28 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:09:28 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')]} 11:09:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:09:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:28 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')]} 11:09:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:09:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:28 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 0xbff030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xec0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xebe3b0>, '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 0xebf2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xebf740>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1470591078.860452-889247057', '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 11:09:28 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 11:09:28 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 11:09:28 INFO - Using env: {'DISPLAY': ':0', 11:09:28 INFO - 'HOME': '/home/cltbld', 11:09:28 INFO - 'LANG': 'en_US.UTF-8', 11:09:28 INFO - 'LANGUAGE': 'en_US:en', 11:09:28 INFO - 'LOGNAME': 'cltbld', 11:09:28 INFO - 'MAIL': '/var/mail/cltbld', 11:09:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:09:28 INFO - 'MOZ_NO_REMOTE': '1', 11:09:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:09:28 INFO - 'NO_EM_RESTART': '1', 11:09:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:09:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:09:28 INFO - 'PWD': '/builds/slave/test', 11:09:28 INFO - 'SHELL': '/bin/bash', 11:09:28 INFO - 'SHLVL': '1', 11:09:28 INFO - 'TERM': 'linux', 11:09:28 INFO - 'TMOUT': '86400', 11:09:28 INFO - 'USER': 'cltbld', 11:09:28 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1470591078.860452-889247057', 11:09:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:09:28 INFO - '_': '/tools/buildbot/bin/python'} 11:09:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:09:28 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:09:28 INFO - Cleaning up... 11:09:28 INFO - Return code: 0 11:09:28 INFO - Running post-action listener: _resource_record_post_action 11:09:28 INFO - Running post-action listener: _start_resource_monitoring 11:09:28 INFO - Starting resource monitoring. 11:09:28 INFO - [mozharness: 2016-08-07 18:09:28.512177Z] Finished create-virtualenv step (success) 11:09:28 INFO - [mozharness: 2016-08-07 18:09:28.512621Z] Running install step. 11:09:28 INFO - Running pre-action listener: _resource_record_pre_action 11:09:28 INFO - Running main action method: install 11:09:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:09:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:09:28 INFO - Reading from file tmpfile_stdout 11:09:28 INFO - Detecting whether we're running mozinstall >=1.0... 11:09:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:09:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:09:28 INFO - Reading from file tmpfile_stdout 11:09:28 INFO - Output received: 11:09:28 INFO - Usage: mozinstall [options] installer 11:09:28 INFO - Options: 11:09:28 INFO - -h, --help show this help message and exit 11:09:28 INFO - -d DEST, --destination=DEST 11:09:28 INFO - Directory to install application into. [default: 11:09:28 INFO - "/builds/slave/test"] 11:09:28 INFO - --app=APP Application being installed. [default: firefox] 11:09:28 INFO - mkdir: /builds/slave/test/build/application 11:09:28 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'] 11:09:28 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 11:09:45 INFO - Reading from file tmpfile_stdout 11:09:45 INFO - Output received: 11:09:45 INFO - /builds/slave/test/build/application/firefox/firefox 11:09:45 INFO - Running post-action listener: _resource_record_post_action 11:09:45 INFO - [mozharness: 2016-08-07 18:09:45.923932Z] Finished install step (success) 11:09:45 INFO - [mozharness: 2016-08-07 18:09:45.924179Z] Running run-tests step. 11:09:45 INFO - Running pre-action listener: _resource_record_pre_action 11:09:45 INFO - Running main action method: run_tests 11:09:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:09:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:09:45 INFO - Python 2.7.3 11:09:45 INFO - Return code: 0 11:09:45 INFO - grabbing minidump binary from tooltool 11:09: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')]} 11:09:45 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 0xebe3b0>, '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 0xebf2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xebf740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:09:45 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 11:09:45 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 11:09:45 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 11:09:45 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:09:45 INFO - Return code: 0 11:09:45 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:09:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:09:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:09:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:09:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:09:46 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/C-X4E9QSTZiRRInGEGHaFw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--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 11:09:46 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/C-X4E9QSTZiRRInGEGHaFw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-034 --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 11:09:46 INFO - Using env: {'DISPLAY': ':0', 11:09:46 INFO - 'HOME': '/home/cltbld', 11:09:46 INFO - 'LANG': 'en_US.UTF-8', 11:09:46 INFO - 'LANGUAGE': 'en_US:en', 11:09:46 INFO - 'LOGNAME': 'cltbld', 11:09:46 INFO - 'MAIL': '/var/mail/cltbld', 11:09:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:09:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:09:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:09:46 INFO - 'MOZ_NO_REMOTE': '1', 11:09:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:09:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:09:46 INFO - 'NO_EM_RESTART': '1', 11:09:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:09:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:09:46 INFO - 'PWD': '/builds/slave/test', 11:09:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:09:46 INFO - 'SHELL': '/bin/bash', 11:09:46 INFO - 'SHLVL': '1', 11:09:46 INFO - 'TERM': 'linux', 11:09:46 INFO - 'TMOUT': '86400', 11:09:46 INFO - 'USER': 'cltbld', 11:09:46 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1470591078.860452-889247057', 11:09:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:09:46 INFO - '_': '/tools/buildbot/bin/python'} 11:09:46 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/C-X4E9QSTZiRRInGEGHaFw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--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 11:09:46 INFO - mozversion application_buildid: 20160807083018 11:09:46 INFO - mozversion application_changeset: 019bbc497f9ed565fda0de3479d2b6af015f5f83 11:09:46 INFO - mozversion application_display_name: Nightly 11:09:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:09:46 INFO - mozversion application_name: Firefox 11:09:46 INFO - mozversion application_remotingname: firefox 11:09:46 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:09:46 INFO - mozversion application_vendor: Mozilla 11:09:46 INFO - mozversion application_version: 51.0a1 11:09:46 INFO - mozversion platform_buildid: 20160807083018 11:09:46 INFO - mozversion platform_changeset: 019bbc497f9ed565fda0de3479d2b6af015f5f83 11:09:46 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:09:46 INFO - mozversion platform_version: 51.0a1 11:09:46 INFO - using testdate: 1470593386 11:09:46 INFO - actual date: 1470593386 11:09:46 INFO - starting webserver on 'localhost:46813' 11:09:46 INFO - SUITE-START | Running 2 tests 11:09:46 INFO - TEST-START | dromaeo_css 11:09:46 INFO - operating with platform_type : linux_ 11:09:46 INFO - Initialising browser for dromaeo_css test... 11:09:46 INFO - TEST-INFO | started process 14480 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHXVNTi/profile http://localhost:46813/getInfo.html) 11:09:50 INFO - PROCESS | 14480 | __metrics Screen width/height:1600/1200 11:09:50 INFO - PROCESS | 14480 | colorDepth:24 11:09:50 INFO - PROCESS | 14480 | Browser inner width/height: 1024/697 11:09:50 INFO - PROCESS | 14480 | __metrics 11:09:50 INFO - PROCESS | 14480 | 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" 11:09:50 INFO - PROCESS | 14480 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:09:51 INFO - TEST-INFO | 14480: exit 0 11:09:51 INFO - Browser initialized. 11:09:51 INFO - Running cycle 1/1 for dromaeo_css test... 11:09:51 INFO - TEST-INFO | started process 14560 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHXVNTi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:10:03 INFO - PROCESS | 14560 | RSS: Main: 156340224 11:10:03 INFO - PROCESS | 14560 | 11:10:55 INFO - PROCESS | 14560 | 1470593455336 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] 11:13:04 INFO - PROCESS | 14560 | Cycle 1(1): loaded http://localhost:46813/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46813/tests/dromaeo/cssquery-ext.html) 11:13:05 INFO - PROCESS | 14560 | RSS: Main: 254156800 11:13:05 INFO - PROCESS | 14560 | 11:16:08 INFO - PROCESS | 14560 | Cycle 1(1): loaded http://localhost:46813/tests/dromaeo/cssquery-ext.html (next: http://localhost:46813/tests/dromaeo/cssquery-jquery.html) 11:16:08 INFO - PROCESS | 14560 | RSS: Main: 244219904 11:16:08 INFO - PROCESS | 14560 | 11:19:10 INFO - PROCESS | 14560 | Cycle 1(1): loaded http://localhost:46813/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46813/tests/dromaeo/cssquery-mootools.html) 11:19:11 INFO - PROCESS | 14560 | RSS: Main: 242290688 11:19:11 INFO - PROCESS | 14560 | 11:22:13 INFO - PROCESS | 14560 | Cycle 1(1): loaded http://localhost:46813/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46813/tests/dromaeo/cssquery-prototype.html) 11:22:13 INFO - PROCESS | 14560 | RSS: Main: 240025600 11:22:13 INFO - PROCESS | 14560 | 11:25:16 INFO - PROCESS | 14560 | Cycle 1(1): loaded http://localhost:46813/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46813/tests/dromaeo/cssquery-yui.html) 11:25:16 INFO - PROCESS | 14560 | RSS: Main: 184963072 11:25:16 INFO - PROCESS | 14560 | 11:28:20 INFO - PROCESS | 14560 | Cycle 1(1): loaded http://localhost:46813/tests/dromaeo/cssquery-yui.html (next: http://localhost:46813/tests/dromaeo/cssquery-dojo.html) 11:28:20 INFO - PROCESS | 14560 | RSS: Main: 277336064 11:28:20 INFO - PROCESS | 14560 | 11:28:20 INFO - PROCESS | 14560 | __start_tp_report 11:28:20 INFO - PROCESS | 14560 | _x_x_mozilla_page_load 11:28:20 INFO - PROCESS | 14560 | _x_x_mozilla_page_load_details 11:28:20 INFO - PROCESS | 14560 | |i|pagename|runs| 11:28:20 INFO - PROCESS | 14560 | |0;dojo.html;3026.984865075675;3049.8932537361197;3069.2633767895713;3078.7844850860433;3099.705527974843;5176.120059589869;5233.502817232366;5281.471852814717;5374.731263436827;5404.756785944632;5276.577873770098;5285.709285989269;5311.362636483627;5327.493888080626;5355.919661205085;4760.452547956995;4775.594074503671;4783.641226907996;4805.063012712522;4937.0125974805005;4909.779059942293;4918.680285781431;4921.581665558414;4942.382202224722;4959.57843583294;4753.667243292971;4803.207470767354;4872.731999739995;4903.289023091667;4911.312416261726;4733.360996265495;4743.430788305391;4780.211265141247;4812.109759694433;4834.564889159992;4668.159731248374;4691.179043667379;4706.27052806812;4770.284457331393;4776.068666610013;5104.540591346797;5223.2165175223645;5239.816606418795;5264.052470555299;5276.657017293864;5470.507654311092;5559.054960656698;5584.022796010722;5618.943810561924;5620.100783874561;5598.524125449342;5625.128105143668;5711.371749107595;5713.114467257582;5716.056850619642;5211.2443695663915;5239.423663397023;5312.814051508218;5319.920201197024;5325.4142044375085;5765.4811067004175;5854.765809367663;5859.970700146472;5860.70696465175;5861.531077513874;5621.831345059655;5630.493255607015;5632.295963004624;5634.464725851038;5637.774489020475;5665.291838520185;5705.657660540381;5717.171010203498;5717.199592057115;5717.313922329347;5492.47821456961;5519.530839878575;5581.079121944834;5581.804636837691;5664.405237450009;5574.916376254359;5617.9719101404235;5620.353659329147;5629.408912064257;5630;4308.590683885089;4342.283523218697;4347.673924455678;4361.672874534423;4385.320275357325;3819.923601527954;3839.3665045267217;3876.1666241758157;3880.553736320303;3953.604639536081;5386.326709161355;5389.865253368697;5391.406945236099;5397.136458166675;5431.83704488866;5698.202251684767;5706.572007099484;5712.857178570569;5714.200011998323;5717.885642287214;5227.163653815372;5293.655912365684;5360.758765855546;5369.838904832861;5420.322459692538;4875.927295994876;4878.0975519529;4882.36529251195;4884.218525036048;4923.261510773413;5904.321003084614;5911.586188966903;5914.556408269397;5919.792807251725;5919.970400147971;5577.219189313419;5639.492445679908;5677.148427735708;5679.858003549779;5775.422457754191;5905.586608937333;5912.024515954991;5920.940790592212;5930.169776231417;5933.940660593339;5621.241132447068;5624.100143977108;5634.661920284796;5636.830895073154;5638.689872057076;5489.58828087887;5634.070378387521;5660.405657406078;5685.545156387562;5787.594868359174;5566.165075238747;5591.664500130005;5599.636023658449;5600.215969764155;5605.04714198579;5586.692731899784;5594.888102238014;5597.3003374578175;5597.63615365;5598.552115830642;5365.034293827149;5419.593530485151;5446.591505637014;5475.72621368922;5561.63849349791;5566.415526369673;5567.8886422272135;5608.2148499209325;5614.04561224601;5627.21219029328;5441.945580544144;5442.972785136208;5449.34607847045;5454.045542030208;5456.263404440509 11:28:20 INFO - PROCESS | 14560 | |1;ext.html;595.3362001368473;598.1267349669482;617.2068891474454;627.5105417774138;629.581328416603;32607.51088733668;35109.12227194321;35159.2968140637;35374.1156471088;43902.34146487805;41165;45304.546954530444;45463.77268113655;45474.090518189616;45520.772396137974;8904.732858014253;9076.36465447419;9080.455172689626;9084.954575227115;9085.909140908605;7987.7204297849585;8854.822903541924;8936.955315223448;10447.16422686187;10708.518116684769;10982.736985246678;11061.778764424747;11076.11391088715;11076.446177691123;11077;10899;10948.4525773711;10952.34285942846;10963.616273430393;10967.451627418597;8098.919010809935;10264.89735102647;10654.307470014503;10672;10823.729406764814;44370;44754;44798.55201447976;44825.55174448279;44851;3524.54180956474;3530.8058056806867;3556.5198698175673;3722.8138593070507;3868.6905047596124;33772.662273377195;34087.488687669706;34330;34607.4808877867;35361.29277414437;4424.690271680984;4432.73403595782;4474.9776251118865;4485.170243504962;4679.344891715163;355663;356036;356314;356336;357459;59760.70119649374;60243;60303.69848150731;60395.69802150961;60420.69789651111;62808;63210;63686.68156659187;63720.30936751667;63808;15921.761173582405;16401.507954761375;16407.917960410123;16429.6714065718;16465.25906334218;13481.325933703276;13510.324483775968;13550.45798168082;13557.186568805902;13568.050236483352;15697.293621787047;17312;17783.73324400135;17951.281948722168;18036.90981545084;6606.8348291293105;6760.797176084725;6835.6309755720695;6837.589744615339;6877.552959057645;942.7030485397078;990.9108180263811;1056.7727938493108;1102.5589764094427;1141.1384404774342;32426;33269.14795143027;33414.49878251828;33427.49858752121;33703.32593348168;1080.5839751695496;1101.9779604407868;1110.3837370259423;1152.9365884876245;1240.3364200152876;16460.259288332054;17553.29786808539;17556.473305800846;17649.027964446122;17782.91108544449;541686;664483;675557;676380;677272;59996.40003599908;60531.69734151301;60583.39416605866;64094.35905640977;64512;1230.7784598772128;1349.1770020287618;1388.0630574362265;1413.7313910357;1487.7768334749874;30105.397892042474;34583.65416345804;34806;34976;35148.29703405969;52600.47399526109;53344;53369.46630533645;53402.1989670163;53532.19701704555;452096;455189;455734;455911;456629;44177.77911110424;44502;45262.54737452715;46123.53876461193;46577;49084.26373604327;49997.75001124971;50059.74970125126;50206.246906297165;51320.74339628278;39924.077174955266;42528.36207456952;42643.36034959416;42733;42752.28990840331;40428.393574097;41020;41092.38361424521;42233.57766422419;42605.14789704251;40631.1873762529;40953;41552.58447415608;42263.78868105763;42295.3655695171;35849;37887.62112378841;37993.62006380012;38450.230995380494;38556;28296.575551367157;28684.569731454463;28855.711442885302;28925.681787515314;28969.275768105967 11:28:20 INFO - PROCESS | 14560 | |2;jquery.html;363.723570086734;380.2641887946823;389.3245219544091;391.5653624476831;409.6190542795199;14573.368114958916;16518.834811651894;19816.40550783477;19822;19958.501037474034;19548.218071277133;19934.70097948532;19994.200231990704;20224.59550808983;20245.392638220877;5715.399883012286;5730.255066841305;5753.223314852504;5833.3874943130995;5865.35481097079;5829.504492118175;5852.912206316909;5854.18041474194;5858.41415858415;5860.619059761123;5471.151971444432;5716.742746576414;5826.475617194452;5829.300483941933;5836.533077353823;5589.74846131925;5601.131824567198;5608.551315894719;5615.157726341061;5622.718864056781;5354.518093371616;5441.782328706847;5651.265335506358;5680.091185410356;5691.658500489983;13492.325383730775;13607.455701771918;13609.047366684335;13758.17450952936;13763.724725505534;2157.6979222908803;2221.911123555072;2308.9307320780404;2393.676853624756;2631.2369412870244;9812.264080193943;9832.90167098327;10447.320924139982;12275.93862030693;15167.24163791806;1911.4361263427184;1939.56359819041;1956.8630195886294;1976.3379267945256;2005.729226554411;65680;69097.30902690958;70958.64520677364;84927.57536212279;85757.57121214416;10592.034230415496;11118.610848620421;11161.888381116247;11351.37567433799;11399.829002564968;15403.537893863202;15745.291461884242;15746.133962631937;15748.448804291795;15848.603784905239;6201.689915504297;6298.1812364392335;6377.075324077982;7550.207228241065;8541.572921353907;7920.089189743138;7968.561729104839;8056.637451314705;8247.670093196324;8329.208725171098;4654.813807447664;4733.668643195012;4816.0818684623155;4904.890896914289;4922.753862306942;1867.5891303913118;1894.9336773212872;1986.5629561496737;1990.2337600024096;1998.4504261328252;899.6131663384807;971.3977334052792;1002.9197664186847;1009.3086235928413;1038.200585549138;19437.611247775247;20047.699284510745;20186.596268074558;20234.392968210977;20327.085281162384;906.1934877958622;936.1200471556715;938.0759951447955;956.0726095687172;986.6004268271362;10465.895341046493;11006.669799906016;11134.944325278484;11230.270032447865;11266.211365204521;475471;475592;484247;488080;488386;60753;80102.5994870022;101166.4941675287;101167;102799;969.5782334684435;1006.1849901579598;1010.8483727440796;1038.7299302181486;1046.2414749306845;12959.805602915776;17334.913325433292;18079.63840723152;18766.249350025846;18869.811301886806;43586.346204806316;44268.33597495976;44753.55246447494;45939.31091033704;46609.766951165024;58600;59248.11127833;60236.69881650564;60340.698296508235;61113;8020.639071241691;8325.95837020811;8367.623456944573;8570.271526920282;8647.56762161902;11618.302901825917;13044.608661740163;13230.338483075615;13323.467061317438;13658.180509169482;11183.273087249303;11684.298942063504;11851.525938962344;12240.204386714835;12275.140740148461;11355.886441135814;11690.70773230676;11731.88268117308;11792;11828.112891533341;11634.185607007428;11801.940990294994;11858.525658973544;11932.761344772882;12271.69320766988;7455.627218638938;7639.197884222077;8146.4297499176855;8184.508929464251;8683.696070637498;11020.283681560673;11298.322100673986;11446.42767861587;11528.193026488065;11611.30332180038 11:28:20 INFO - PROCESS | 14560 | |3;mootools.html;1495.4990078323765;1554.8289688134303;1692.839180277874;1744.6249056452875;1819.5269230000197;8619.784505387368;9208.95395523023;9231.123043310892;9244.352895297332;9246.012107396908;7902.091259505159;8568.271696905771;8869.246114080295;8872.778180545489;9077.591508382122;2321.535692861426;2355.3993731598416;2358.2335740884196;2360.775726305998;2361.3624321433203;2369.6919400477914;2415.0219161239725;2451.6445115458246;2453.3498622864868;2454.7422520635346;2402.495475950044;2419.4798118404537;2427.6844010278637;2435.756424357568;2437.524682686877;2346.1671106757026;2349.5653304138705;2353.2940117964627;2362.503874186414;2384.308550520347;2320.9651855222187;2332.918347857834;2339.3215967369442;2342.3792694935855;2347.659589359533;8966.820663586692;9129.726108216697;9176.31177661678;9186.40288381253;9191.264698824078;5311.309529761145;5416.458354164552;5443.720725629474;5447.400785913546;5454.427285135043;3482.2687235680537;3484.4599087141532;3556.715462762973;3558.430651095812;3564.518789963348;1102.7132945434246;1105.0551778229658;1115.654147214366;1128.198978725098;1142.206166714134;12684.619461416172;12715.427805748672;12723.809142862865;12747.872521274761;12761.361931903368;4461.8845288677185;4661.673682842168;4754.952450475451;4808.422989241313;4822.180229361017;10741.83887241692;10745.892541074645;10757.30077544957;10764;10765.56937722498;5418.4039755626845;5420.891582168413;5431.511163995259;5436.972815135978;5438.7280635968045;4121.8969525761495;4797.376341075638;4844.224924012141;4895.143349913751;4973.975130124399;3796.544414670257;3882.3011857865854;3946.2896678597554;4003.3794761811964;4011.458453108793;1244.800831866897;1265.519102740971;1278.469435184388;1292.9482820687067;1310.2924420812653;847.2332539052168;949.7388218240039;966.9758256043515;982.1995074014656;989.5125605379712;5808.30300363959;5950.214935519327;6098.451139397475;6155.169052177898;6179.3820617937845;440.2098233670569;469.68531084173685;473.44606810032343;475.16134023448643;476.9713817170981;4178.456800615901;4351.82592696295;4352.107817897323;4396.186705459436;4401.22978478765;10680.359178449318;11105;11106.833397499044;11115.22193446451;11149.944250278697;10628.893711062945;10928.508217130247;11051.447427628586;11051.889481105087;11056.723581910517;8097.149799271109;8143.959280203561;8164.265216130577;8165.836683266301;8166.1833816619055;5988.401159883977;6005.789797357072;6052.576319657582;6147.415995480601;6257.5932564383165;10086.142677872169;10134.290599658249;10162.136218421518;10193.184545236216;10339;10483;10533.157347412036;10564.683059508227;10621.256512044083;10631.468426578485;6843.931560684528;7615.809604759926;7822.843543128992;7967.322777563972;8065;8706.825863482822;8758.343124265579;8769.824603508021;8771.035186129393;8775.824483510421;7596.050493688289;7732.8453430932195;7848.960755196187;7913.683452661829;7994.5602991836;7325.157606875277;7433.739819106306;7525.134609519975;7625.313721765067;7771.378289736695;7065.964670176616;7120.1099862517185;7174.964125179549;7177.210506844347;7199;4741.217699079613;5178.844634660966;5244.134717771678;5284.7886084556185;5431.076716958048;5203.375594928632;5245.186996015624;5323.1749078892835;5349.545288650508;5419 11:28:20 INFO - PROCESS | 14560 | |4;prototype.html;273.65382790769695;298.64908732239616;300.59569878513406;302.32882999740576;307.7983920532051;5381.408045115039;5397.4872387123205;5408;5410.296661434018;5439.755211015504;5190;5294.57643388529;5302.674331417145;5327.174287985359;5328.813491527797;4101.179764047202;4106.77412742299;4110.588941105895;4113.588641135878;4117.938230926538;4070.5115386153702;4102.528209255944;4122.154958233555;4133.855315063958;4135.503739551258;3937.3503371943593;4020.718549701522;4060.2894493463673;4064.6545043671176;4074.246264441073;4040.9191816163807;4049.7165198436123;4053.8041277823113;4056.71602987791;4059.579147298422;3552.5559305086863;3555.2711694102645;3565.5186549815703;3576.9968817462304;3581.552305961755;5087.9824035193105;5226.137687281594;5235.607329450307;5238.5023422774775;5249.606279529051;4615.399998000272;4618.976905115486;4629.652776041777;4631.614718420016;4631.791569379386;5505.972470137664;5511.476409741068;5526.50261476469;5562.694051827148;5565.499105080562;3636.5999740028574;3890.0663840678035;3894.201688653819;3894.2211557688574;3917.4711413959035;5440.238366628636;5656.349519805234;5674.375818659944;5711.314642242916;5747.540196784247;3913.882583522499;3921.31377009028;3921.627445392683;3932.783696896641;3934.4688467057154;3961.6632586229916;3970.781607011584;3976.165005348851;3979.1245925896837;3979.5025621797276;4373.397828292161;4496.5503449655425;4545.159275452842;4586.656000799953;4587.72473651582;5564.276644036249;5570.303712035996;5574.414686457944;5576.358718747315;5583.609147359646;1335.3857225676297;1346.616214378917;1348.191085348783;1350.7568637645122;1350.770369037266;855.3072011670566;855.9271719770384;867.2498288979987;874.3169398907079;881.6297155194834;4752.358431611758;4786.760661966958;4791.137595232892;4792.281157826354;4794.352762377104;5016.673916195436;5023.6985780853265;5035.244713293036;5045.520675535819;5078.263651770547;4560.908781824345;4693.601043911238;4772.928406073912;4788.976055119702;4800.711957282574;2678.2367025397666;2695.2183866678834;2701.8919243230052;2702.351435655468;2704.5665797127554;5219.381991582622;5228.790848366023;5242.7378631068295;5250.894982100336;5264.947010597895;4995.7561535773275;5058.721770302595;5111.821086261963;5150.459201783834;5159.509846564571;5150.562202212779;5202.271681964528;5214.921776173361;5224.268602395668;5229.973850130725;5010.348654674869;5028.321176641107;5045.571126454146;5086;5112.463191364853;5008.524190201925;5291.788328466818;5463.590230732631;5598.972005139948;5738.68437235956;5982.49148822355;6010.789622363196;6031.487323577545;6031.979286938749;6043.09353596964;3917.0794863207693;3936.291467535871;3941.428492868575;3945.230680017369;3947.210557888491;5548.861278468071;5739.167820666064;5790.639199787962;5815.592908496534;5835.153902684172;5686.488216060575;5694.4590263924865;5704.3154821421695;5715.514181294637;5717.256756621613;5555.8888822224135;5690.890276396063;5701.857453563694;5706.657600543981;5733.684647344269;5566.248556444828;5605.943940560543;5609.298837645294;5616.876624674999;5632.859513384888;5673.659580425187;5674.829755107354;5702.201691763239;5704.144378343116;5717.514011308919;5404.432534583812;5539.806106786243;5551.916721249104;5578.972105139448;5582.33012038558 11:28:20 INFO - PROCESS | 14560 | |5;yui.html;739.4232498651053;761.8362052158785;787.2245837849721;799.788056165116;807.4468988742708;15445;16348.918255408737;16803.0758308293;16824.07467589282;17320.393786217486;13479.39342729577;13505.864941350583;13519;13529.323533823319;13542.864571354283;671.3622059043903;803.8070862992869;809.6316176139842;820.7948012996751;823.5429336718119;827.4125370986607;828.6726742936567;833.3166803221361;833.5748768128268;837.1001173738225;856.3962406503431;856.8457677618027;857.3741168946673;857.5240741388527;857.5412154497345;700.9404200642952;841.1924552429614;856.0583358305876;856.1823458597025;856.1908995998783;626.8464226264549;627.253568253781;627.3068259573151;627.5293529852611;629.9086632438317;15500.379984800595;15511.914166008384;15523.844761552353;15543.533693989199;15556.144412057332;15005.849941500554;15165.772513412308;15382.384704611803;15447.845521544754;15532.534023979299;13882.08702203806;13974;14073.718525629532;14230;14254.358553864997;4656.4877863434995;4761.005101076902;4763.071201115784;4902.509749025069;4921.409430868319;87771.56114219452;88769;89198;90875;90973.54513227458;11618.6514404568;12360.938195308965;12494.687632809253;12570.937145314398;12642.546107197606;21939.122435102738;23370.065197391912;23376.883115584315;23465.530689386116;23486.530269394858;8532.36007299455;8672.046074931752;8737.563121843883;8770.429922055046;8848.513331766686;4799.424069111659;4859.708417494961;4951.232558953368;5092.134337162691;5098.1842905135;3611.747177697536;3656.3784156693428;3738.1589142443277;3741.1021354874633;3744.419614959631;605.6759633596005;614.2874265851591;617.7930393318198;618.5021058048225;643.0161852365887;654.8035589323184;671.1644003216028;678.5962352400314;685.8799710050721;694.3577191098213;8741.475511469333;9495.48072308441;9799.363041402286;9870.358426702385;10022.448765317977;647.9514036447285;697.940675042627;700;706.2584286499258;734.474850481908;4215.22018426586;4246.256905041605;4463.4420697412825;4501.693706543077;4638.257878739386;126910.36544817218;127475;130025;131370;135945;105162;105229;106063;107525;111975;98453.50773246231;98545.07274636239;100204.99795002102;103108.48445757873;104761.47619261855;8903.19871211594;8959.372843900865;9048.638054478011;9074.863877041982;9178.991325097615;57384;58205.70897145487;59622.70188649029;60088.39911600828;60216;80633;83099;83609;85157;86516.13483865332;12102.75794484123;12277.38613069325;12464.875351246372;12590.370481475706;12773.23360598367;13437.596872093853;13609.455621775018;13955.58133256004;14176.787348189991;14180.424675214917;13085.41115649817;13165.341732913508;13414.262215578237;13530.797038044635;13663.453461861414;12794.053257970621;12871.613851584467;12958.28729419891;12962.35188240603;13619.046666733233;12737.681557960754;13049.869501304865;13183.93408032992;13326.600201993955;13567.389467474184;8859.867101993346;8946.150115738994;9308.348415610842;9466.621335146518;9614.855777163208;9095.226905713089;9689;9742.269329800152;9803.117719405287;9862.408255504693 11:28:20 INFO - PROCESS | 14560 | __end_tp_report 11:28:20 INFO - PROCESS | 14560 | __start_cc_report 11:28:20 INFO - PROCESS | 14560 | _x_x_mozilla_cycle_collect,930 11:28:20 INFO - PROCESS | 14560 | __end_cc_report 11:28:20 INFO - PROCESS | 14560 | __startTimestamp1470594500397__endTimestamp 11:28:20 INFO - PROCESS | 14560 | 11:28:20 INFO - PROCESS | 14560 | ------- Summary: start ------- 11:28:20 INFO - PROCESS | 14560 | Number of tests: 6 11:28:20 INFO - PROCESS | 14560 | 11:28:20 INFO - PROCESS | 14560 | [#0] dojo.html Cycles:165 Average:5269.70 Median:5456.26 stddev:602.09 (11.0%) stddev-sans-first:577.66 11:28:20 INFO - PROCESS | 14560 | Values: 3027.0 3049.9 3069.3 3078.8 3099.7 5176.1 5233.5 5281.5 5374.7 5404.8 5276.6 5285.7 5311.4 5327.5 5355.9 4760.5 4775.6 4783.6 4805.1 4937.0 4909.8 4918.7 4921.6 4942.4 4959.6 4753.7 4803.2 4872.7 4903.3 4911.3 4733.4 4743.4 4780.2 4812.1 4834.6 4668.2 4691.2 4706.3 4770.3 4776.1 5104.5 5223.2 5239.8 5264.1 5276.7 5470.5 5559.1 5584.0 5618.9 5620.1 5598.5 5625.1 5711.4 5713.1 5716.1 5211.2 5239.4 5312.8 5319.9 5325.4 5765.5 5854.8 5860.0 5860.7 5861.5 5621.8 5630.5 5632.3 5634.5 5637.8 5665.3 5705.7 5717.2 5717.2 5717.3 5492.5 5519.5 5581.1 5581.8 5664.4 5574.9 5618.0 5620.4 5629.4 5630.0 4308.6 4342.3 4347.7 4361.7 4385.3 3819.9 3839.4 3876.2 3880.6 3953.6 5386.3 5389.9 5391.4 5397.1 5431.8 5698.2 5706.6 5712.9 5714.2 5717.9 5227.2 5293.7 5360.8 5369.8 5420.3 4875.9 4878.1 4882.4 4884.2 4923.3 5904.3 5911.6 5914.6 5919.8 5920.0 5577.2 5639.5 5677.1 5679.9 5775.4 5905.6 5912.0 5920.9 5930.2 5933.9 5621.2 5624.1 5634.7 5636.8 5638.7 5489.6 5634.1 5660.4 5685.5 5787.6 5566.2 5591.7 5599.6 5600.2 5605.0 5586.7 5594.9 5597.3 5597.6 5598.6 5365.0 5419.6 5446.6 5475.7 5561.6 5566.4 5567.9 5608.2 5614.0 5627.2 5441.9 5443.0 5449.3 5454.0 5456.3 11:28:20 INFO - PROCESS | 14560 | 11:28:20 INFO - PROCESS | 14560 | [#1] ext.html Cycles:180 Average:65169.12 Median:40792.09 stddev:133657.44 (327.7%) stddev-sans-first:133944.46 11:28:20 INFO - PROCESS | 14560 | Values: 595.3 598.1 617.2 627.5 629.6 32607.5 35109.1 35159.3 35374.1 43902.3 41165.0 45304.5 45463.8 45474.1 45520.8 8904.7 9076.4 9080.5 9085.0 9085.9 7987.7 8854.8 8937.0 10447.2 10708.5 10982.7 11061.8 11076.1 11076.4 11077.0 10899.0 10948.5 10952.3 10963.6 10967.5 8098.9 10264.9 10654.3 10672.0 10823.7 44370.0 44754.0 44798.6 44825.6 44851.0 3524.5 3530.8 3556.5 3722.8 3868.7 33772.7 34087.5 34330.0 34607.5 35361.3 4424.7 4432.7 4475.0 4485.2 4679.3 355663.0 356036.0 356314.0 356336.0 357459.0 59760.7 60243.0 60303.7 60395.7 60420.7 62808.0 63210.0 63686.7 63720.3 63808.0 15921.8 16401.5 16407.9 16429.7 16465.3 13481.3 13510.3 13550.5 13557.2 13568.1 15697.3 17312.0 17783.7 17951.3 18036.9 6606.8 6760.8 6835.6 6837.6 6877.6 942.7 990.9 1056.8 1102.6 1141.1 32426.0 33269.1 33414.5 33427.5 33703.3 1080.6 1102.0 1110.4 1152.9 1240.3 16460.3 17553.3 17556.5 17649.0 17782.9 541686.0 664483.0 675557.0 676380.0 677272.0 59996.4 60531.7 60583.4 64094.4 64512.0 1230.8 1349.2 1388.1 1413.7 1487.8 30105.4 34583.7 34806.0 34976.0 35148.3 52600.5 53344.0 53369.5 53402.2 53532.2 452096.0 455189.0 455734.0 455911.0 456629.0 44177.8 44502.0 45262.5 46123.5 46577.0 49084.3 49997.8 50059.7 50206.2 51320.7 39924.1 42528.4 42643.4 42733.0 42752.3 40428.4 41020.0 41092.4 42233.6 42605.1 40631.2 40953.0 41552.6 42263.8 42295.4 35849.0 37887.6 37993.6 38450.2 38556.0 28296.6 28684.6 28855.7 28925.7 28969.3 11:28:20 INFO - PROCESS | 14560 | 11:28:20 INFO - PROCESS | 14560 | [#2] jquery.html Cycles:180 Average:28454.47 Median:2351.30 stddev:79551.52 (3383.3%) stddev-sans-first:79746.72 11:28:20 INFO - PROCESS | 14560 | Values: 363.7 380.3 389.3 391.6 409.6 14573.4 16518.8 19816.4 19822.0 19958.5 19548.2 19934.7 19994.2 20224.6 20245.4 5715.4 5730.3 5753.2 5833.4 5865.4 5829.5 5852.9 5854.2 5858.4 5860.6 5471.2 5716.7 5826.5 5829.3 5836.5 5589.7 5601.1 5608.6 5615.2 5622.7 5354.5 5441.8 5651.3 5680.1 5691.7 13492.3 13607.5 13609.0 13758.2 13763.7 2157.7 2221.9 2308.9 2393.7 2631.2 9812.3 9832.9 10447.3 12275.9 15167.2 1911.4 1939.6 1956.9 1976.3 2005.7 65680.0 69097.3 70958.6 84927.6 85757.6 10592.0 11118.6 11161.9 11351.4 11399.8 15403.5 15745.3 15746.1 15748.4 15848.6 6201.7 6298.2 6377.1 7550.2 8541.6 7920.1 7968.6 8056.6 8247.7 8329.2 4654.8 4733.7 4816.1 4904.9 4922.8 1867.6 1894.9 1986.6 1990.2 1998.5 899.6 971.4 1002.9 1009.3 1038.2 19437.6 20047.7 20186.6 20234.4 20327.1 906.2 936.1 938.1 956.1 986.6 10465.9 11006.7 11134.9 11230.3 11266.2 475471.0 475592.0 484247.0 488080.0 488386.0 60753.0 80102.6 101166.5 101167.0 102799.0 969.6 1006.2 1010.8 1038.7 1046.2 12959.8 17334.9 18079.6 18766.2 18869.8 43586.3 44268.3 44753.6 45939.3 46609.8 58600.0 59248.1 60236.7 60340.7 61113.0 8020.6 8326.0 8367.6 8570.3 8647.6 11618.3 13044.6 13230.3 13323.5 13658.2 11183.3 11684.3 11851.5 12240.2 12275.1 11355.9 11690.7 11731.9 11792.0 11828.1 11634.2 11801.9 11858.5 11932.8 12271.7 7455.6 7639.2 8146.4 8184.5 8683.7 11020.3 11298.3 11446.4 11528.2 11611.3 11:28:20 INFO - PROCESS | 14560 | 11:28:20 INFO - PROCESS | 14560 | [#3] mootools.html Cycles:180 Average:5895.11 Median:2607.33 stddev:3383.16 (129.8%) stddev-sans-first:3376.49 11:28:20 INFO - PROCESS | 14560 | Values: 1495.5 1554.8 1692.8 1744.6 1819.5 8619.8 9209.0 9231.1 9244.4 9246.0 7902.1 8568.3 8869.2 8872.8 9077.6 2321.5 2355.4 2358.2 2360.8 2361.4 2369.7 2415.0 2451.6 2453.3 2454.7 2402.5 2419.5 2427.7 2435.8 2437.5 2346.2 2349.6 2353.3 2362.5 2384.3 2321.0 2332.9 2339.3 2342.4 2347.7 8966.8 9129.7 9176.3 9186.4 9191.3 5311.3 5416.5 5443.7 5447.4 5454.4 3482.3 3484.5 3556.7 3558.4 3564.5 1102.7 1105.1 1115.7 1128.2 1142.2 12684.6 12715.4 12723.8 12747.9 12761.4 4461.9 4661.7 4755.0 4808.4 4822.2 10741.8 10745.9 10757.3 10764.0 10765.6 5418.4 5420.9 5431.5 5437.0 5438.7 4121.9 4797.4 4844.2 4895.1 4974.0 3796.5 3882.3 3946.3 4003.4 4011.5 1244.8 1265.5 1278.5 1292.9 1310.3 847.2 949.7 967.0 982.2 989.5 5808.3 5950.2 6098.5 6155.2 6179.4 440.2 469.7 473.4 475.2 477.0 4178.5 4351.8 4352.1 4396.2 4401.2 10680.4 11105.0 11106.8 11115.2 11149.9 10628.9 10928.5 11051.4 11051.9 11056.7 8097.1 8144.0 8164.3 8165.8 8166.2 5988.4 6005.8 6052.6 6147.4 6257.6 10086.1 10134.3 10162.1 10193.2 10339.0 10483.0 10533.2 10564.7 10621.3 10631.5 6843.9 7615.8 7822.8 7967.3 8065.0 8706.8 8758.3 8769.8 8771.0 8775.8 7596.1 7732.8 7849.0 7913.7 7994.6 7325.2 7433.7 7525.1 7625.3 7771.4 7066.0 7120.1 7175.0 7177.2 7199.0 4741.2 5178.8 5244.1 5284.8 5431.1 5203.4 5245.2 5323.2 5349.5 5419.0 11:28:20 INFO - PROCESS | 14560 | 11:28:20 INFO - PROCESS | 14560 | [#4] prototype.html Cycles:180 Average:4530.74 Median:5082.13 stddev:1357.86 (26.7%) stddev-sans-first:1323.54 11:28:20 INFO - PROCESS | 14560 | Values: 273.7 298.6 300.6 302.3 307.8 5381.4 5397.5 5408.0 5410.3 5439.8 5190.0 5294.6 5302.7 5327.2 5328.8 4101.2 4106.8 4110.6 4113.6 4117.9 4070.5 4102.5 4122.2 4133.9 4135.5 3937.4 4020.7 4060.3 4064.7 4074.2 4040.9 4049.7 4053.8 4056.7 4059.6 3552.6 3555.3 3565.5 3577.0 3581.6 5088.0 5226.1 5235.6 5238.5 5249.6 4615.4 4619.0 4629.7 4631.6 4631.8 5506.0 5511.5 5526.5 5562.7 5565.5 3636.6 3890.1 3894.2 3894.2 3917.5 5440.2 5656.3 5674.4 5711.3 5747.5 3913.9 3921.3 3921.6 3932.8 3934.5 3961.7 3970.8 3976.2 3979.1 3979.5 4373.4 4496.6 4545.2 4586.7 4587.7 5564.3 5570.3 5574.4 5576.4 5583.6 1335.4 1346.6 1348.2 1350.8 1350.8 855.3 855.9 867.2 874.3 881.6 4752.4 4786.8 4791.1 4792.3 4794.4 5016.7 5023.7 5035.2 5045.5 5078.3 4560.9 4693.6 4772.9 4789.0 4800.7 2678.2 2695.2 2701.9 2702.4 2704.6 5219.4 5228.8 5242.7 5250.9 5264.9 4995.8 5058.7 5111.8 5150.5 5159.5 5150.6 5202.3 5214.9 5224.3 5230.0 5010.3 5028.3 5045.6 5086.0 5112.5 5008.5 5291.8 5463.6 5599.0 5738.7 5982.5 6010.8 6031.5 6032.0 6043.1 3917.1 3936.3 3941.4 3945.2 3947.2 5548.9 5739.2 5790.6 5815.6 5835.2 5686.5 5694.5 5704.3 5715.5 5717.3 5555.9 5690.9 5701.9 5706.7 5733.7 5566.2 5605.9 5609.3 5616.9 5632.9 5673.7 5674.8 5702.2 5704.1 5717.5 5404.4 5539.8 5551.9 5579.0 5582.3 11:28:20 INFO - PROCESS | 14560 | 11:28:20 INFO - PROCESS | 14560 | [#5] yui.html Cycles:180 Average:22724.96 Median:4936.32 stddev:34192.27 (692.7%) stddev-sans-first:34248.33 11:28:20 INFO - PROCESS | 14560 | Values: 739.4 761.8 787.2 799.8 807.4 15445.0 16348.9 16803.1 16824.1 17320.4 13479.4 13505.9 13519.0 13529.3 13542.9 671.4 803.8 809.6 820.8 823.5 827.4 828.7 833.3 833.6 837.1 856.4 856.8 857.4 857.5 857.5 700.9 841.2 856.1 856.2 856.2 626.8 627.3 627.3 627.5 629.9 15500.4 15511.9 15523.8 15543.5 15556.1 15005.8 15165.8 15382.4 15447.8 15532.5 13882.1 13974.0 14073.7 14230.0 14254.4 4656.5 4761.0 4763.1 4902.5 4921.4 87771.6 88769.0 89198.0 90875.0 90973.5 11618.7 12360.9 12494.7 12570.9 12642.5 21939.1 23370.1 23376.9 23465.5 23486.5 8532.4 8672.0 8737.6 8770.4 8848.5 4799.4 4859.7 4951.2 5092.1 5098.2 3611.7 3656.4 3738.2 3741.1 3744.4 605.7 614.3 617.8 618.5 643.0 654.8 671.2 678.6 685.9 694.4 8741.5 9495.5 9799.4 9870.4 10022.4 648.0 697.9 700.0 706.3 734.5 4215.2 4246.3 4463.4 4501.7 4638.3 126910.4 127475.0 130025.0 131370.0 135945.0 105162.0 105229.0 106063.0 107525.0 111975.0 98453.5 98545.1 100205.0 103108.5 104761.5 8903.2 8959.4 9048.6 9074.9 9179.0 57384.0 58205.7 59622.7 60088.4 60216.0 80633.0 83099.0 83609.0 85157.0 86516.1 12102.8 12277.4 12464.9 12590.4 12773.2 13437.6 13609.5 13955.6 14176.8 14180.4 13085.4 13165.3 13414.3 13530.8 13663.5 12794.1 12871.6 12958.3 12962.4 13619.0 12737.7 13049.9 13183.9 13326.6 13567.4 8859.9 8946.2 9308.3 9466.6 9614.9 9095.2 9689.0 9742.3 9803.1 9862.4 11:28:20 INFO - PROCESS | 14560 | -------- Summary: end -------- 11:28:20 INFO - PROCESS | 14560 | 11:28:21 INFO - TEST-INFO | 14560: exit 0 11:28:21 INFO - TEST-OK | dromaeo_css | took 1115008ms 11:28:21 INFO - TEST-START | kraken 11:28:21 INFO - operating with platform_type : linux_ 11:28:21 INFO - Initialising browser for kraken test... 11:28:21 INFO - TEST-INFO | started process 14751 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp41W7R_/profile http://localhost:46813/getInfo.html) 11:28:25 INFO - PROCESS | 14751 | __metrics Screen width/height:1600/1200 11:28:25 INFO - PROCESS | 14751 | colorDepth:24 11:28:25 INFO - PROCESS | 14751 | Browser inner width/height: 1024/697 11:28:25 INFO - PROCESS | 14751 | __metrics 11:28:25 INFO - PROCESS | 14751 | 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" 11:28:25 INFO - PROCESS | 14751 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:28:26 INFO - PROCESS | 14751 | console.error: PushService: 11:28:26 INFO - PROCESS | 14751 | stateChangeProcessEnqueue: Error transitioning state 11:28:26 INFO - PROCESS | 14751 | UnknownError 11:28:26 INFO - TEST-INFO | 14751: exit 0 11:28:26 INFO - Browser initialized. 11:28:26 INFO - Running cycle 1/1 for kraken test... 11:28:26 INFO - TEST-INFO | started process 14830 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp41W7R_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:28:38 INFO - PROCESS | 14830 | RSS: Main: 156700672 11:28:38 INFO - PROCESS | 14830 | 11:28:41 INFO - PROCESS | 14830 | Cycle 1(1): loaded http://localhost:46813/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46813/tests/kraken/driver.html?testName=audio-beat-detection) 11:28:41 INFO - PROCESS | 14830 | RSS: Main: 213184512 11:28:41 INFO - PROCESS | 14830 | 11:28:44 INFO - PROCESS | 14830 | Cycle 1(1): loaded http://localhost:46813/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46813/tests/kraken/driver.html?testName=audio-dft) 11:28:45 INFO - PROCESS | 14830 | RSS: Main: 192552960 11:28:45 INFO - PROCESS | 14830 | 11:28:48 INFO - PROCESS | 14830 | Cycle 1(1): loaded http://localhost:46813/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46813/tests/kraken/driver.html?testName=audio-fft) 11:28:48 INFO - PROCESS | 14830 | RSS: Main: 270368768 11:28:48 INFO - PROCESS | 14830 | 11:28:50 INFO - PROCESS | 14830 | Cycle 1(1): loaded http://localhost:46813/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46813/tests/kraken/driver.html?testName=audio-oscillator) 11:28:51 INFO - PROCESS | 14830 | RSS: Main: 179539968 11:28:51 INFO - PROCESS | 14830 | 11:28:53 INFO - PROCESS | 14830 | Cycle 1(1): loaded http://localhost:46813/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46813/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:28:54 INFO - PROCESS | 14830 | RSS: Main: 184242176 11:28:54 INFO - PROCESS | 14830 | 11:28:57 INFO - PROCESS | 14830 | Cycle 1(1): loaded http://localhost:46813/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46813/tests/kraken/driver.html?testName=imaging-darkroom) 11:28:57 INFO - PROCESS | 14830 | RSS: Main: 219574272 11:28:57 INFO - PROCESS | 14830 | 11:29:01 INFO - PROCESS | 14830 | Cycle 1(1): loaded http://localhost:46813/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46813/tests/kraken/driver.html?testName=imaging-desaturate) 11:29:01 INFO - PROCESS | 14830 | RSS: Main: 219992064 11:29:01 INFO - PROCESS | 14830 | 11:29:04 INFO - PROCESS | 14830 | Cycle 1(1): loaded http://localhost:46813/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46813/tests/kraken/driver.html?testName=json-parse-financial) 11:29:05 INFO - PROCESS | 14830 | RSS: Main: 219619328 11:29:05 INFO - PROCESS | 14830 | 11:29:06 INFO - PROCESS | 14830 | Cycle 1(1): loaded http://localhost:46813/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46813/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:29:07 INFO - PROCESS | 14830 | RSS: Main: 183934976 11:29:07 INFO - PROCESS | 14830 | 11:29:08 INFO - PROCESS | 14830 | Cycle 1(1): loaded http://localhost:46813/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46813/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:29:09 INFO - PROCESS | 14830 | RSS: Main: 188534784 11:29:09 INFO - PROCESS | 14830 | 11:29:11 INFO - PROCESS | 14830 | Cycle 1(1): loaded http://localhost:46813/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46813/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:29:12 INFO - PROCESS | 14830 | RSS: Main: 194441216 11:29:12 INFO - PROCESS | 14830 | 11:29:14 INFO - PROCESS | 14830 | Cycle 1(1): loaded http://localhost:46813/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46813/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:29:15 INFO - PROCESS | 14830 | RSS: Main: 194781184 11:29:15 INFO - PROCESS | 14830 | 11:29:18 INFO - PROCESS | 14830 | Cycle 1(1): loaded http://localhost:46813/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46813/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:29:18 INFO - PROCESS | 14830 | RSS: Main: 196329472 11:29:18 INFO - PROCESS | 14830 | 11:29:20 INFO - PROCESS | 14830 | Cycle 1(1): loaded http://localhost:46813/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46813/tests/kraken/driver.html?testName=ai-astar) 11:29:20 INFO - PROCESS | 14830 | RSS: Main: 242995200 11:29:20 INFO - PROCESS | 14830 | 11:29:20 INFO - PROCESS | 14830 | __start_tp_report 11:29:20 INFO - PROCESS | 14830 | _x_x_mozilla_page_load 11:29:20 INFO - PROCESS | 14830 | _x_x_mozilla_page_load_details 11:29:20 INFO - PROCESS | 14830 | |i|pagename|runs| 11:29:20 INFO - PROCESS | 14830 | |0;ai-astar;100;110;108;108;111;107;108;111;109;108 11:29:20 INFO - PROCESS | 14830 | |1;audio-beat-detection;143;117;119;185;119;120;150;118;153;118 11:29:20 INFO - PROCESS | 14830 | |2;audio-dft;161;161;161;162;161;162;161;161;161;161 11:29:20 INFO - PROCESS | 14830 | |3;audio-fft;74;75;74;109;74;75;75;74;102;73 11:29:20 INFO - PROCESS | 14830 | |4;audio-oscillator;83;84;133;84;84;85;114;84;83;121 11:29:20 INFO - PROCESS | 14830 | |5;imaging-gaussian-blur;117;116;117;117;118;116;117;117;117;117 11:29:20 INFO - PROCESS | 14830 | |6;imaging-darkroom;147;146;146;146;145;146;145;145;145;147 11:29:20 INFO - PROCESS | 14830 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;95 11:29:20 INFO - PROCESS | 14830 | |8;json-parse-financial;52;50;52;52;51;52;51;51;51;51 11:29:20 INFO - PROCESS | 14830 | |9;json-stringify-tinderbox;61;60;60;60;60;60;60;61;60;60 11:29:20 INFO - PROCESS | 14830 | |10;stanford-crypto-aes;76;78;80;75;75;76;75;74;75;78 11:29:20 INFO - PROCESS | 14830 | |11;stanford-crypto-ccm;131;124;131;121;136;128;123;130;206;122 11:29:20 INFO - PROCESS | 14830 | |12;stanford-crypto-pbkdf2;157;160;157;163;158;155;154;158;163;169 11:29:20 INFO - PROCESS | 14830 | |13;stanford-crypto-sha256-iterative;63;62;65;64;63;62;61;63;61;61 11:29:20 INFO - PROCESS | 14830 | __end_tp_report 11:29:20 INFO - PROCESS | 14830 | __start_cc_report 11:29:20 INFO - PROCESS | 14830 | _x_x_mozilla_cycle_collect,1631 11:29:20 INFO - PROCESS | 14830 | __end_cc_report 11:29:20 INFO - PROCESS | 14830 | __startTimestamp1470594560546__endTimestamp 11:29:20 INFO - PROCESS | 14830 | 11:29:20 INFO - PROCESS | 14830 | ------- Summary: start ------- 11:29:20 INFO - PROCESS | 14830 | Number of tests: 14 11:29:20 INFO - PROCESS | 14830 | 11:29:20 INFO - PROCESS | 14830 | [#0] ai-astar Cycles:10 Average:108.00 Median:108.50 stddev:3.13 (2.9%) stddev-sans-first:1.45 11:29:20 INFO - PROCESS | 14830 | Values: 100.0 110.0 108.0 108.0 111.0 107.0 108.0 111.0 109.0 108.0 11:29:20 INFO - PROCESS | 14830 | 11:29:20 INFO - PROCESS | 14830 | [#1] audio-beat-detection Cycles:10 Average:134.20 Median:131.50 stddev:22.96 (17.5%) stddev-sans-first:24.13 11:29:20 INFO - PROCESS | 14830 | Values: 143.0 117.0 119.0 185.0 119.0 120.0 150.0 118.0 153.0 118.0 11:29:20 INFO - PROCESS | 14830 | 11:29:20 INFO - PROCESS | 14830 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 11:29:20 INFO - PROCESS | 14830 | Values: 161.0 161.0 161.0 162.0 161.0 162.0 161.0 161.0 161.0 161.0 11:29:20 INFO - PROCESS | 14830 | 11:29:20 INFO - PROCESS | 14830 | [#3] audio-fft Cycles:10 Average:80.50 Median:74.00 stddev:13.29 (18.0%) stddev-sans-first:13.89 11:29:20 INFO - PROCESS | 14830 | Values: 74.0 75.0 74.0 109.0 74.0 75.0 75.0 74.0 102.0 73.0 11:29:20 INFO - PROCESS | 14830 | 11:29:20 INFO - PROCESS | 14830 | [#4] audio-oscillator Cycles:10 Average:95.50 Median:84.00 stddev:19.29 (23.0%) stddev-sans-first:19.93 11:29:20 INFO - PROCESS | 14830 | Values: 83.0 84.0 133.0 84.0 84.0 85.0 114.0 84.0 83.0 121.0 11:29:20 INFO - PROCESS | 14830 | 11:29:20 INFO - PROCESS | 14830 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 11:29:20 INFO - PROCESS | 14830 | Values: 117.0 116.0 117.0 117.0 118.0 116.0 117.0 117.0 117.0 117.0 11:29:20 INFO - PROCESS | 14830 | 11:29:20 INFO - PROCESS | 14830 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.79 (0.5%) stddev-sans-first:0.71 11:29:20 INFO - PROCESS | 14830 | Values: 147.0 146.0 146.0 146.0 145.0 146.0 145.0 145.0 145.0 147.0 11:29:20 INFO - PROCESS | 14830 | 11:29:20 INFO - PROCESS | 14830 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 11:29:20 INFO - PROCESS | 14830 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 11:29:20 INFO - PROCESS | 14830 | 11:29:20 INFO - PROCESS | 14830 | [#8] json-parse-financial Cycles:10 Average:51.30 Median:51.50 stddev:0.67 (1.3%) stddev-sans-first:0.67 11:29:20 INFO - PROCESS | 14830 | Values: 52.0 50.0 52.0 52.0 51.0 52.0 51.0 51.0 51.0 51.0 11:29:20 INFO - PROCESS | 14830 | 11:29:20 INFO - PROCESS | 14830 | [#9] json-stringify-tinderbox Cycles:10 Average:60.20 Median:60.00 stddev:0.42 (0.7%) stddev-sans-first:0.33 11:29:20 INFO - PROCESS | 14830 | Values: 61.0 60.0 60.0 60.0 60.0 60.0 60.0 61.0 60.0 60.0 11:29:20 INFO - PROCESS | 14830 | 11:29:20 INFO - PROCESS | 14830 | [#10] stanford-crypto-aes Cycles:10 Average:76.20 Median:76.00 stddev:1.87 (2.5%) stddev-sans-first:1.99 11:29:20 INFO - PROCESS | 14830 | Values: 76.0 78.0 80.0 75.0 75.0 76.0 75.0 74.0 75.0 78.0 11:29:20 INFO - PROCESS | 14830 | 11:29:20 INFO - PROCESS | 14830 | [#11] stanford-crypto-ccm Cycles:10 Average:135.20 Median:130.50 stddev:25.34 (19.4%) stddev-sans-first:26.83 11:29:20 INFO - PROCESS | 14830 | Values: 131.0 124.0 131.0 121.0 136.0 128.0 123.0 130.0 206.0 122.0 11:29:20 INFO - PROCESS | 14830 | 11:29:20 INFO - PROCESS | 14830 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.40 Median:159.00 stddev:4.50 (2.8%) stddev-sans-first:4.69 11:29:20 INFO - PROCESS | 14830 | Values: 157.0 160.0 157.0 163.0 158.0 155.0 154.0 158.0 163.0 169.0 11:29:20 INFO - PROCESS | 14830 | 11:29:20 INFO - PROCESS | 14830 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.50 Median:63.00 stddev:1.35 (2.1%) stddev-sans-first:1.42 11:29:20 INFO - PROCESS | 14830 | Values: 63.0 62.0 65.0 64.0 63.0 62.0 61.0 63.0 61.0 61.0 11:29:20 INFO - PROCESS | 14830 | -------- Summary: end -------- 11:29:20 INFO - PROCESS | 14830 | 11:29:21 INFO - TEST-INFO | 14830: exit 0 11:29:21 INFO - TEST-OK | kraken | took 60327ms 11:29:21 INFO - SUITE-END | took 1175s 11:29:21 INFO - Completed test suite (00:19:35) 11:29:21 INFO - javascript benchmark 11:29:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3026.984865075675, 3049.8932537361197, 3069.2633767895713, 3078.7844850860433, 3099.705527974843, 5176.120059589869, 5233.502817232366, 5281.471852814717, 5374.731263436827, 5404.756785944632, 5276.577873770098, 5285.709285989269, 5311.362636483627, 5327.493888080626, 5355.919661205085, 4760.452547956995, 4775.594074503671, 4783.641226907996, 4805.063012712522, 4937.0125974805005, 4909.779059942293, 4918.680285781431, 4921.581665558414, 4942.382202224722, 4959.57843583294, 4753.667243292971, 4803.207470767354, 4872.731999739995, 4903.289023091667, 4911.312416261726, 4733.360996265495, 4743.430788305391, 4780.211265141247, 4812.109759694433, 4834.564889159992, 4668.159731248374, 4691.179043667379, 4706.27052806812, 4770.284457331393, 4776.068666610013, 5104.540591346797, 5223.2165175223645, 5239.816606418795, 5264.052470555299, 5276.657017293864, 5470.507654311092, 5559.054960656698, 5584.022796010722, 5618.943810561924, 5620.100783874561, 5598.524125449342, 5625.128105143668, 5711.371749107595, 5713.114467257582, 5716.056850619642, 5211.2443695663915, 5239.423663397023, 5312.814051508218, 5319.920201197024, 5325.4142044375085, 5765.4811067004175, 5854.765809367663, 5859.970700146472, 5860.70696465175, 5861.531077513874, 5621.831345059655, 5630.493255607015, 5632.295963004624, 5634.464725851038, 5637.774489020475, 5665.291838520185, 5705.657660540381, 5717.171010203498, 5717.199592057115, 5717.313922329347, 5492.47821456961, 5519.530839878575, 5581.079121944834, 5581.804636837691, 5664.405237450009, 5574.916376254359, 5617.9719101404235, 5620.353659329147, 5629.408912064257, 5630.0, 4308.590683885089, 4342.283523218697, 4347.673924455678, 4361.672874534423, 4385.320275357325, 3819.923601527954, 3839.3665045267217, 3876.1666241758157, 3880.553736320303, 3953.604639536081, 5386.326709161355, 5389.865253368697, 5391.406945236099, 5397.136458166675, 5431.83704488866, 5698.202251684767, 5706.572007099484, 5712.857178570569, 5714.200011998323, 5717.885642287214, 5227.163653815372, 5293.655912365684, 5360.758765855546, 5369.838904832861, 5420.322459692538, 4875.927295994876, 4878.0975519529, 4882.36529251195, 4884.218525036048, 4923.261510773413, 5904.321003084614, 5911.586188966903, 5914.556408269397, 5919.792807251725, 5919.970400147971, 5577.219189313419, 5639.492445679908, 5677.148427735708, 5679.858003549779, 5775.422457754191, 5905.586608937333, 5912.024515954991, 5920.940790592212, 5930.169776231417, 5933.940660593339, 5621.241132447068, 5624.100143977108, 5634.661920284796, 5636.830895073154, 5638.689872057076, 5489.58828087887, 5634.070378387521, 5660.405657406078, 5685.545156387562, 5787.594868359174, 5566.165075238747, 5591.664500130005, 5599.636023658449, 5600.215969764155, 5605.04714198579, 5586.692731899784, 5594.888102238014, 5597.3003374578175, 5597.63615365, 5598.552115830642, 5365.034293827149, 5419.593530485151, 5446.591505637014, 5475.72621368922, 5561.63849349791, 5566.415526369673, 5567.8886422272135, 5608.2148499209325, 5614.04561224601, 5627.21219029328, 5441.945580544144, 5442.972785136208, 5449.34607847045, 5454.045542030208, 5456.263404440509], "value": 5228.8025269644095, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [595.3362001368473, 598.1267349669482, 617.2068891474454, 627.5105417774138, 629.581328416603, 32607.51088733668, 35109.12227194321, 35159.2968140637, 35374.1156471088, 43902.34146487805, 41165.0, 45304.546954530444, 45463.77268113655, 45474.090518189616, 45520.772396137974, 8904.732858014253, 9076.36465447419, 9080.455172689626, 9084.954575227115, 9085.909140908605, 7987.7204297849585, 8854.822903541924, 8936.955315223448, 10447.16422686187, 10708.518116684769, 10982.736985246678, 11061.778764424747, 11076.11391088715, 11076.446177691123, 11077.0, 10899.0, 10948.4525773711, 10952.34285942846, 10963.616273430393, 10967.451627418597, 8098.919010809935, 10264.89735102647, 10654.307470014503, 10672.0, 10823.729406764814, 44370.0, 44754.0, 44798.55201447976, 44825.55174448279, 44851.0, 3524.54180956474, 3530.8058056806867, 3556.5198698175673, 3722.8138593070507, 3868.6905047596124, 33772.662273377195, 34087.488687669706, 34330.0, 34607.4808877867, 35361.29277414437, 4424.690271680984, 4432.73403595782, 4474.9776251118865, 4485.170243504962, 4679.344891715163, 355663.0, 356036.0, 356314.0, 356336.0, 357459.0, 59760.70119649374, 60243.0, 60303.69848150731, 60395.69802150961, 60420.69789651111, 62808.0, 63210.0, 63686.68156659187, 63720.30936751667, 63808.0, 15921.761173582405, 16401.507954761375, 16407.917960410123, 16429.6714065718, 16465.25906334218, 13481.325933703276, 13510.324483775968, 13550.45798168082, 13557.186568805902, 13568.050236483352, 15697.293621787047, 17312.0, 17783.73324400135, 17951.281948722168, 18036.90981545084, 6606.8348291293105, 6760.797176084725, 6835.6309755720695, 6837.589744615339, 6877.552959057645, 942.7030485397078, 990.9108180263811, 1056.7727938493108, 1102.5589764094427, 1141.1384404774342, 32426.0, 33269.14795143027, 33414.49878251828, 33427.49858752121, 33703.32593348168, 1080.5839751695496, 1101.9779604407868, 1110.3837370259423, 1152.9365884876245, 1240.3364200152876, 16460.259288332054, 17553.29786808539, 17556.473305800846, 17649.027964446122, 17782.91108544449, 541686.0, 664483.0, 675557.0, 676380.0, 677272.0, 59996.40003599908, 60531.69734151301, 60583.39416605866, 64094.35905640977, 64512.0, 1230.7784598772128, 1349.1770020287618, 1388.0630574362265, 1413.7313910357, 1487.7768334749874, 30105.397892042474, 34583.65416345804, 34806.0, 34976.0, 35148.29703405969, 52600.47399526109, 53344.0, 53369.46630533645, 53402.1989670163, 53532.19701704555, 452096.0, 455189.0, 455734.0, 455911.0, 456629.0, 44177.77911110424, 44502.0, 45262.54737452715, 46123.53876461193, 46577.0, 49084.26373604327, 49997.75001124971, 50059.74970125126, 50206.246906297165, 51320.74339628278, 39924.077174955266, 42528.36207456952, 42643.36034959416, 42733.0, 42752.28990840331, 40428.393574097, 41020.0, 41092.38361424521, 42233.57766422419, 42605.14789704251, 40631.1873762529, 40953.0, 41552.58447415608, 42263.78868105763, 42295.3655695171, 35849.0, 37887.62112378841, 37993.62006380012, 38450.230995380494, 38556.0, 28296.575551367157, 28684.569731454463, 28855.711442885302, 28925.681787515314, 28969.275768105967], "value": 21154.1868816453, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [363.723570086734, 380.2641887946823, 389.3245219544091, 391.5653624476831, 409.6190542795199, 14573.368114958916, 16518.834811651894, 19816.40550783477, 19822.0, 19958.501037474034, 19548.218071277133, 19934.70097948532, 19994.200231990704, 20224.59550808983, 20245.392638220877, 5715.399883012286, 5730.255066841305, 5753.223314852504, 5833.3874943130995, 5865.35481097079, 5829.504492118175, 5852.912206316909, 5854.18041474194, 5858.41415858415, 5860.619059761123, 5471.151971444432, 5716.742746576414, 5826.475617194452, 5829.300483941933, 5836.533077353823, 5589.74846131925, 5601.131824567198, 5608.551315894719, 5615.157726341061, 5622.718864056781, 5354.518093371616, 5441.782328706847, 5651.265335506358, 5680.091185410356, 5691.658500489983, 13492.325383730775, 13607.455701771918, 13609.047366684335, 13758.17450952936, 13763.724725505534, 2157.6979222908803, 2221.911123555072, 2308.9307320780404, 2393.676853624756, 2631.2369412870244, 9812.264080193943, 9832.90167098327, 10447.320924139982, 12275.93862030693, 15167.24163791806, 1911.4361263427184, 1939.56359819041, 1956.8630195886294, 1976.3379267945256, 2005.729226554411, 65680.0, 69097.30902690958, 70958.64520677364, 84927.57536212279, 85757.57121214416, 10592.034230415496, 11118.610848620421, 11161.888381116247, 11351.37567433799, 11399.829002564968, 15403.537893863202, 15745.291461884242, 15746.133962631937, 15748.448804291795, 15848.603784905239, 6201.689915504297, 6298.1812364392335, 6377.075324077982, 7550.207228241065, 8541.572921353907, 7920.089189743138, 7968.561729104839, 8056.637451314705, 8247.670093196324, 8329.208725171098, 4654.813807447664, 4733.668643195012, 4816.0818684623155, 4904.890896914289, 4922.753862306942, 1867.5891303913118, 1894.9336773212872, 1986.5629561496737, 1990.2337600024096, 1998.4504261328252, 899.6131663384807, 971.3977334052792, 1002.9197664186847, 1009.3086235928413, 1038.200585549138, 19437.611247775247, 20047.699284510745, 20186.596268074558, 20234.392968210977, 20327.085281162384, 906.1934877958622, 936.1200471556715, 938.0759951447955, 956.0726095687172, 986.6004268271362, 10465.895341046493, 11006.669799906016, 11134.944325278484, 11230.270032447865, 11266.211365204521, 475471.0, 475592.0, 484247.0, 488080.0, 488386.0, 60753.0, 80102.5994870022, 101166.4941675287, 101167.0, 102799.0, 969.5782334684435, 1006.1849901579598, 1010.8483727440796, 1038.7299302181486, 1046.2414749306845, 12959.805602915776, 17334.913325433292, 18079.63840723152, 18766.249350025846, 18869.811301886806, 43586.346204806316, 44268.33597495976, 44753.55246447494, 45939.31091033704, 46609.766951165024, 58600.0, 59248.11127833, 60236.69881650564, 60340.698296508235, 61113.0, 8020.639071241691, 8325.95837020811, 8367.623456944573, 8570.271526920282, 8647.56762161902, 11618.302901825917, 13044.608661740163, 13230.338483075615, 13323.467061317438, 13658.180509169482, 11183.273087249303, 11684.298942063504, 11851.525938962344, 12240.204386714835, 12275.140740148461, 11355.886441135814, 11690.70773230676, 11731.88268117308, 11792.0, 11828.112891533341, 11634.185607007428, 11801.940990294994, 11858.525658973544, 11932.761344772882, 12271.69320766988, 7455.627218638938, 7639.197884222077, 8146.4297499176855, 8184.508929464251, 8683.696070637498, 11020.283681560673, 11298.322100673986, 11446.42767861587, 11528.193026488065, 11611.30332180038], "value": 9065.040726260942, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1495.4990078323765, 1554.8289688134303, 1692.839180277874, 1744.6249056452875, 1819.5269230000197, 8619.784505387368, 9208.95395523023, 9231.123043310892, 9244.352895297332, 9246.012107396908, 7902.091259505159, 8568.271696905771, 8869.246114080295, 8872.778180545489, 9077.591508382122, 2321.535692861426, 2355.3993731598416, 2358.2335740884196, 2360.775726305998, 2361.3624321433203, 2369.6919400477914, 2415.0219161239725, 2451.6445115458246, 2453.3498622864868, 2454.7422520635346, 2402.495475950044, 2419.4798118404537, 2427.6844010278637, 2435.756424357568, 2437.524682686877, 2346.1671106757026, 2349.5653304138705, 2353.2940117964627, 2362.503874186414, 2384.308550520347, 2320.9651855222187, 2332.918347857834, 2339.3215967369442, 2342.3792694935855, 2347.659589359533, 8966.820663586692, 9129.726108216697, 9176.31177661678, 9186.40288381253, 9191.264698824078, 5311.309529761145, 5416.458354164552, 5443.720725629474, 5447.400785913546, 5454.427285135043, 3482.2687235680537, 3484.4599087141532, 3556.715462762973, 3558.430651095812, 3564.518789963348, 1102.7132945434246, 1105.0551778229658, 1115.654147214366, 1128.198978725098, 1142.206166714134, 12684.619461416172, 12715.427805748672, 12723.809142862865, 12747.872521274761, 12761.361931903368, 4461.8845288677185, 4661.673682842168, 4754.952450475451, 4808.422989241313, 4822.180229361017, 10741.83887241692, 10745.892541074645, 10757.30077544957, 10764.0, 10765.56937722498, 5418.4039755626845, 5420.891582168413, 5431.511163995259, 5436.972815135978, 5438.7280635968045, 4121.8969525761495, 4797.376341075638, 4844.224924012141, 4895.143349913751, 4973.975130124399, 3796.544414670257, 3882.3011857865854, 3946.2896678597554, 4003.3794761811964, 4011.458453108793, 1244.800831866897, 1265.519102740971, 1278.469435184388, 1292.9482820687067, 1310.2924420812653, 847.2332539052168, 949.7388218240039, 966.9758256043515, 982.1995074014656, 989.5125605379712, 5808.30300363959, 5950.214935519327, 6098.451139397475, 6155.169052177898, 6179.3820617937845, 440.2098233670569, 469.68531084173685, 473.44606810032343, 475.16134023448643, 476.9713817170981, 4178.456800615901, 4351.82592696295, 4352.107817897323, 4396.186705459436, 4401.22978478765, 10680.359178449318, 11105.0, 11106.833397499044, 11115.22193446451, 11149.944250278697, 10628.893711062945, 10928.508217130247, 11051.447427628586, 11051.889481105087, 11056.723581910517, 8097.149799271109, 8143.959280203561, 8164.265216130577, 8165.836683266301, 8166.1833816619055, 5988.401159883977, 6005.789797357072, 6052.576319657582, 6147.415995480601, 6257.5932564383165, 10086.142677872169, 10134.290599658249, 10162.136218421518, 10193.184545236216, 10339.0, 10483.0, 10533.157347412036, 10564.683059508227, 10621.256512044083, 10631.468426578485, 6843.931560684528, 7615.809604759926, 7822.843543128992, 7967.322777563972, 8065.0, 8706.825863482822, 8758.343124265579, 8769.824603508021, 8771.035186129393, 8775.824483510421, 7596.050493688289, 7732.8453430932195, 7848.960755196187, 7913.683452661829, 7994.5602991836, 7325.157606875277, 7433.739819106306, 7525.134609519975, 7625.313721765067, 7771.378289736695, 7065.964670176616, 7120.1099862517185, 7174.964125179549, 7177.210506844347, 7199.0, 4741.217699079613, 5178.844634660966, 5244.134717771678, 5284.7886084556185, 5431.076716958048, 5203.375594928632, 5245.186996015624, 5323.1749078892835, 5349.545288650508, 5419.0], "value": 4633.893340838911, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [273.65382790769695, 298.64908732239616, 300.59569878513406, 302.32882999740576, 307.7983920532051, 5381.408045115039, 5397.4872387123205, 5408.0, 5410.296661434018, 5439.755211015504, 5190.0, 5294.57643388529, 5302.674331417145, 5327.174287985359, 5328.813491527797, 4101.179764047202, 4106.77412742299, 4110.588941105895, 4113.588641135878, 4117.938230926538, 4070.5115386153702, 4102.528209255944, 4122.154958233555, 4133.855315063958, 4135.503739551258, 3937.3503371943593, 4020.718549701522, 4060.2894493463673, 4064.6545043671176, 4074.246264441073, 4040.9191816163807, 4049.7165198436123, 4053.8041277823113, 4056.71602987791, 4059.579147298422, 3552.5559305086863, 3555.2711694102645, 3565.5186549815703, 3576.9968817462304, 3581.552305961755, 5087.9824035193105, 5226.137687281594, 5235.607329450307, 5238.5023422774775, 5249.606279529051, 4615.399998000272, 4618.976905115486, 4629.652776041777, 4631.614718420016, 4631.791569379386, 5505.972470137664, 5511.476409741068, 5526.50261476469, 5562.694051827148, 5565.499105080562, 3636.5999740028574, 3890.0663840678035, 3894.201688653819, 3894.2211557688574, 3917.4711413959035, 5440.238366628636, 5656.349519805234, 5674.375818659944, 5711.314642242916, 5747.540196784247, 3913.882583522499, 3921.31377009028, 3921.627445392683, 3932.783696896641, 3934.4688467057154, 3961.6632586229916, 3970.781607011584, 3976.165005348851, 3979.1245925896837, 3979.5025621797276, 4373.397828292161, 4496.5503449655425, 4545.159275452842, 4586.656000799953, 4587.72473651582, 5564.276644036249, 5570.303712035996, 5574.414686457944, 5576.358718747315, 5583.609147359646, 1335.3857225676297, 1346.616214378917, 1348.191085348783, 1350.7568637645122, 1350.770369037266, 855.3072011670566, 855.9271719770384, 867.2498288979987, 874.3169398907079, 881.6297155194834, 4752.358431611758, 4786.760661966958, 4791.137595232892, 4792.281157826354, 4794.352762377104, 5016.673916195436, 5023.6985780853265, 5035.244713293036, 5045.520675535819, 5078.263651770547, 4560.908781824345, 4693.601043911238, 4772.928406073912, 4788.976055119702, 4800.711957282574, 2678.2367025397666, 2695.2183866678834, 2701.8919243230052, 2702.351435655468, 2704.5665797127554, 5219.381991582622, 5228.790848366023, 5242.7378631068295, 5250.894982100336, 5264.947010597895, 4995.7561535773275, 5058.721770302595, 5111.821086261963, 5150.459201783834, 5159.509846564571, 5150.562202212779, 5202.271681964528, 5214.921776173361, 5224.268602395668, 5229.973850130725, 5010.348654674869, 5028.321176641107, 5045.571126454146, 5086.0, 5112.463191364853, 5008.524190201925, 5291.788328466818, 5463.590230732631, 5598.972005139948, 5738.68437235956, 5982.49148822355, 6010.789622363196, 6031.487323577545, 6031.979286938749, 6043.09353596964, 3917.0794863207693, 3936.291467535871, 3941.428492868575, 3945.230680017369, 3947.210557888491, 5548.861278468071, 5739.167820666064, 5790.639199787962, 5815.592908496534, 5835.153902684172, 5686.488216060575, 5694.4590263924865, 5704.3154821421695, 5715.514181294637, 5717.256756621613, 5555.8888822224135, 5690.890276396063, 5701.857453563694, 5706.657600543981, 5733.684647344269, 5566.248556444828, 5605.943940560543, 5609.298837645294, 5616.876624674999, 5632.859513384888, 5673.659580425187, 5674.829755107354, 5702.201691763239, 5704.144378343116, 5717.514011308919, 5404.432534583812, 5539.806106786243, 5551.916721249104, 5578.972105139448, 5582.33012038558], "value": 4085.7446675926494, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [739.4232498651053, 761.8362052158785, 787.2245837849721, 799.788056165116, 807.4468988742708, 15445.0, 16348.918255408737, 16803.0758308293, 16824.07467589282, 17320.393786217486, 13479.39342729577, 13505.864941350583, 13519.0, 13529.323533823319, 13542.864571354283, 671.3622059043903, 803.8070862992869, 809.6316176139842, 820.7948012996751, 823.5429336718119, 827.4125370986607, 828.6726742936567, 833.3166803221361, 833.5748768128268, 837.1001173738225, 856.3962406503431, 856.8457677618027, 857.3741168946673, 857.5240741388527, 857.5412154497345, 700.9404200642952, 841.1924552429614, 856.0583358305876, 856.1823458597025, 856.1908995998783, 626.8464226264549, 627.253568253781, 627.3068259573151, 627.5293529852611, 629.9086632438317, 15500.379984800595, 15511.914166008384, 15523.844761552353, 15543.533693989199, 15556.144412057332, 15005.849941500554, 15165.772513412308, 15382.384704611803, 15447.845521544754, 15532.534023979299, 13882.08702203806, 13974.0, 14073.718525629532, 14230.0, 14254.358553864997, 4656.4877863434995, 4761.005101076902, 4763.071201115784, 4902.509749025069, 4921.409430868319, 87771.56114219452, 88769.0, 89198.0, 90875.0, 90973.54513227458, 11618.6514404568, 12360.938195308965, 12494.687632809253, 12570.937145314398, 12642.546107197606, 21939.122435102738, 23370.065197391912, 23376.883115584315, 23465.530689386116, 23486.530269394858, 8532.36007299455, 8672.046074931752, 8737.563121843883, 8770.429922055046, 8848.513331766686, 4799.424069111659, 4859.708417494961, 4951.232558953368, 5092.134337162691, 5098.1842905135, 3611.747177697536, 3656.3784156693428, 3738.1589142443277, 3741.1021354874633, 3744.419614959631, 605.6759633596005, 614.2874265851591, 617.7930393318198, 618.5021058048225, 643.0161852365887, 654.8035589323184, 671.1644003216028, 678.5962352400314, 685.8799710050721, 694.3577191098213, 8741.475511469333, 9495.48072308441, 9799.363041402286, 9870.358426702385, 10022.448765317977, 647.9514036447285, 697.940675042627, 700.0, 706.2584286499258, 734.474850481908, 4215.22018426586, 4246.256905041605, 4463.4420697412825, 4501.693706543077, 4638.257878739386, 126910.36544817218, 127475.0, 130025.0, 131370.0, 135945.0, 105162.0, 105229.0, 106063.0, 107525.0, 111975.0, 98453.50773246231, 98545.07274636239, 100204.99795002102, 103108.48445757873, 104761.47619261855, 8903.19871211594, 8959.372843900865, 9048.638054478011, 9074.863877041982, 9178.991325097615, 57384.0, 58205.70897145487, 59622.70188649029, 60088.39911600828, 60216.0, 80633.0, 83099.0, 83609.0, 85157.0, 86516.13483865332, 12102.75794484123, 12277.38613069325, 12464.875351246372, 12590.370481475706, 12773.23360598367, 13437.596872093853, 13609.455621775018, 13955.58133256004, 14176.787348189991, 14180.424675214917, 13085.41115649817, 13165.341732913508, 13414.262215578237, 13530.797038044635, 13663.453461861414, 12794.053257970621, 12871.613851584467, 12958.28729419891, 12962.35188240603, 13619.046666733233, 12737.681557960754, 13049.869501304865, 13183.93408032992, 13326.600201993955, 13567.389467474184, 8859.867101993346, 8946.150115738994, 9308.348415610842, 9466.621335146518, 9614.855777163208, 9095.226905713089, 9689.0, 9742.269329800152, 9803.117719405287, 9862.408255504693], "value": 7725.067822785437, "unit": "score"}], "name": "dromaeo_css", "value": 7261.99811254183, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 110.0, 108.0, 108.0, 111.0, 107.0, 108.0, 111.0, 109.0, 108.0], "value": 108.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 117.0, 119.0, 185.0, 119.0, 120.0, 150.0, 118.0, 153.0, 118.0], "value": 134.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 162.0, 161.0, 162.0, 161.0, 161.0, 161.0, 161.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 74.0, 109.0, 74.0, 75.0, 75.0, 74.0, 102.0, 73.0], "value": 80.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 133.0, 84.0, 84.0, 85.0, 114.0, 84.0, 83.0, 121.0], "value": 95.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 118.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 146.0, 145.0, 146.0, 145.0, 145.0, 145.0, 147.0], "value": 145.8, "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": [52.0, 50.0, 52.0, 52.0, 51.0, 52.0, 51.0, 51.0, 51.0, 51.0], "value": 51.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 60.0, 60.0, 60.0, 60.0, 60.0, 61.0, 60.0, 60.0], "value": 60.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 78.0, 80.0, 75.0, 75.0, 76.0, 75.0, 74.0, 75.0, 78.0], "value": 76.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 124.0, 131.0, 121.0, 136.0, 128.0, 123.0, 130.0, 206.0, 122.0], "value": 135.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 160.0, 157.0, 163.0, 158.0, 155.0, 154.0, 158.0, 163.0, 169.0], "value": 159.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 65.0, 64.0, 63.0, 62.0, 61.0, 63.0, 61.0, 61.0], "value": 62.5, "unit": "score"}], "name": "kraken", "value": 1481.9, "alertThreshold": 2.0}]} 11:29:21 INFO - Return code: 0 11:29:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:29:21 INFO - # TBPL SUCCESS # 11:29:21 INFO - Running post-action listener: _resource_record_post_action 11:29:21 INFO - [mozharness: 2016-08-07 18:29:21.864433Z] Finished run-tests step (success) 11:29:21 INFO - Running post-run listener: _resource_record_post_run 11:29:21 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 8192; Write bytes: 553177088; Read time: 16; Write time: 625932 11:29:21 INFO - TinderboxPrint: CPU usage
13.1% 11:29:21 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 16 11:29:21 INFO - TinderboxPrint: I/O write bytes / time
553,177,088 / 625,932 11:29:21 INFO - TinderboxPrint: CPU idle
8,276.5 (86.9%) 11:29:21 INFO - TinderboxPrint: CPU user
1,198.0 (12.6%) 11:29:21 INFO - TinderboxPrint: Swap in / out
0 / 0 11:29:21 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 257597440; Read time: 0; Write time: 354652 11:29:21 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 295579648; Read time: 0; Write time: 271280 11:29:22 INFO - Running post-run listener: _upload_blobber_files 11:29:22 INFO - Blob upload gear active. 11:29:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:29:22 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 11:29:22 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'] 11:29:22 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 11:29:22 INFO - (blobuploader) - INFO - Open directory for files ... 11:29:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:29:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:29:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:29:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:29:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:29:24 INFO - (blobuploader) - INFO - Done attempting. 11:29:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:29:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:29:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:29:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:29:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:29:24 INFO - (blobuploader) - INFO - Done attempting. 11:29:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:29:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:29:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:29:28 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:29:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:29:28 INFO - (blobuploader) - INFO - Done attempting. 11:29:28 INFO - (blobuploader) - INFO - Iteration through files over. 11:29:28 INFO - Return code: 0 11:29:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:29:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:29:28 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3956de608e27faabc3558123ad010c5bc8bd1a55a059f6106867a6e60b8e662828922cce419a4855c7c81dc1b7b420f911a699e664065a3b8e7e51bc2d62a2aa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/36b18e7a5199aa236eef015aee4d311d911021b32b427eb902114dcfe17a7af616e256729f6edb910f594f3fd30a36e2746ee0b361ceb4a100154d681c482c8d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b4c0530af049574f70a79666df6b937b0479999d02d56c830f30af61eeb39b70c55a8eceeefffa61f9f8b6cdc44718157a1f77da0616857bdf5e19c5c6ec169b"} 11:29:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:29:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:29:28 INFO - Contents: 11:29:28 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3956de608e27faabc3558123ad010c5bc8bd1a55a059f6106867a6e60b8e662828922cce419a4855c7c81dc1b7b420f911a699e664065a3b8e7e51bc2d62a2aa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/36b18e7a5199aa236eef015aee4d311d911021b32b427eb902114dcfe17a7af616e256729f6edb910f594f3fd30a36e2746ee0b361ceb4a100154d681c482c8d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b4c0530af049574f70a79666df6b937b0479999d02d56c830f30af61eeb39b70c55a8eceeefffa61f9f8b6cdc44718157a1f77da0616857bdf5e19c5c6ec169b"} 11:29:28 INFO - Running post-run listener: copy_logs_to_upload_dir 11:29:28 INFO - Copying logs to upload dir... 11:29:28 INFO - mkdir: /builds/slave/test/build/upload/logs 11:29:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.028728 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-08-07 11:29:28.429092) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-07 11:29:28.433571) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1470591078.860452-889247057 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/3956de608e27faabc3558123ad010c5bc8bd1a55a059f6106867a6e60b8e662828922cce419a4855c7c81dc1b7b420f911a699e664065a3b8e7e51bc2d62a2aa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/36b18e7a5199aa236eef015aee4d311d911021b32b427eb902114dcfe17a7af616e256729f6edb910f594f3fd30a36e2746ee0b361ceb4a100154d681c482c8d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b4c0530af049574f70a79666df6b937b0479999d02d56c830f30af61eeb39b70c55a8eceeefffa61f9f8b6cdc44718157a1f77da0616857bdf5e19c5c6ec169b"} build_url:https://queue.taskcluster.net/v1/task/C-X4E9QSTZiRRInGEGHaFw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011244 build_url: 'https://queue.taskcluster.net/v1/task/C-X4E9QSTZiRRInGEGHaFw/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/3956de608e27faabc3558123ad010c5bc8bd1a55a059f6106867a6e60b8e662828922cce419a4855c7c81dc1b7b420f911a699e664065a3b8e7e51bc2d62a2aa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/36b18e7a5199aa236eef015aee4d311d911021b32b427eb902114dcfe17a7af616e256729f6edb910f594f3fd30a36e2746ee0b361ceb4a100154d681c482c8d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b4c0530af049574f70a79666df6b937b0479999d02d56c830f30af61eeb39b70c55a8eceeefffa61f9f8b6cdc44718157a1f77da0616857bdf5e19c5c6ec169b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-07 11:29:28.458818) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 11:29:28.459134) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1470591078.860452-889247057 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004498 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 11:29:28.545411) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-07 11:29:28.545708) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-07 11:29:28.545976) ========= ========= Total master_lag: 0.18 =========