builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-005 starttime: 1467396497.93 results: success (0) buildid: 20160701083038 builduid: 4d2e09a028d7417e88a547c2880f7247 revision: 22c6ee548233a87bace78f804eac487970f95ddb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-01 11:08:17.928920) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-01 11:08:17.929403) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-01 11:08:17.929687) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-01 11:08:17.955489) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 11:08:17.955788) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1467395456.9183-1780684504 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-01 11:08:18-- 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% 112M=0s 2016-07-01 11:08:18 (112 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.097776 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 11:08:18.067882) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 11:08:18.068187) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1467395456.9183-1780684504 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020450 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 11:08:18.116946) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 11:08:18.117285) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 22c6ee548233a87bace78f804eac487970f95ddb --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 22c6ee548233a87bace78f804eac487970f95ddb --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=7fc86f70bae03e018da0b1d8000001c4-1467395456.9183-1780684504 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-01 11:08:18,968 truncating revision to first 12 chars 2016-07-01 11:08:18,968 Setting DEBUG logging. 2016-07-01 11:08:18,968 attempt 1/10 2016-07-01 11:08:18,968 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/22c6ee548233?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-01 11:08:19,302 unpacking tar archive at: fx-team-22c6ee548233/testing/mozharness/ program finished with exit code 0 elapsedTime=0.679306 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 11:08:18.810568) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-01 11:08:18.810903) ========= script_repo_revision: 22c6ee548233a87bace78f804eac487970f95ddb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-01 11:08:18.811337) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-01 11:08:18.811620) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-01 11:08:18.822081) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-07-01 11:08:18.822386) ========= /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=7fc86f70bae03e018da0b1d8000001c4-1467395456.9183-1780684504 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:08:19 INFO - MultiFileLogger online at 20160701 11:08:19 in /builds/slave/test 11:08:19 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:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:08:19 INFO - {'append_to_log': False, 11:08:19 INFO - 'base_work_dir': '/builds/slave/test', 11:08:19 INFO - 'blob_upload_branch': 'Fx-Team', 11:08:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:08:19 INFO - 'branch': 'Fx-Team', 11:08:19 INFO - 'buildbot_json_path': 'buildprops.json', 11:08:19 INFO - 'config_files': ('talos/linux_config.py',), 11:08:19 INFO - 'default_actions': ('clobber', 11:08:19 INFO - 'read-buildbot-config', 11:08:19 INFO - 'download-and-extract', 11:08:19 INFO - 'populate-webroot', 11:08:19 INFO - 'create-virtualenv', 11:08:19 INFO - 'install', 11:08:19 INFO - 'run-tests'), 11:08:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:08:19 INFO - 'download_minidump_stackwalk': True, 11:08:19 INFO - 'download_symbols': 'ondemand', 11:08:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:08:19 INFO - 'tooltool.py': '/tools/tooltool.py', 11:08:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:08:19 INFO - '/tools/misc-python/virtualenv.py')}, 11:08:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:08:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:08:19 INFO - 'installer_path': 'installer.exe', 11:08:19 INFO - 'log_level': 'info', 11:08:19 INFO - 'log_name': 'talos', 11:08:19 INFO - 'log_to_console': True, 11:08:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:08:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:08:19 INFO - 'opt_config_files': (), 11:08:19 INFO - 'pip_index': False, 11:08:19 INFO - 'sps_profile': False, 11:08:19 INFO - 'sps_profile_interval': 0, 11:08:19 INFO - 'suite': 'dromaeojs', 11:08:19 INFO - 'system_bits': '32', 11:08:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:08:19 INFO - 'title': 'talos-linux64-ix-005', 11:08:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:08:19 INFO - 'use_talos_json': True, 11:08:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:08:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:08:19 INFO - 'work_dir': 'build'} 11:08:19 INFO - ##### 11:08:19 INFO - ##### Running clobber step. 11:08:19 INFO - ##### 11:08:19 INFO - Running pre-action listener: _resource_record_pre_action 11:08:19 INFO - Running main action method: clobber 11:08:19 INFO - rmtree: /builds/slave/test/build 11:08:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:08:20 INFO - Running post-action listener: _resource_record_post_action 11:08:20 INFO - ##### 11:08:20 INFO - ##### Finished clobber step (success) 11:08:20 INFO - ##### 11:08:20 INFO - ##### 11:08:20 INFO - ##### Running read-buildbot-config step. 11:08:20 INFO - ##### 11:08:20 INFO - Running pre-action listener: _resource_record_pre_action 11:08:20 INFO - Running main action method: read_buildbot_config 11:08:20 INFO - Using buildbot properties: 11:08:20 INFO - { 11:08:20 INFO - "project": "", 11:08:20 INFO - "product": "firefox", 11:08:20 INFO - "script_repo_revision": "production", 11:08:20 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 11:08:20 INFO - "repository": "", 11:08:20 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 11:08:20 INFO - "buildid": "20160701083038", 11:08:20 INFO - "pgo_build": "True", 11:08:20 INFO - "basedir": "/builds/slave/test", 11:08:20 INFO - "buildnumber": 852, 11:08:20 INFO - "slavename": "talos-linux64-ix-005", 11:08:20 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:08:20 INFO - "platform": "ubuntu64_hw", 11:08:20 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 11:08:20 INFO - "branch": "fx-team", 11:08:20 INFO - "repo_path": "integration/fx-team", 11:08:20 INFO - "revision": "22c6ee548233a87bace78f804eac487970f95ddb", 11:08:20 INFO - "stage_platform": "linux64-pgo", 11:08:20 INFO - "builduid": "4d2e09a028d7417e88a547c2880f7247", 11:08:20 INFO - "slavebuilddir": "test" 11:08:20 INFO - } 11:08:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/Yl6O7QocSEa_LgZ_0hZvMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 11:08:20 INFO - Running post-action listener: _resource_record_post_action 11:08:20 INFO - ##### 11:08:20 INFO - ##### Finished read-buildbot-config step (success) 11:08:20 INFO - ##### 11:08:20 INFO - ##### 11:08:20 INFO - ##### Running download-and-extract step. 11:08:20 INFO - ##### 11:08:20 INFO - Running pre-action listener: _resource_record_pre_action 11:08:20 INFO - Running main action method: download_and_extract 11:08:20 INFO - mkdir: /builds/slave/test/build/tests 11:08: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:08:20 INFO - https://queue.taskcluster.net/v1/task/Yl6O7QocSEa_LgZ_0hZvMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:08:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yl6O7QocSEa_LgZ_0hZvMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:08:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yl6O7QocSEa_LgZ_0hZvMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:08:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yl6O7QocSEa_LgZ_0hZvMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:08:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yl6O7QocSEa_LgZ_0hZvMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 11:08:23 INFO - Downloaded 1361 bytes. 11:08:23 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:08:23 INFO - Using the following test package requirements: 11:08:23 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 11:08:23 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:08:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:08:23 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:08:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:08:23 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:08:23 INFO - u'jsshell-linux-x86_64.zip'], 11:08:23 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:08:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:08:23 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 11:08:23 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:08:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:08:23 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:08:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:08:23 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:08:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:08:23 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:08:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:08:23 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:08: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:08:23 INFO - https://queue.taskcluster.net/v1/task/Yl6O7QocSEa_LgZ_0hZvMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:08:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yl6O7QocSEa_LgZ_0hZvMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:08:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yl6O7QocSEa_LgZ_0hZvMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:08:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yl6O7QocSEa_LgZ_0hZvMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:08:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yl6O7QocSEa_LgZ_0hZvMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:08:28 INFO - Downloaded 24270680 bytes. 11:08:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:08:28 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:08:29 INFO - Return code: 0 11:08:29 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:08:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:08:29 INFO - https://queue.taskcluster.net/v1/task/Yl6O7QocSEa_LgZ_0hZvMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:08:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yl6O7QocSEa_LgZ_0hZvMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:08:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yl6O7QocSEa_LgZ_0hZvMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:08:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yl6O7QocSEa_LgZ_0hZvMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:08:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yl6O7QocSEa_LgZ_0hZvMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:08:30 INFO - Downloaded 24270680 bytes. 11:08:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:08:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:08:32 INFO - Return code: 0 11:08:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:08:32 INFO - https://queue.taskcluster.net/v1/task/Yl6O7QocSEa_LgZ_0hZvMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:08:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yl6O7QocSEa_LgZ_0hZvMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 11:08:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yl6O7QocSEa_LgZ_0hZvMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 11:08:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yl6O7QocSEa_LgZ_0hZvMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 11:08:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yl6O7QocSEa_LgZ_0hZvMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:08:33 INFO - Downloaded 14405242 bytes. 11:08:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:08:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 11:08:33 INFO - Return code: 0 11:08:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:08:33 INFO - https://queue.taskcluster.net/v1/task/Yl6O7QocSEa_LgZ_0hZvMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:08:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yl6O7QocSEa_LgZ_0hZvMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:08:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yl6O7QocSEa_LgZ_0hZvMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:08:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yl6O7QocSEa_LgZ_0hZvMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:08:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yl6O7QocSEa_LgZ_0hZvMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:08:34 INFO - Downloaded 60345412 bytes. 11:08:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Yl6O7QocSEa_LgZ_0hZvMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:08:34 INFO - mkdir: /builds/slave/test/properties 11:08:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:08:34 INFO - Writing to file /builds/slave/test/properties/build_url 11:08:34 INFO - Contents: 11:08:34 INFO - build_url:https://queue.taskcluster.net/v1/task/Yl6O7QocSEa_LgZ_0hZvMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:08:35 INFO - Running post-action listener: _resource_record_post_action 11:08:35 INFO - Running post-action listener: set_extra_try_arguments 11:08:35 INFO - ##### 11:08:35 INFO - ##### Finished download-and-extract step (success) 11:08:35 INFO - ##### 11:08:35 INFO - ##### 11:08:35 INFO - ##### Running populate-webroot step. 11:08:35 INFO - ##### 11:08:35 INFO - Running pre-action listener: _resource_record_pre_action 11:08:35 INFO - Running main action method: populate_webroot 11:08:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:08:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:08:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:08:35 INFO - '--tppagecycles', 11:08:35 INFO - '7'], 11:08:35 INFO - 'tests': ['tsvgm']}}, 11:08:35 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:08:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:08:35 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:08:35 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:08:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:08:35 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:08:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:08:35 INFO - 'talos_options': ['--disable-e10s'], 11:08:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:08:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:08:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:08:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:08:35 INFO - 'talos_options': ['--disable-e10s'], 11:08:35 INFO - 'tests': ['damp', 'tps']}, 11:08:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:08:35 INFO - 'tests': ['damp', 'tps']}, 11:08:35 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:08:35 INFO - 'tests': ['dromaeo_dom']}, 11:08:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:08:35 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:08:35 INFO - 'tests': ['basic_compositor_video']}, 11:08:35 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:08:35 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:08:35 INFO - 'tests': ['a11yr', 11:08:35 INFO - 'ts_paint', 11:08:35 INFO - 'tpaint', 11:08:35 INFO - 'sessionrestore', 11:08:35 INFO - 'sessionrestore_no_auto_restore', 11:08:35 INFO - 'tabpaint']}, 11:08:35 INFO - 'other-e10s': {'tests': ['a11yr', 11:08:35 INFO - 'ts_paint', 11:08:35 INFO - 'tpaint', 11:08:35 INFO - 'sessionrestore', 11:08:35 INFO - 'sessionrestore_no_auto_restore', 11:08:35 INFO - 'tabpaint']}, 11:08:35 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:08:35 INFO - 'ts_paint', 11:08:35 INFO - 'tpaint', 11:08:35 INFO - 'sessionrestore', 11:08:35 INFO - 'sessionrestore_no_auto_restore', 11:08:35 INFO - 'tabpaint']}, 11:08:35 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:08:35 INFO - 'ts_paint', 11:08:35 INFO - 'tpaint', 11:08:35 INFO - 'sessionrestore', 11:08:35 INFO - 'sessionrestore_no_auto_restore', 11:08:35 INFO - 'tabpaint']}, 11:08:35 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:08:35 INFO - 'tests': ['a11yr', 11:08:35 INFO - 'ts_paint', 11:08:35 INFO - 'tpaint', 11:08:35 INFO - 'sessionrestore', 11:08:35 INFO - 'sessionrestore_no_auto_restore', 11:08:35 INFO - 'tabpaint']}, 11:08:35 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:08:35 INFO - 'tests': ['a11yr', 11:08:35 INFO - 'ts_paint', 11:08:35 INFO - 'tpaint', 11:08:35 INFO - 'sessionrestore', 11:08:35 INFO - 'sessionrestore_no_auto_restore', 11:08:35 INFO - 'tabpaint']}, 11:08:35 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:08:35 INFO - 'tests': ['tsvgx', 11:08:35 INFO - 'tsvgr_opacity', 11:08:35 INFO - 'tart', 11:08:35 INFO - 'tscrollx', 11:08:35 INFO - 'cart']}, 11:08:35 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:08:35 INFO - 'tsvgr_opacity', 11:08:35 INFO - 'tart', 11:08:35 INFO - 'tscrollx', 11:08:35 INFO - 'cart']}, 11:08:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:08:35 INFO - 'talos_options': ['--disable-e10s'], 11:08:35 INFO - 'tests': ['tp5o']}, 11:08:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:08:35 INFO - 'tests': ['tp5o']}, 11:08:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:08:35 INFO - 'talos_options': ['--disable-e10s', 11:08:35 INFO - '--xperf_path', 11:08:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:08:35 INFO - 'tests': ['tp5n']}, 11:08:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:08:35 INFO - 'talos_options': ['--xperf_path', 11:08:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:08:35 INFO - 'tests': ['tp5n']}}, 11:08:35 INFO - 'talos.zip': {'path': '', 11:08:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:08:35 INFO - Running post-action listener: _resource_record_post_action 11:08:35 INFO - ##### 11:08:35 INFO - ##### Finished populate-webroot step (success) 11:08:35 INFO - ##### 11:08:35 INFO - ##### 11:08:35 INFO - ##### Running create-virtualenv step. 11:08:35 INFO - ##### 11:08:35 INFO - Running pre-action listener: _resource_record_pre_action 11:08:35 INFO - Running main action method: create_virtualenv 11:08:35 INFO - Creating virtualenv /builds/slave/test/build/venv 11:08:35 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:08:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:08:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:08:35 INFO - Using real prefix '/usr' 11:08:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:08:36 INFO - Installing distribute.............................................................................................................................................................................................done. 11:08:38 INFO - Installing pip.................done. 11:08:38 INFO - Return code: 0 11:08:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:08:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:08:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:08:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:08:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:08:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd06030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfc7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc53b0>, '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 0xfc62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfc6740>, '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': '7fc86f70bae03e018da0b1d8000001c4-1467395456.9183-1780684504', '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:08:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:08:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:08:38 INFO - Using env: {'DISPLAY': ':0', 11:08:38 INFO - 'HOME': '/home/cltbld', 11:08:38 INFO - 'LANG': 'en_US.UTF-8', 11:08:38 INFO - 'LANGUAGE': 'en_US:en', 11:08:38 INFO - 'LOGNAME': 'cltbld', 11:08:38 INFO - 'MAIL': '/var/mail/cltbld', 11:08:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:08:38 INFO - 'MOZ_NO_REMOTE': '1', 11:08:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:08:38 INFO - 'NO_EM_RESTART': '1', 11:08:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:08:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:08:38 INFO - 'PWD': '/builds/slave/test', 11:08:38 INFO - 'SHELL': '/bin/bash', 11:08:38 INFO - 'SHLVL': '1', 11:08:38 INFO - 'TERM': 'linux', 11:08:38 INFO - 'TMOUT': '86400', 11:08:38 INFO - 'USER': 'cltbld', 11:08:38 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1467395456.9183-1780684504', 11:08:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:08:38 INFO - '_': '/tools/buildbot/bin/python'} 11:08:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:08:38 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 11:08:38 INFO - Cleaning up... 11:08:38 INFO - Return code: 0 11:08:38 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:08:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:08:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:08:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:08:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:08:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd06030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfc7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc53b0>, '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 0xfc62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfc6740>, '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': '7fc86f70bae03e018da0b1d8000001c4-1467395456.9183-1780684504', '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:08:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:08:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:08:38 INFO - Using env: {'DISPLAY': ':0', 11:08:38 INFO - 'HOME': '/home/cltbld', 11:08:38 INFO - 'LANG': 'en_US.UTF-8', 11:08:38 INFO - 'LANGUAGE': 'en_US:en', 11:08:38 INFO - 'LOGNAME': 'cltbld', 11:08:38 INFO - 'MAIL': '/var/mail/cltbld', 11:08:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:08:38 INFO - 'MOZ_NO_REMOTE': '1', 11:08:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:08:38 INFO - 'NO_EM_RESTART': '1', 11:08:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:08:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:08:38 INFO - 'PWD': '/builds/slave/test', 11:08:38 INFO - 'SHELL': '/bin/bash', 11:08:38 INFO - 'SHLVL': '1', 11:08:38 INFO - 'TERM': 'linux', 11:08:38 INFO - 'TMOUT': '86400', 11:08:38 INFO - 'USER': 'cltbld', 11:08:38 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1467395456.9183-1780684504', 11:08:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:08:38 INFO - '_': '/tools/buildbot/bin/python'} 11:08:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:08:38 INFO - Downloading/unpacking psutil>=3.1.1 11:08:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:08:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:08:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:08:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:08:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:08:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:08:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:08:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:08:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:08:40 INFO - Installing collected packages: psutil 11:08:40 INFO - Running setup.py install for psutil 11:08:40 INFO - building 'psutil._psutil_linux' extension 11:08:40 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 11:08:40 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 11:08:40 INFO - building 'psutil._psutil_posix' extension 11:08:40 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 11:08:40 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 11:08:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:08:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:08:40 INFO - Successfully installed psutil 11:08:40 INFO - Cleaning up... 11:08:41 INFO - Return code: 0 11:08:41 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:08:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:08:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:08:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:08:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:08:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:41 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 0xd06030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfc7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc53b0>, '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 0xfc62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfc6740>, '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': '7fc86f70bae03e018da0b1d8000001c4-1467395456.9183-1780684504', '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:08:41 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:08:41 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:08:41 INFO - Using env: {'DISPLAY': ':0', 11:08:41 INFO - 'HOME': '/home/cltbld', 11:08:41 INFO - 'LANG': 'en_US.UTF-8', 11:08:41 INFO - 'LANGUAGE': 'en_US:en', 11:08:41 INFO - 'LOGNAME': 'cltbld', 11:08:41 INFO - 'MAIL': '/var/mail/cltbld', 11:08:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:08:41 INFO - 'MOZ_NO_REMOTE': '1', 11:08:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:08:41 INFO - 'NO_EM_RESTART': '1', 11:08:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:08:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:08:41 INFO - 'PWD': '/builds/slave/test', 11:08:41 INFO - 'SHELL': '/bin/bash', 11:08:41 INFO - 'SHLVL': '1', 11:08:41 INFO - 'TERM': 'linux', 11:08:41 INFO - 'TMOUT': '86400', 11:08:41 INFO - 'USER': 'cltbld', 11:08:41 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1467395456.9183-1780684504', 11:08:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:08:41 INFO - '_': '/tools/buildbot/bin/python'} 11:08:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:08:41 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:08:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:08:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:08:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:08:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:08:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:08:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:08:43 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:08:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:08:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:08:43 INFO - Installing collected packages: mozsystemmonitor 11:08:43 INFO - Running setup.py install for mozsystemmonitor 11:08:43 INFO - Successfully installed mozsystemmonitor 11:08:43 INFO - Cleaning up... 11:08:43 INFO - Return code: 0 11:08:43 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:08:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:08:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:08:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:08:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:08:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd06030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfc7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc53b0>, '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 0xfc62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfc6740>, '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': '7fc86f70bae03e018da0b1d8000001c4-1467395456.9183-1780684504', '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:08:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:08:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:08:43 INFO - Using env: {'DISPLAY': ':0', 11:08:43 INFO - 'HOME': '/home/cltbld', 11:08:43 INFO - 'LANG': 'en_US.UTF-8', 11:08:43 INFO - 'LANGUAGE': 'en_US:en', 11:08:43 INFO - 'LOGNAME': 'cltbld', 11:08:43 INFO - 'MAIL': '/var/mail/cltbld', 11:08:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:08:43 INFO - 'MOZ_NO_REMOTE': '1', 11:08:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:08:43 INFO - 'NO_EM_RESTART': '1', 11:08:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:08:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:08:43 INFO - 'PWD': '/builds/slave/test', 11:08:43 INFO - 'SHELL': '/bin/bash', 11:08:43 INFO - 'SHLVL': '1', 11:08:43 INFO - 'TERM': 'linux', 11:08:43 INFO - 'TMOUT': '86400', 11:08:43 INFO - 'USER': 'cltbld', 11:08:43 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1467395456.9183-1780684504', 11:08:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:08:43 INFO - '_': '/tools/buildbot/bin/python'} 11:08:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:08:43 INFO - Downloading/unpacking jsonschema==2.5.1 11:08:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:08:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:08:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:08:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:08:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:08:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:08:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:08:45 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:08:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:08:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:08:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:08:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:08:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:08:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:08:45 INFO - Downloading functools32-3.2.3-2.tar.gz 11:08:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:08:45 INFO - warning: no files found matching '*.txt' 11:08:45 INFO - no previously-included directories found matching 'build' 11:08:45 INFO - no previously-included directories found matching 'dist' 11:08:45 INFO - no previously-included directories found matching '.git*' 11:08:45 INFO - Installing collected packages: jsonschema, functools32 11:08:45 INFO - Running setup.py install for functools32 11:08:45 INFO - warning: no files found matching '*.txt' 11:08:45 INFO - no previously-included directories found matching 'build' 11:08:45 INFO - no previously-included directories found matching 'dist' 11:08:45 INFO - no previously-included directories found matching '.git*' 11:08:45 INFO - Successfully installed jsonschema functools32 11:08:45 INFO - Cleaning up... 11:08:45 INFO - Return code: 0 11:08:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:08: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:08:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:08:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:08:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:08:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd06030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfc7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc53b0>, '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 0xfc62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfc6740>, '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': '7fc86f70bae03e018da0b1d8000001c4-1467395456.9183-1780684504', '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:08:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:08:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:08:45 INFO - Using env: {'DISPLAY': ':0', 11:08:45 INFO - 'HOME': '/home/cltbld', 11:08:45 INFO - 'LANG': 'en_US.UTF-8', 11:08:45 INFO - 'LANGUAGE': 'en_US:en', 11:08:45 INFO - 'LOGNAME': 'cltbld', 11:08:45 INFO - 'MAIL': '/var/mail/cltbld', 11:08:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:08:45 INFO - 'MOZ_NO_REMOTE': '1', 11:08:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:08:45 INFO - 'NO_EM_RESTART': '1', 11:08:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:08:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:08:45 INFO - 'PWD': '/builds/slave/test', 11:08:45 INFO - 'SHELL': '/bin/bash', 11:08:45 INFO - 'SHLVL': '1', 11:08:45 INFO - 'TERM': 'linux', 11:08:45 INFO - 'TMOUT': '86400', 11:08:45 INFO - 'USER': 'cltbld', 11:08:45 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1467395456.9183-1780684504', 11:08:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:08:45 INFO - '_': '/tools/buildbot/bin/python'} 11:08:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:08:46 INFO - Downloading/unpacking blobuploader==1.2.4 11:08:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:08:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:08:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:08:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:08:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:08:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:08:47 INFO - Downloading blobuploader-1.2.4.tar.gz 11:08:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:08:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:08:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:08:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:08:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:08:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:08:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:08:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:08:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:08:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:08:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:08:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:08:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:08:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:08:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:08:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:08:48 INFO - Downloading docopt-0.6.1.tar.gz 11:08:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:08:48 INFO - Installing collected packages: blobuploader, requests, docopt 11:08:48 INFO - Running setup.py install for blobuploader 11:08:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:08:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:08:48 INFO - Running setup.py install for requests 11:08:49 INFO - Running setup.py install for docopt 11:08:49 INFO - Successfully installed blobuploader requests docopt 11:08:49 INFO - Cleaning up... 11:08:49 INFO - Return code: 0 11:08:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:08:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:08:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:08:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:08:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:08:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd06030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfc7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc53b0>, '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 0xfc62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfc6740>, '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': '7fc86f70bae03e018da0b1d8000001c4-1467395456.9183-1780684504', '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:08:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:08:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:08:49 INFO - Using env: {'DISPLAY': ':0', 11:08:49 INFO - 'HOME': '/home/cltbld', 11:08:49 INFO - 'LANG': 'en_US.UTF-8', 11:08:49 INFO - 'LANGUAGE': 'en_US:en', 11:08:49 INFO - 'LOGNAME': 'cltbld', 11:08:49 INFO - 'MAIL': '/var/mail/cltbld', 11:08:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:08:49 INFO - 'MOZ_NO_REMOTE': '1', 11:08:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:08:49 INFO - 'NO_EM_RESTART': '1', 11:08:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:08:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:08:49 INFO - 'PWD': '/builds/slave/test', 11:08:49 INFO - 'SHELL': '/bin/bash', 11:08:49 INFO - 'SHLVL': '1', 11:08:49 INFO - 'TERM': 'linux', 11:08:49 INFO - 'TMOUT': '86400', 11:08:49 INFO - 'USER': 'cltbld', 11:08:49 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1467395456.9183-1780684504', 11:08:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:08:49 INFO - '_': '/tools/buildbot/bin/python'} 11:08:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:08:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:08:49 INFO - Running setup.py (path:/tmp/pip-MBKEdB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:08:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:08:49 INFO - Running setup.py (path:/tmp/pip-kckPbC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:08:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:08:49 INFO - Running setup.py (path:/tmp/pip-VjFh0B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:08:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:08:49 INFO - Running setup.py (path:/tmp/pip-6NdGU8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:08:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:08:49 INFO - Running setup.py (path:/tmp/pip-r6XQRQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:08:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:08:49 INFO - Running setup.py (path:/tmp/pip-Js2fE6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:08:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:08:50 INFO - Running setup.py (path:/tmp/pip-bbG9Ey-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:08:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:08:50 INFO - Running setup.py (path:/tmp/pip-ZEHBia-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:08:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:08:50 INFO - Running setup.py (path:/tmp/pip-bZIdEY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:08:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:08:50 INFO - Running setup.py (path:/tmp/pip-0OFJT1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:08:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:08:50 INFO - Running setup.py (path:/tmp/pip-sIdJrh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:08:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:08:50 INFO - Running setup.py (path:/tmp/pip-N3nSmq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:08:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:08:50 INFO - Running setup.py (path:/tmp/pip-l7BeMx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:08:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:08:50 INFO - Running setup.py (path:/tmp/pip-9MactN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:08:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:08:50 INFO - Running setup.py (path:/tmp/pip-lPTG1n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:08:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:08:50 INFO - Running setup.py (path:/tmp/pip-xnHtTf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:08:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:08:50 INFO - Running setup.py (path:/tmp/pip-jrzZG5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:08:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:08:50 INFO - Running setup.py install for manifestparser 11:08:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:08:50 INFO - Running setup.py install for mozcrash 11:08:51 INFO - Running setup.py install for mozdebug 11:08:51 INFO - Running setup.py install for mozdevice 11:08:51 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:08:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:08:51 INFO - Running setup.py install for mozfile 11:08:51 INFO - Running setup.py install for mozhttpd 11:08:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:08:51 INFO - Running setup.py install for mozinfo 11:08:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:08:51 INFO - Running setup.py install for mozInstall 11:08:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:08:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:08:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:08:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:08:51 INFO - Running setup.py install for mozleak 11:08:51 INFO - Running setup.py install for mozlog 11:08:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:08:51 INFO - Running setup.py install for moznetwork 11:08:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:08:51 INFO - Running setup.py install for mozprocess 11:08:52 INFO - Running setup.py install for mozprofile 11:08:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:08:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:08:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:08:52 INFO - Running setup.py install for mozrunner 11:08:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:08:52 INFO - Running setup.py install for mozscreenshot 11:08:52 INFO - Running setup.py install for moztest 11:08:52 INFO - Running setup.py install for mozversion 11:08:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:08:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:08:52 INFO - Cleaning up... 11:08:52 INFO - Return code: 0 11:08:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:08:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:08:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:08:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:08:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:08:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd06030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfc7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc53b0>, '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 0xfc62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfc6740>, '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': '7fc86f70bae03e018da0b1d8000001c4-1467395456.9183-1780684504', '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:08:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:08:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:08:52 INFO - Using env: {'DISPLAY': ':0', 11:08:52 INFO - 'HOME': '/home/cltbld', 11:08:52 INFO - 'LANG': 'en_US.UTF-8', 11:08:52 INFO - 'LANGUAGE': 'en_US:en', 11:08:52 INFO - 'LOGNAME': 'cltbld', 11:08:52 INFO - 'MAIL': '/var/mail/cltbld', 11:08:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:08:52 INFO - 'MOZ_NO_REMOTE': '1', 11:08:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:08:52 INFO - 'NO_EM_RESTART': '1', 11:08:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:08:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:08:52 INFO - 'PWD': '/builds/slave/test', 11:08:52 INFO - 'SHELL': '/bin/bash', 11:08:52 INFO - 'SHLVL': '1', 11:08:52 INFO - 'TERM': 'linux', 11:08:52 INFO - 'TMOUT': '86400', 11:08:52 INFO - 'USER': 'cltbld', 11:08:52 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1467395456.9183-1780684504', 11:08:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:08:52 INFO - '_': '/tools/buildbot/bin/python'} 11:08:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:08:52 INFO - Running setup.py (path:/tmp/pip-LcCAfi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:08:52 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 11:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:08:52 INFO - Running setup.py (path:/tmp/pip-4qNJa9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:08:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:08:52 INFO - Running setup.py (path:/tmp/pip-L5h1Zz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:08:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:08:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:08:53 INFO - Running setup.py (path:/tmp/pip-R9LlUg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:08:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:08:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:08:53 INFO - Running setup.py (path:/tmp/pip-w__CRx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:08:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 11:08:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:08:53 INFO - Running setup.py (path:/tmp/pip-NkA6Rz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:08:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 11:08:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:08:53 INFO - Running setup.py (path:/tmp/pip-qsz4jc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:08:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 11:08:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:08:53 INFO - Running setup.py (path:/tmp/pip-ECxPQT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:08:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:08:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:08:53 INFO - Running setup.py (path:/tmp/pip-DXsWqo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:08:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 11:08:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:08:53 INFO - Running setup.py (path:/tmp/pip-oO0EnA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:08:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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:08:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:08:53 INFO - Running setup.py (path:/tmp/pip-WUjdW1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:08:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 11:08:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:08:53 INFO - Running setup.py (path:/tmp/pip-jEbBOU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:08:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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:08:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:08:53 INFO - Running setup.py (path:/tmp/pip-CoE5Fr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:08:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 11:08:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:08:53 INFO - Running setup.py (path:/tmp/pip-MPG1ng-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:08:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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:08:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:08:53 INFO - Running setup.py (path:/tmp/pip-GvLroa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:08:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 11:08:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:08:53 INFO - Running setup.py (path:/tmp/pip-Ma5rSe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:08:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 11:08:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:08:53 INFO - Running setup.py (path:/tmp/pip-CTQ6DR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:08:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 11:08:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:08:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:08:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:08:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:08:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:08:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:08:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:08:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:08:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:08:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:08:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:08:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:08:55 INFO - Downloading blessings-1.6.tar.gz 11:08:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:08:56 INFO - Installing collected packages: blessings 11:08:56 INFO - Running setup.py install for blessings 11:08:56 INFO - Successfully installed blessings 11:08:56 INFO - Cleaning up... 11:08:56 INFO - Return code: 0 11:08:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:08:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:08:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:08:56 INFO - Reading from file tmpfile_stdout 11:08:56 INFO - Current package versions: 11:08:56 INFO - argparse == 1.2.1 11:08:56 INFO - blessings == 1.6 11:08:56 INFO - blobuploader == 1.2.4 11:08:56 INFO - docopt == 0.6.1 11:08:56 INFO - functools32 == 3.2.3-2 11:08:56 INFO - jsonschema == 2.5.1 11:08:56 INFO - manifestparser == 1.1 11:08:56 INFO - mozInstall == 1.12 11:08:56 INFO - mozcrash == 0.17 11:08:56 INFO - mozdebug == 0.1 11:08:56 INFO - mozdevice == 0.48 11:08:56 INFO - mozfile == 1.2 11:08:56 INFO - mozhttpd == 0.7 11:08:56 INFO - mozinfo == 0.9 11:08:56 INFO - mozleak == 0.1 11:08:56 INFO - mozlog == 3.2 11:08:56 INFO - moznetwork == 0.27 11:08:56 INFO - mozprocess == 0.22 11:08:56 INFO - mozprofile == 0.28 11:08:56 INFO - mozrunner == 6.11 11:08:56 INFO - mozscreenshot == 0.1 11:08:56 INFO - mozsystemmonitor == 0.3 11:08:56 INFO - moztest == 0.7 11:08:56 INFO - mozversion == 1.4 11:08:56 INFO - psutil == 3.1.1 11:08:56 INFO - requests == 1.2.3 11:08:56 INFO - wsgiref == 0.1.2 11:08:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:08:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:08:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:08:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:08:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:08:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd06030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfc7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc53b0>, '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 0xfc62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfc6740>, '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': '7fc86f70bae03e018da0b1d8000001c4-1467395456.9183-1780684504', '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:08:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 11:08:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:08:56 INFO - Using env: {'DISPLAY': ':0', 11:08:56 INFO - 'HOME': '/home/cltbld', 11:08:56 INFO - 'LANG': 'en_US.UTF-8', 11:08:56 INFO - 'LANGUAGE': 'en_US:en', 11:08:56 INFO - 'LOGNAME': 'cltbld', 11:08:56 INFO - 'MAIL': '/var/mail/cltbld', 11:08:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:08:56 INFO - 'MOZ_NO_REMOTE': '1', 11:08:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:08:56 INFO - 'NO_EM_RESTART': '1', 11:08:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:08:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:08:56 INFO - 'PWD': '/builds/slave/test', 11:08:56 INFO - 'SHELL': '/bin/bash', 11:08:56 INFO - 'SHLVL': '1', 11:08:56 INFO - 'TERM': 'linux', 11:08:56 INFO - 'TMOUT': '86400', 11:08:56 INFO - 'USER': 'cltbld', 11:08:56 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1467395456.9183-1780684504', 11:08:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:08:56 INFO - '_': '/tools/buildbot/bin/python'} 11:08:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:08:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:08:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 11:08:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 11:08:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:08:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 11:08:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 11:08:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 11:08:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 11:08:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 11:08:56 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:08:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:08:56 INFO - Cleaning up... 11:08:56 INFO - Return code: 0 11:08:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:08:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:08:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:08:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:08:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:08:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd06030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfc7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc53b0>, '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 0xfc62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfc6740>, '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': '7fc86f70bae03e018da0b1d8000001c4-1467395456.9183-1780684504', '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:08:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:08:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:08:56 INFO - Using env: {'DISPLAY': ':0', 11:08:56 INFO - 'HOME': '/home/cltbld', 11:08:56 INFO - 'LANG': 'en_US.UTF-8', 11:08:56 INFO - 'LANGUAGE': 'en_US:en', 11:08:56 INFO - 'LOGNAME': 'cltbld', 11:08:56 INFO - 'MAIL': '/var/mail/cltbld', 11:08:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:08:56 INFO - 'MOZ_NO_REMOTE': '1', 11:08:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:08:56 INFO - 'NO_EM_RESTART': '1', 11:08:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:08:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:08:56 INFO - 'PWD': '/builds/slave/test', 11:08:56 INFO - 'SHELL': '/bin/bash', 11:08:56 INFO - 'SHLVL': '1', 11:08:56 INFO - 'TERM': 'linux', 11:08:56 INFO - 'TMOUT': '86400', 11:08:56 INFO - 'USER': 'cltbld', 11:08:56 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1467395456.9183-1780684504', 11:08:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:08:56 INFO - '_': '/tools/buildbot/bin/python'} 11:08:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:08:56 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:08:56 INFO - Cleaning up... 11:08:56 INFO - Return code: 0 11:08:56 INFO - Running post-action listener: _resource_record_post_action 11:08:56 INFO - Running post-action listener: _start_resource_monitoring 11:08:56 INFO - Starting resource monitoring. 11:08:56 INFO - ##### 11:08:56 INFO - ##### Finished create-virtualenv step (success) 11:08:56 INFO - ##### 11:08:56 INFO - ##### 11:08:56 INFO - ##### Running install step. 11:08:56 INFO - ##### 11:08:56 INFO - Running pre-action listener: _resource_record_pre_action 11:08:56 INFO - Running main action method: install 11:08:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:08:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:08:57 INFO - Reading from file tmpfile_stdout 11:08:57 INFO - Detecting whether we're running mozinstall >=1.0... 11:08:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:08:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:08:57 INFO - Reading from file tmpfile_stdout 11:08:57 INFO - Output received: 11:08:57 INFO - Usage: mozinstall [options] installer 11:08:57 INFO - Options: 11:08:57 INFO - -h, --help show this help message and exit 11:08:57 INFO - -d DEST, --destination=DEST 11:08:57 INFO - Directory to install application into. [default: 11:08:57 INFO - "/builds/slave/test"] 11:08:57 INFO - --app=APP Application being installed. [default: firefox] 11:08:57 INFO - mkdir: /builds/slave/test/build/application 11:08:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:08:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 11:09:14 INFO - Reading from file tmpfile_stdout 11:09:14 INFO - Output received: 11:09:14 INFO - /builds/slave/test/build/application/firefox/firefox 11:09:14 INFO - Running post-action listener: _resource_record_post_action 11:09:14 INFO - ##### 11:09:14 INFO - ##### Finished install step (success) 11:09:14 INFO - ##### 11:09:14 INFO - ##### 11:09:14 INFO - ##### Running run-tests step. 11:09:14 INFO - ##### 11:09:14 INFO - Running pre-action listener: _resource_record_pre_action 11:09:14 INFO - Running main action method: run_tests 11:09:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:09:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:09:14 INFO - Python 2.7.3 11:09:14 INFO - Return code: 0 11:09:14 INFO - grabbing minidump binary from tooltool 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:09:14 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc53b0>, '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 0xfc62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfc6740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:09:14 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 11:09:14 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 11:09:14 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 11:09:14 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:09:14 INFO - Return code: 0 11:09:14 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:09:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:09:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:09:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:09:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:09:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Yl6O7QocSEa_LgZ_0hZvMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--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:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Yl6O7QocSEa_LgZ_0hZvMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-005 --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: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 - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:09:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:09:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:09:14 INFO - 'MOZ_NO_REMOTE': '1', 11:09:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 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': '/builds/slave/test/build/venv/bin:/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 - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 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': '7fc86f70bae03e018da0b1d8000001c4-1467395456.9183-1780684504', 11:09:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:09:14 INFO - '_': '/tools/buildbot/bin/python'} 11:09:14 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Yl6O7QocSEa_LgZ_0hZvMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--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:14 INFO - mozversion application_buildid: 20160701083038 11:09:14 INFO - mozversion application_changeset: 22c6ee548233a87bace78f804eac487970f95ddb 11:09:14 INFO - mozversion application_display_name: Nightly 11:09:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:09:14 INFO - mozversion application_name: Firefox 11:09:14 INFO - mozversion application_remotingname: firefox 11:09:14 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:09:14 INFO - mozversion application_vendor: Mozilla 11:09:14 INFO - mozversion application_version: 50.0a1 11:09:14 INFO - mozversion platform_buildid: 20160701083038 11:09:14 INFO - mozversion platform_changeset: 22c6ee548233a87bace78f804eac487970f95ddb 11:09:14 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:09:14 INFO - mozversion platform_version: 50.0a1 11:09:14 INFO - using testdate: 1467396554 11:09:14 INFO - actual date: 1467396554 11:09:14 INFO - starting webserver on 'localhost:50099' 11:09:14 INFO - SUITE-START | Running 2 tests 11:09:14 INFO - TEST-START | dromaeo_css 11:09:14 INFO - operating with platform_type : linux_ 11:09:14 INFO - Initialising browser for dromaeo_css test... 11:09:14 INFO - TEST-INFO | started process 32558 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOCW09h/profile http://localhost:50099/getInfo.html) 11:09:18 INFO - PROCESS | 32558 | __metrics Screen width/height:1600/1200 11:09:18 INFO - PROCESS | 32558 | colorDepth:24 11:09:18 INFO - PROCESS | 32558 | Browser inner width/height: 1024/697 11:09:18 INFO - PROCESS | 32558 | __metrics 11:09:19 INFO - PROCESS | 32558 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:09:19 INFO - TEST-INFO | 32558: exit 0 11:09:19 INFO - Browser initialized. 11:09:19 INFO - Running cycle 1/1 for dromaeo_css test... 11:09:19 INFO - TEST-INFO | started process 32641 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOCW09h/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:09:31 INFO - PROCESS | 32641 | RSS: Main: 157581312 11:09:31 INFO - PROCESS | 32641 | 11:10:23 INFO - PROCESS | 32641 | 1467396623214 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:12:31 INFO - PROCESS | 32641 | Cycle 1(1): loaded http://localhost:50099/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50099/tests/dromaeo/cssquery-ext.html) 11:12:32 INFO - PROCESS | 32641 | RSS: Main: 253685760 11:12:32 INFO - PROCESS | 32641 | 11:15:34 INFO - PROCESS | 32641 | Cycle 1(1): loaded http://localhost:50099/tests/dromaeo/cssquery-ext.html (next: http://localhost:50099/tests/dromaeo/cssquery-jquery.html) 11:15:35 INFO - PROCESS | 32641 | RSS: Main: 237821952 11:15:35 INFO - PROCESS | 32641 | 11:18:37 INFO - PROCESS | 32641 | Cycle 1(1): loaded http://localhost:50099/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50099/tests/dromaeo/cssquery-mootools.html) 11:18:37 INFO - PROCESS | 32641 | RSS: Main: 243466240 11:18:37 INFO - PROCESS | 32641 | 11:21:39 INFO - PROCESS | 32641 | Cycle 1(1): loaded http://localhost:50099/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50099/tests/dromaeo/cssquery-prototype.html) 11:21:40 INFO - PROCESS | 32641 | RSS: Main: 238592000 11:21:40 INFO - PROCESS | 32641 | 11:24:42 INFO - PROCESS | 32641 | Cycle 1(1): loaded http://localhost:50099/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50099/tests/dromaeo/cssquery-yui.html) 11:24:43 INFO - PROCESS | 32641 | RSS: Main: 223690752 11:24:43 INFO - PROCESS | 32641 | 11:27:46 INFO - PROCESS | 32641 | Cycle 1(1): loaded http://localhost:50099/tests/dromaeo/cssquery-yui.html (next: http://localhost:50099/tests/dromaeo/cssquery-dojo.html) 11:27:46 INFO - PROCESS | 32641 | RSS: Main: 281116672 11:27:46 INFO - PROCESS | 32641 | 11:27:46 INFO - PROCESS | 32641 | __start_tp_report 11:27:46 INFO - PROCESS | 32641 | _x_x_mozilla_page_load 11:27:46 INFO - PROCESS | 32641 | _x_x_mozilla_page_load_details 11:27:46 INFO - PROCESS | 32641 | |i|pagename|runs| 11:27:46 INFO - PROCESS | 32641 | |0;dojo.html;3095.7213850753433;3096.3652451247494;3109.54911537827;3135.3415782685634;3167.4456970030255;5289.047971365153;5293.232481290211;5361.169018802082;5363.785448582057;5382.300300960875;5330.28041214436;5356.303680521536;5367.973160134204;5377.381601115872;5383.084875571152;4787.521247875211;4878.292647566101;4897.436794768594;4907.6073914086965;5020.322256495381;4921.532454416824;4925;4956.2070068789;4980.153373926441;4986.775595098211;4813.855584332476;4815.398075240612;4854.2718592211095;4864.391951006124;4877.829275975341;4838.903221935541;4860.756962151913;4862.781174847105;4948.282499037619;4986.376702912136;4874.951250487486;4886.291487734258;4900.754962251909;4918.877028074291;4920.827771028033;5264.789408423697;5346.064438723208;5443.618946673734;5484.945150548523;5508.421615730331;5802.12968054791;5825.330087040003;5853.560982926298;5855.180274761537;5863.70681465925;5659.094544872801;5728.684922329312;5732.0542110551705;5737.770489180428;5738.42615738427;5371.704556249405;5380.408155102975;5389.541888939445;5487.341519017744;5506.834794956158;5983.341832398432;5995;5995.880082398415;5996.640201587831;5999.430054144849;5542.224088627595;5594.664320140804;5758.136279558016;5767.163761254678;5768.134779783066;5713.685747283939;5818.912716309259;5823.5923485355615;5828.88342233153;5836.2412886325355;5702.116171993348;5730.054541000772;5735.254416925773;5741.62679425836;5745.339285982082;5607.80372686954;5633;5688.5733569981585;5743.8564035899435;5744.942550574524;4359.716618419856;4389.341598760211;4395.230834603932;4418.116376724668;4431.8005689743395;3897.6881849451975;3921.6470517653547;3929.724919255682;3953.031507280735;3964.0288129408477;5296.788128474818;5301.655392399482;5347.759350829222;5354.598405119632;5378.005069062236;5736.68448235351;5738.139279108167;5741.511971482387;5765.827025189251;5783;5408.621396502286;5416.7562459688625;5419;5420.214068959979;5427.348718153847;4899.853004409873;4956.90086198274;4978.626603004789;4981.153203955337;4994.450610432849;5964.314103878023;5992.191054207713;5998.370171131968;6001.279846418371;6002.519798416116;5671.688057156896;5686.630369026;5690.715464226855;5692.032354499662;5695.857603559944;5713.028785106625;5765.106408506688;5841.94158058431;5842.2405087338375;5892.882142357043;5593.804216852391;5601.04782187021;5613.663180209201;5614.157876318422;5616.971915140398;5611.551075913999;5643.35101463337;5683;5696.572757043321;5699.715014249188;5660.349059858169;5665.49010589049;5678.68767217807;5692.430756924275;5727.570432217683;5658;5658.321001479849;5658.801941932013;5660.773569057192;5670.007748643889;5433.239346491416;5476.069068258326;5515.806946756844;5593.720313984366;5596.440355964371;5647.15292706081;5690.2887139107615;5696.430356964271;5741.081426971665;5747.137929310469;5564.610477266552;5567.860803479945;5568.192612071146;5576.944230557642;5577.9442205577425 11:27:46 INFO - PROCESS | 32641 | |1;ext.html;592.5792687192094;613.8281281241249;620.2742790934607;629.25747617811;633.7528363938063;33552.16119597011;36677.44983825245;36729.449058264116;36738.26523469529;44042;43395.566044339546;47542.28686569704;47626.28560571586;47751.522484775145;47825;9040.141186587263;9189.954050229773;9196.172344488994;9197.448153110834;9198.632054717804;8925.464472131693;8985;9010.774730631754;9013.32400069994;9019.54902254888;9005.819883602324;9033.819323613523;9049.95475022624;9053.547322633875;9053.909460905372;8962.551872406386;8986.55067246635;9007.099290071006;9007.459552426875;9013.369064165445;8940.061293564147;9021.594028268744;9027.729168124966;9032.367734258605;9036.593353299051;43572.128557428674;43782;43924;43940;43952.78023609894;3384.086296699877;3403.149212696826;3441.4665726812386;3509.6314886937016;3871.399933010388;33992.32015359704;34201.82899085488;34430.31139377198;35626;35795.64204357949;4273.18809426208;4355.150745604608;4381.649468042581;4383.364412160251;4453.643708503312;336221;337646;337833;338344;340036;36701;37673.62326376701;37701.62298377036;60357;61241.38758612446;39436.60563394329;39518.20963580712;39595.60404395919;39597;39620;15502.534923952075;15573.922130389275;15598.220088995731;15714.371425142866;15734.449294274646;12780.297083660487;12810.039247056508;12869.613911582668;12964.675883102998;13029.804552931713;8984.146506081912;9083.727488175366;9089.22741566961;9145.359824812333;9166.037566055602;3327.667233276653;3434.9828250859086;3466;3500.334936362083;3551.1654761131113;998.256299057207;1055.8996895294936;1068.8770791359093;1146.4267866066966;1161.0653423993765;33096;33440.49839252413;33480;33538;33979;1148.8736239013701;1167.3229526874393;1172.3903570143477;1200.363807182195;1216.558378321674;17122.571935701457;17168.39910603123;17493.91253043752;17573.384931527336;17656.91171544134;542724;546741;549420;550128;550762;60785;62286;62407.6879615599;62408;62523.374766251756;1246.8316777235138;1363.2025265219957;1413.3639862062114;1419.5386499387535;1419.9432022719182;33171.33657326888;34330.82834585911;34494.82752586221;34875.65124348825;34985;51980;52289.47710522846;52731.20903186532;52771;52865.735671321396;383327;384117;384171;385170;385484;26519.86740066287;26768.59847102334;27198.72801271962;27321.45357092887;30005.399892002475;49666.50333496763;49973.250401243284;50548;50721;51381;42186.57813421949;43102;43103.7844810774;43574.34638480362;44214.11571768611;42297.365539517545;42874.78562607167;43376;43394.78302608467;43609.41785662825;41772.79113604413;42565;42809.57190428056;42947.9263018427;43149.56850431456;36710.8164459176;38024.80987595044;38201.23597528089;38589;38719.419208712454;28415;28712.712872871005;28818.423631527672;28838.855805721676;29061 11:27:46 INFO - PROCESS | 32641 | |2;jquery.html;407.8042539581001;409.5699515508715;411.7262020756197;415.2228462181861;428.96353809926177;18859.339923102692;19566.11952462139;20511.743708192087;20772.688409673847;20776.792232077692;13155.802662960063;13160.670983225424;13165.078444508888;15907.52277431676;19194.328198513056;5266.81566145185;5447.536959358449;5597.832065038056;6063.393660633923;6115.816525504242;5926.674032928187;5988.251468566429;6006.609570377911;6024.759009639609;6028.849278768044;5401.567874570044;5481.095619222823;5489.505944464997;5498.945010549884;5977.013792724195;5494.203340515623;5500.889982200373;5503.422140675251;5506.807261745819;5524.944750552483;5210.713410762407;5429.267048948421;5429.56563474921;5434.864128396782;5435.918461223085;14194.929025354808;14281.78577321341;14408.351624176938;19779.406617801487;24172.879135604384;2321.7330007049236;2346.8591884486987;2615.9346016349555;2692.909371704463;3031.3937212557576;10491.10825579819;10545.156387488982;11018.063464605519;11204.047655949254;11225.438728063646;1902.1060101752155;1997.3708281891159;2039.5309078911932;2051.887146206958;2054.4555692741437;80685;85703.57148214281;86034;86581;88946.99999999936;11609.245399049034;11611.825822612667;11632.883671163348;11781.469833857496;11973.880261197452;15971.121588312522;16230.51308460748;16238.67522649564;16271.26779294911;16678.833211667727;8295.917040829636;8315;8441.15588441151;8536;8660.48037117775;8156.225158609923;8225.670973161126;8270.37972152091;8379.120192379713;8384.580770961427;5022.573081288058;5130.820421285237;5143.177091665316;5162.432132465426;5273.551748101454;2075.9273425430038;2085.124247815921;2099.0537788956663;2101.810837024675;2176.3906106290265;783.7100272899064;982.94102353859;1028.99485502572;1052.5158427123456;1066.7546464313252;20249.291274805604;20410.28564000253;20532.281370151974;20569.89715051445;20607.278745243846;958.6692591056075;999.9900001000043;1012.6607586458472;1042.588177669816;1069.1767339148812;10571.947140264403;11184.888151118548;11267;11319.094472442184;11387.943060284646;345966;373291;374725;485915;491145;82204.17795822085;88414.55792721124;95971;96461.51769241109;96983;1008.324422636835;1008.8991100889999;1033.9379637221791;1046.0689985912543;1051.495282264502;18193.45419637413;18275.45173644793;18922.3377181798;18958.170708060454;19030.42908712741;39568.60431395764;39976.60023399729;42142.157156856076;42642.36036459517;43986.34020489631;53325.73337133289;54190.18714719361;54414.7279263617;58999.41000590111;60443.09335359885;7468.3278504934815;7728.381729461517;8847.380683352361;9121.392359586369;9124.95437522808;10494.265401421828;13397.397117129947;13542.661433464242;13788.103773254707;13821.861781382058;11775.882241177478;12016.399180040788;12063.336516491678;12168.08739344535;12518.499260029497;11952.593510849367;12140.514379424723;12248.38758062111;12602.49590016389;12743.93628031854;12062.276263424223;12320.383980801103;12327.439816202464;12447.751044979232;12790.232586044867;9063.728088157366;9113.453192808453;9195.218406435528;9267.67563135287;9333.439993600407;9533.570989305637;11364.829527556927;11965.940170299093;12450.81323780126;12490 11:27:46 INFO - PROCESS | 32641 | |3;mootools.html;1339.196482110733;1504.0449314685175;1544.8918575699702;1658.6268089679822;1820.2355010895424;8640.524771137585;9093.590788414529;9111.453312801228;9345.252379809615;9354.672586459475;9111.635534578625;9278.489683067428;9288.628454861815;9293;9298.25613950884;2416.142269494335;2449.9955018442442;2450.3384086296687;2451.914183003595;2453.2027091195346;2312.5721741477796;2412.7587241275905;2473.6907886514186;2473.826832121752;2479.070348619268;2424.3211900667843;2437.9634305485342;2453.7546245375497;2453.865037422941;2466.5930121529927;2308.284431826131;2315.5947709150832;2347.1667558016916;2348.189874493297;2352.4589344450874;2358.7641235876445;2387.307680772574;2420.47959688666;2423.7697418745192;2424.260600516842;8113.472624279462;8306.003279606486;9168;9268.443893366351;9292.72121836346;5118.795248190068;5266.657667251617;5278.709670968095;5349.3045904032615;5358.33020872391;3450.551428314328;3497.475378693191;3498.073010652179;3583.6416358363954;3602.2615363850346;1080.556971641631;1106.6292791914718;1108.4014632098656;1109.290054365207;1112.5605385872616;13050.934745326307;13182.143160694524;13252.867471325357;13268.73462530744;13279.73440531184;4849.345338379344;4927.334809800631;4987.700737955734;4996.200607902791;5060.240963855377;11016.394098324668;11033.172512061628;11040.723981900517;11051.392173430539;11054.392008439612;5547.362053363915;5551.722413879371;5560.276314342485;5572.637778544382;5573.359063707726;4970.304157417964;5038.370203724535;5047.394312682502;5108.106081435734;5122.257272695439;4044.8584299549375;4062.207869465485;4102.50769907607;4140.710150289511;4170.311898536707;1278.213898452445;1291.464042422403;1300.1159211735921;1305.9738805223842;1312.3766211049865;930.8417569013284;971.5676523946917;983.2920297385871;990.2226751999646;994.9900500995042;5999.820005399758;6046.153538504613;6116;6141;6237.251529816361;483.2485485070749;488.1579275749375;491.8868660208172;508.329005712456;510.3263691926695;4049.5950404959267;4131.462909821704;4153.54311025787;4207.642350400189;4232.894177645522;11339.716507087389;11504.194706370641;11533.423328833525;11642.708932276591;11648.592299269485;11381.943090284496;11452.083833293316;11463.942680286546;11464.4840982156;11473.36896470702;8044.2760151586635;8617.870731939025;8734.475931444007;8744.606492707844;8745.781355466164;6000;6001.4298641628975;6013.428724271187;6219.689015549114;6266.905996409966;11004.889951100708;11103.222774405715;11204.719882003015;11213.271137376045;11215.102791776475;10674.46627668598;11105.611303604335;11360.03439707634;11494.367809770543;11525.711857203636;8321.916780832114;8377.539235342114;8431.451955622864;8443.577821109044;8471.195236452528;8749.16882896124;8853.380263381501;8866.689665861923;8874.733757987271;8901.109889011048;7929.286364227247;8046.839063218586;8090.110087890445;8256.587170641564;8309.335253179852;7783.260590243918;7796.961015194887;8020.639071241691;8176.713815016446;8183.181681831769;7385.372243359375;7427.368673662799;7437.851242975002;7459;7466.290702383265;5193.143131383279;5378.811741589026;5464.300865962948;5504.174373843955;5536.307961504812;3971.424143499234;5012.899742005066;5243.790248390022;5247.842564723064;5428.185772134211 11:27:46 INFO - PROCESS | 32641 | |4;prototype.html;347.2672660685953;348.7976973355454;356.9072041269269;359.0001844862058;359.29040145712236;5336.066188417031;5369.24830523727;5371.838844834651;5371.91942120868;5402;5268.367795864501;5290.7354632268425;5342.465753424655;5355.518003379695;5356.678599284046;3758.5113935188524;3984.9439898426867;4185.434966279544;4190.245755763976;4197.307444271707;4156.43888075109;4165.604267594574;4169.353750168729;4174.833006679729;4196.328587426013;4004.879853604382;4180.498340199165;4190.832366705328;4199.916001679964;4201.243776120297;4107.466029416187;4196.139791342767;4196.433481479991;4202.1175553134035;4205.621494065549;3740.3641380965028;3742.288965096623;3743.3262012837677;3744.925101497955;3759.661630453272;5226.189940559181;5233.906437425022;5235.816746413857;5243.659162154486;5251.474852514756;4532.546745325441;4751.3585665935;4754;4819.42166939966;4821.807127714887;5592.406164243172;5605.243292155588;5607.345832979281;5634.183043458716;5657.405972372882;4092.1406504634065;4095.24238015968;4099.1801639672185;4106.67146628269;4112.609302116294;5459.788785541862;5560.638558493725;5603.943960560383;5778.3643799182055;5785.904541070549;4058.9502301338225;4106.864430496125;4121.9381709274385;4123.340265557496;4145.274576949082;4183.288840897055;4190.329547272483;4192.182524407711;4194.6853985951175;4199.811008504625;4579.755919599373;4710.4347478302825;4740.644451666139;4770.7853146607795;4785.760711964457;5502.257195278667;5512.586556008316;5531.3362396512675;5554.333479982428;5598.356189038232;1391.559735673573;1410.153907655419;1412.6185929798896;1420.453125546672;1424.9241822424003;898.5462341517623;936.9718908432758;938.7934654376027;952.9850708994899;956.4887477785082;4745.745770758862;4753.310769938409;4755.2153894607;4763.761422030297;4770.401915358394;5043.36957880265;5049.394072711299;5052.9242061369105;5076.466970968069;5085.355615080138;4770.379850619467;4787.736674482867;4796.77682191046;4798.3042458843975;5036.420811606639;3010.7440867526066;3021.561873528326;3026.3190782073857;3035.165329534396;3054.2975115723507;5871.941280587225;5873;5937.643741375531;5938.851528711817;5948.7323070461935;5569.0254205513875;5822.796202132905;5827.621204621686;5837.124431335249;5861.186630417424;5834.329052159056;5847;5849.976254155506;5861.9413805861395;5873.853153671278;5454.945450545444;5664.603477756517;5679;5739.71301434935;5758.683272420057;5650.152477128464;5673.74468148926;5688;5731;5737.91393129095;5668.886622267614;5811.186433899342;5823.592348535732;5848;5930.140129681258;3986.880393588197;4045.4134150548593;4157.542670306203;4186.120914607966;4202.26460369428;5679.914801278067;5690.374058853606;5693.5160511357;5710.5717071219;5729.770809167587;5410.2696136022705;5618.494335509824;5621.606487545832;5625.634333768292;5652.463016013472;5550.139728342114;5559.749811258423;5575.804846830341;5586.190002449704;5589.720513974204;5270.762815673227;5497.945020549743;5510.9448905510435;5541.445855414427;5562.525930628468;5622.690752008515;5654.886902261849;5654.943450565442;5669.4047125051275;5679.943200567942;5530.557555395479;5531;5533.889322213614;5561.221428999862;5564.4713752193475 11:27:46 INFO - PROCESS | 32641 | |5;yui.html;741.6959046790817;766.0156698642243;769.7844603511015;794.9602519874009;819.7090033038274;14447.349869255882;15177.392904283843;15271.6945661087;15338.616534586641;15363.155026473554;15064.548063558083;15677.29452174652;15679.764803527956;16312.918435407806;16373;808.2119933065259;819.6229734322189;826.1284345016036;826.396730386818;826.8387664405443;659.4295934017089;784.3920961255016;807.317816445103;810.2059981218409;820.8481430935296;840.7898025493627;842.4271495383138;844.1642773654099;844.1811442900377;846.3398549131687;845.8815765792793;846.2087947768856;847.821957388949;848.101012926294;848.8641817309232;505.92411138329174;604.0425924909024;617.7930393318244;619.8202521268872;620.3269452643887;15723.685526289524;15730.9213453932;15739.842601573951;15806.288717007763;15825;13656.317184140753;14188.361523731353;14246.07400518963;14250.2162381069;14253.928730356281;13126.86873131266;13160.6709832254;13171.47314107444;13191.142575732643;13277.46890124394;4494.16857881293;4500.459944806611;4549.385832912581;4555.589996900262;4666.2767271073035;82016.58991705063;82649;82828.58585707094;83958.74061889137;84515;11212.719682008015;11464.541418343173;11534.077273818075;11692.766144677058;11836.408179590986;21505.24731634385;22102.336929891808;22116.33650990473;22127.336179914306;22131.336059918227;8286.295664868554;8906.86639700405;8920.152585504497;8954.462732236087;9053.049429809907;4779.354787103766;4947.307376967227;5032.949670503248;5099;5147.485251474823;3585.103724068983;3723.851045958131;3730.7015438764834;3736;3737.271232109767;639.9712012959428;652.2792314492417;659.0147729144959;660.6894759463045;662.3078882567728;741.6625435426868;772.5967114859055;788.6056971514242;796.259478684817;800.5956991719145;9944.850827237597;10517.684469465928;10579.682609521727;10622.628208012837;10637.30857494276;736.8378956629533;743.2381808646073;753.0661979145929;758.3023618271204;782.2920257167273;4861.854144375674;4941.45643979162;4967.806780976594;4972.8756781080765;5026.623003274769;83588.16411835926;106982;111757;113660;114411;100648;100845.49577252066;101016.49491752642;101751.4912425448;101947.4902625482;87321;88574.55712721395;88978;90507;90959.99999999868;9374.859377109486;9538.95230523843;9557.856632150384;9654.71035868925;9676.41941483485;37455.2508949814;41902;52239.73880130575;52532.737336313076;53399.199012015626;74486.62756686182;79787.60106199431;79853.60073199598;80681;82660.17339826525;12109.757804843677;12152.331621760888;12325.085260880858;12374.381280935737;12465.439055242718;13998.160110393408;14167;14257.358418870968;14349.497767578085;14390.568282951528;10021.549030293509;13155.408006639533;13429.798553021908;13480.123791953492;13834.65413364674;13649.931750341582;13801;14005.159690418608;14099.859001409855;14209.644758881112;14595.124292542481;14770.778438323649;14822.925885370503;14881.181535015678;14888.404463821325;11480.94259528697;11792;11849.703757406134;12242.02063834909;12415.875841241472;12203.755924881276;12321.44553495077;12438.568042908819;12503.249805011728;12600.906668787471 11:27:46 INFO - PROCESS | 32641 | __end_tp_report 11:27:46 INFO - PROCESS | 32641 | __start_cc_report 11:27:46 INFO - PROCESS | 32641 | _x_x_mozilla_cycle_collect,920 11:27:46 INFO - PROCESS | 32641 | __end_cc_report 11:27:46 INFO - PROCESS | 32641 | __startTimestamp1467397666538__endTimestamp 11:27:46 INFO - PROCESS | 32641 | 11:27:46 INFO - PROCESS | 32641 | ------- Summary: start ------- 11:27:46 INFO - PROCESS | 32641 | Number of tests: 6 11:27:46 INFO - PROCESS | 32641 | 11:27:46 INFO - PROCESS | 32641 | [#0] dojo.html Cycles:165 Average:5343.17 Median:5576.94 stddev:604.10 (10.8%) stddev-sans-first:579.66 11:27:46 INFO - PROCESS | 32641 | Values: 3095.7 3096.4 3109.5 3135.3 3167.4 5289.0 5293.2 5361.2 5363.8 5382.3 5330.3 5356.3 5368.0 5377.4 5383.1 4787.5 4878.3 4897.4 4907.6 5020.3 4921.5 4925.0 4956.2 4980.2 4986.8 4813.9 4815.4 4854.3 4864.4 4877.8 4838.9 4860.8 4862.8 4948.3 4986.4 4875.0 4886.3 4900.8 4918.9 4920.8 5264.8 5346.1 5443.6 5484.9 5508.4 5802.1 5825.3 5853.6 5855.2 5863.7 5659.1 5728.7 5732.1 5737.8 5738.4 5371.7 5380.4 5389.5 5487.3 5506.8 5983.3 5995.0 5995.9 5996.6 5999.4 5542.2 5594.7 5758.1 5767.2 5768.1 5713.7 5818.9 5823.6 5828.9 5836.2 5702.1 5730.1 5735.3 5741.6 5745.3 5607.8 5633.0 5688.6 5743.9 5744.9 4359.7 4389.3 4395.2 4418.1 4431.8 3897.7 3921.6 3929.7 3953.0 3964.0 5296.8 5301.7 5347.8 5354.6 5378.0 5736.7 5738.1 5741.5 5765.8 5783.0 5408.6 5416.8 5419.0 5420.2 5427.3 4899.9 4956.9 4978.6 4981.2 4994.5 5964.3 5992.2 5998.4 6001.3 6002.5 5671.7 5686.6 5690.7 5692.0 5695.9 5713.0 5765.1 5841.9 5842.2 5892.9 5593.8 5601.0 5613.7 5614.2 5617.0 5611.6 5643.4 5683.0 5696.6 5699.7 5660.3 5665.5 5678.7 5692.4 5727.6 5658.0 5658.3 5658.8 5660.8 5670.0 5433.2 5476.1 5515.8 5593.7 5596.4 5647.2 5690.3 5696.4 5741.1 5747.1 5564.6 5567.9 5568.2 5576.9 5577.9 11:27:46 INFO - PROCESS | 32641 | 11:27:46 INFO - PROCESS | 32641 | [#1] ext.html Cycles:180 Average:58107.62 Median:40696.40 stddev:114909.01 (282.4%) stddev-sans-first:115150.22 11:27:46 INFO - PROCESS | 32641 | Values: 592.6 613.8 620.3 629.3 633.8 33552.2 36677.4 36729.4 36738.3 44042.0 43395.6 47542.3 47626.3 47751.5 47825.0 9040.1 9190.0 9196.2 9197.4 9198.6 8925.5 8985.0 9010.8 9013.3 9019.5 9005.8 9033.8 9050.0 9053.5 9053.9 8962.6 8986.6 9007.1 9007.5 9013.4 8940.1 9021.6 9027.7 9032.4 9036.6 43572.1 43782.0 43924.0 43940.0 43952.8 3384.1 3403.1 3441.5 3509.6 3871.4 33992.3 34201.8 34430.3 35626.0 35795.6 4273.2 4355.2 4381.6 4383.4 4453.6 336221.0 337646.0 337833.0 338344.0 340036.0 36701.0 37673.6 37701.6 60357.0 61241.4 39436.6 39518.2 39595.6 39597.0 39620.0 15502.5 15573.9 15598.2 15714.4 15734.4 12780.3 12810.0 12869.6 12964.7 13029.8 8984.1 9083.7 9089.2 9145.4 9166.0 3327.7 3435.0 3466.0 3500.3 3551.2 998.3 1055.9 1068.9 1146.4 1161.1 33096.0 33440.5 33480.0 33538.0 33979.0 1148.9 1167.3 1172.4 1200.4 1216.6 17122.6 17168.4 17493.9 17573.4 17656.9 542724.0 546741.0 549420.0 550128.0 550762.0 60785.0 62286.0 62407.7 62408.0 62523.4 1246.8 1363.2 1413.4 1419.5 1419.9 33171.3 34330.8 34494.8 34875.7 34985.0 51980.0 52289.5 52731.2 52771.0 52865.7 383327.0 384117.0 384171.0 385170.0 385484.0 26519.9 26768.6 27198.7 27321.5 30005.4 49666.5 49973.3 50548.0 50721.0 51381.0 42186.6 43102.0 43103.8 43574.3 44214.1 42297.4 42874.8 43376.0 43394.8 43609.4 41772.8 42565.0 42809.6 42947.9 43149.6 36710.8 38024.8 38201.2 38589.0 38719.4 28415.0 28712.7 28818.4 28838.9 29061.0 11:27:46 INFO - PROCESS | 32641 | 11:27:46 INFO - PROCESS | 32641 | [#2] jquery.html Cycles:180 Average:26960.41 Median:13259.87 stddev:69628.01 (525.1%) stddev-sans-first:69794.80 11:27:46 INFO - PROCESS | 32641 | Values: 407.8 409.6 411.7 415.2 429.0 18859.3 19566.1 20511.7 20772.7 20776.8 13155.8 13160.7 13165.1 15907.5 19194.3 5266.8 5447.5 5597.8 6063.4 6115.8 5926.7 5988.3 6006.6 6024.8 6028.8 5401.6 5481.1 5489.5 5498.9 5977.0 5494.2 5500.9 5503.4 5506.8 5524.9 5210.7 5429.3 5429.6 5434.9 5435.9 14194.9 14281.8 14408.4 19779.4 24172.9 2321.7 2346.9 2615.9 2692.9 3031.4 10491.1 10545.2 11018.1 11204.0 11225.4 1902.1 1997.4 2039.5 2051.9 2054.5 80685.0 85703.6 86034.0 86581.0 88947.0 11609.2 11611.8 11632.9 11781.5 11973.9 15971.1 16230.5 16238.7 16271.3 16678.8 8295.9 8315.0 8441.2 8536.0 8660.5 8156.2 8225.7 8270.4 8379.1 8384.6 5022.6 5130.8 5143.2 5162.4 5273.6 2075.9 2085.1 2099.1 2101.8 2176.4 783.7 982.9 1029.0 1052.5 1066.8 20249.3 20410.3 20532.3 20569.9 20607.3 958.7 1000.0 1012.7 1042.6 1069.2 10571.9 11184.9 11267.0 11319.1 11387.9 345966.0 373291.0 374725.0 485915.0 491145.0 82204.2 88414.6 95971.0 96461.5 96983.0 1008.3 1008.9 1033.9 1046.1 1051.5 18193.5 18275.5 18922.3 18958.2 19030.4 39568.6 39976.6 42142.2 42642.4 43986.3 53325.7 54190.2 54414.7 58999.4 60443.1 7468.3 7728.4 8847.4 9121.4 9125.0 10494.3 13397.4 13542.7 13788.1 13821.9 11775.9 12016.4 12063.3 12168.1 12518.5 11952.6 12140.5 12248.4 12602.5 12743.9 12062.3 12320.4 12327.4 12447.8 12790.2 9063.7 9113.5 9195.2 9267.7 9333.4 9533.6 11364.8 11965.9 12450.8 12490.0 11:27:46 INFO - PROCESS | 32641 | 11:27:46 INFO - PROCESS | 32641 | [#3] mootools.html Cycles:180 Average:6081.69 Median:4948.82 stddev:3562.74 (72.0%) stddev-sans-first:3554.90 11:27:46 INFO - PROCESS | 32641 | Values: 1339.2 1504.0 1544.9 1658.6 1820.2 8640.5 9093.6 9111.5 9345.3 9354.7 9111.6 9278.5 9288.6 9293.0 9298.3 2416.1 2450.0 2450.3 2451.9 2453.2 2312.6 2412.8 2473.7 2473.8 2479.1 2424.3 2438.0 2453.8 2453.9 2466.6 2308.3 2315.6 2347.2 2348.2 2352.5 2358.8 2387.3 2420.5 2423.8 2424.3 8113.5 8306.0 9168.0 9268.4 9292.7 5118.8 5266.7 5278.7 5349.3 5358.3 3450.6 3497.5 3498.1 3583.6 3602.3 1080.6 1106.6 1108.4 1109.3 1112.6 13050.9 13182.1 13252.9 13268.7 13279.7 4849.3 4927.3 4987.7 4996.2 5060.2 11016.4 11033.2 11040.7 11051.4 11054.4 5547.4 5551.7 5560.3 5572.6 5573.4 4970.3 5038.4 5047.4 5108.1 5122.3 4044.9 4062.2 4102.5 4140.7 4170.3 1278.2 1291.5 1300.1 1306.0 1312.4 930.8 971.6 983.3 990.2 995.0 5999.8 6046.2 6116.0 6141.0 6237.3 483.2 488.2 491.9 508.3 510.3 4049.6 4131.5 4153.5 4207.6 4232.9 11339.7 11504.2 11533.4 11642.7 11648.6 11381.9 11452.1 11463.9 11464.5 11473.4 8044.3 8617.9 8734.5 8744.6 8745.8 6000.0 6001.4 6013.4 6219.7 6266.9 11004.9 11103.2 11204.7 11213.3 11215.1 10674.5 11105.6 11360.0 11494.4 11525.7 8321.9 8377.5 8431.5 8443.6 8471.2 8749.2 8853.4 8866.7 8874.7 8901.1 7929.3 8046.8 8090.1 8256.6 8309.3 7783.3 7797.0 8020.6 8176.7 8183.2 7385.4 7427.4 7437.9 7459.0 7466.3 5193.1 5378.8 5464.3 5504.2 5536.3 3971.4 5012.9 5243.8 5247.8 5428.2 11:27:46 INFO - PROCESS | 32641 | 11:27:46 INFO - PROCESS | 32641 | [#4] prototype.html Cycles:180 Average:4657.48 Median:5269.57 stddev:1355.92 (25.7%) stddev-sans-first:1320.57 11:27:46 INFO - PROCESS | 32641 | Values: 347.3 348.8 356.9 359.0 359.3 5336.1 5369.2 5371.8 5371.9 5402.0 5268.4 5290.7 5342.5 5355.5 5356.7 3758.5 3984.9 4185.4 4190.2 4197.3 4156.4 4165.6 4169.4 4174.8 4196.3 4004.9 4180.5 4190.8 4199.9 4201.2 4107.5 4196.1 4196.4 4202.1 4205.6 3740.4 3742.3 3743.3 3744.9 3759.7 5226.2 5233.9 5235.8 5243.7 5251.5 4532.5 4751.4 4754.0 4819.4 4821.8 5592.4 5605.2 5607.3 5634.2 5657.4 4092.1 4095.2 4099.2 4106.7 4112.6 5459.8 5560.6 5603.9 5778.4 5785.9 4059.0 4106.9 4121.9 4123.3 4145.3 4183.3 4190.3 4192.2 4194.7 4199.8 4579.8 4710.4 4740.6 4770.8 4785.8 5502.3 5512.6 5531.3 5554.3 5598.4 1391.6 1410.2 1412.6 1420.5 1424.9 898.5 937.0 938.8 953.0 956.5 4745.7 4753.3 4755.2 4763.8 4770.4 5043.4 5049.4 5052.9 5076.5 5085.4 4770.4 4787.7 4796.8 4798.3 5036.4 3010.7 3021.6 3026.3 3035.2 3054.3 5871.9 5873.0 5937.6 5938.9 5948.7 5569.0 5822.8 5827.6 5837.1 5861.2 5834.3 5847.0 5850.0 5861.9 5873.9 5454.9 5664.6 5679.0 5739.7 5758.7 5650.2 5673.7 5688.0 5731.0 5737.9 5668.9 5811.2 5823.6 5848.0 5930.1 3986.9 4045.4 4157.5 4186.1 4202.3 5679.9 5690.4 5693.5 5710.6 5729.8 5410.3 5618.5 5621.6 5625.6 5652.5 5550.1 5559.7 5575.8 5586.2 5589.7 5270.8 5497.9 5510.9 5541.4 5562.5 5622.7 5654.9 5654.9 5669.4 5679.9 5530.6 5531.0 5533.9 5561.2 5564.5 11:27:46 INFO - PROCESS | 32641 | 11:27:46 INFO - PROCESS | 32641 | [#5] yui.html Cycles:180 Average:21129.49 Median:4497.31 stddev:30083.18 (668.9%) stddev-sans-first:30128.62 11:27:46 INFO - PROCESS | 32641 | Values: 741.7 766.0 769.8 795.0 819.7 14447.3 15177.4 15271.7 15338.6 15363.2 15064.5 15677.3 15679.8 16312.9 16373.0 808.2 819.6 826.1 826.4 826.8 659.4 784.4 807.3 810.2 820.8 840.8 842.4 844.2 844.2 846.3 845.9 846.2 847.8 848.1 848.9 505.9 604.0 617.8 619.8 620.3 15723.7 15730.9 15739.8 15806.3 15825.0 13656.3 14188.4 14246.1 14250.2 14253.9 13126.9 13160.7 13171.5 13191.1 13277.5 4494.2 4500.5 4549.4 4555.6 4666.3 82016.6 82649.0 82828.6 83958.7 84515.0 11212.7 11464.5 11534.1 11692.8 11836.4 21505.2 22102.3 22116.3 22127.3 22131.3 8286.3 8906.9 8920.2 8954.5 9053.0 4779.4 4947.3 5032.9 5099.0 5147.5 3585.1 3723.9 3730.7 3736.0 3737.3 640.0 652.3 659.0 660.7 662.3 741.7 772.6 788.6 796.3 800.6 9944.9 10517.7 10579.7 10622.6 10637.3 736.8 743.2 753.1 758.3 782.3 4861.9 4941.5 4967.8 4972.9 5026.6 83588.2 106982.0 111757.0 113660.0 114411.0 100648.0 100845.5 101016.5 101751.5 101947.5 87321.0 88574.6 88978.0 90507.0 90960.0 9374.9 9539.0 9557.9 9654.7 9676.4 37455.3 41902.0 52239.7 52532.7 53399.2 74486.6 79787.6 79853.6 80681.0 82660.2 12109.8 12152.3 12325.1 12374.4 12465.4 13998.2 14167.0 14257.4 14349.5 14390.6 10021.5 13155.4 13429.8 13480.1 13834.7 13649.9 13801.0 14005.2 14099.9 14209.6 14595.1 14770.8 14822.9 14881.2 14888.4 11480.9 11792.0 11849.7 12242.0 12415.9 12203.8 12321.4 12438.6 12503.2 12600.9 11:27:46 INFO - PROCESS | 32641 | -------- Summary: end -------- 11:27:46 INFO - PROCESS | 32641 | 11:27:47 INFO - TEST-INFO | 32641: exit 0 11:27:47 INFO - TEST-OK | dromaeo_css | took 1112757ms 11:27:47 INFO - TEST-START | kraken 11:27:47 INFO - operating with platform_type : linux_ 11:27:47 INFO - Initialising browser for kraken test... 11:27:47 INFO - TEST-INFO | started process 365 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_1rrsF/profile http://localhost:50099/getInfo.html) 11:27:51 INFO - PROCESS | 365 | __metrics Screen width/height:1600/1200 11:27:51 INFO - PROCESS | 365 | colorDepth:24 11:27:51 INFO - PROCESS | 365 | Browser inner width/height: 1024/697 11:27:51 INFO - PROCESS | 365 | __metrics 11:27:52 INFO - PROCESS | 365 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:27:52 INFO - TEST-INFO | 365: exit 0 11:27:52 INFO - Browser initialized. 11:27:52 INFO - Running cycle 1/1 for kraken test... 11:27:52 INFO - TEST-INFO | started process 448 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_1rrsF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:28:04 INFO - PROCESS | 448 | RSS: Main: 156942336 11:28:04 INFO - PROCESS | 448 | 11:28:07 INFO - PROCESS | 448 | Cycle 1(1): loaded http://localhost:50099/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50099/tests/kraken/driver.html?testName=audio-beat-detection) 11:28:07 INFO - PROCESS | 448 | RSS: Main: 215121920 11:28:07 INFO - PROCESS | 448 | 11:28:10 INFO - PROCESS | 448 | Cycle 1(1): loaded http://localhost:50099/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50099/tests/kraken/driver.html?testName=audio-dft) 11:28:11 INFO - PROCESS | 448 | RSS: Main: 202997760 11:28:11 INFO - PROCESS | 448 | 11:28:14 INFO - PROCESS | 448 | Cycle 1(1): loaded http://localhost:50099/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50099/tests/kraken/driver.html?testName=audio-fft) 11:28:14 INFO - PROCESS | 448 | RSS: Main: 269418496 11:28:14 INFO - PROCESS | 448 | 11:28:17 INFO - PROCESS | 448 | Cycle 1(1): loaded http://localhost:50099/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50099/tests/kraken/driver.html?testName=audio-oscillator) 11:28:17 INFO - PROCESS | 448 | RSS: Main: 180170752 11:28:17 INFO - PROCESS | 448 | 11:28:19 INFO - PROCESS | 448 | Cycle 1(1): loaded http://localhost:50099/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50099/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:28:20 INFO - PROCESS | 448 | RSS: Main: 184324096 11:28:20 INFO - PROCESS | 448 | 11:28:23 INFO - PROCESS | 448 | Cycle 1(1): loaded http://localhost:50099/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50099/tests/kraken/driver.html?testName=imaging-darkroom) 11:28:24 INFO - PROCESS | 448 | RSS: Main: 218980352 11:28:24 INFO - PROCESS | 448 | 11:28:27 INFO - PROCESS | 448 | Cycle 1(1): loaded http://localhost:50099/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50099/tests/kraken/driver.html?testName=imaging-desaturate) 11:28:27 INFO - PROCESS | 448 | RSS: Main: 220819456 11:28:27 INFO - PROCESS | 448 | 11:28:30 INFO - PROCESS | 448 | Cycle 1(1): loaded http://localhost:50099/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50099/tests/kraken/driver.html?testName=json-parse-financial) 11:28:31 INFO - PROCESS | 448 | RSS: Main: 221220864 11:28:31 INFO - PROCESS | 448 | 11:28:32 INFO - PROCESS | 448 | Cycle 1(1): loaded http://localhost:50099/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50099/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:28:33 INFO - PROCESS | 448 | RSS: Main: 209719296 11:28:33 INFO - PROCESS | 448 | 11:28:35 INFO - PROCESS | 448 | Cycle 1(1): loaded http://localhost:50099/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50099/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:28:35 INFO - PROCESS | 448 | RSS: Main: 213024768 11:28:35 INFO - PROCESS | 448 | 11:28:37 INFO - PROCESS | 448 | Cycle 1(1): loaded http://localhost:50099/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50099/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:28:38 INFO - PROCESS | 448 | RSS: Main: 210530304 11:28:38 INFO - PROCESS | 448 | 11:28:40 INFO - PROCESS | 448 | Cycle 1(1): loaded http://localhost:50099/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50099/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:28:41 INFO - PROCESS | 448 | RSS: Main: 223657984 11:28:41 INFO - PROCESS | 448 | 11:28:44 INFO - PROCESS | 448 | Cycle 1(1): loaded http://localhost:50099/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50099/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:28:44 INFO - PROCESS | 448 | RSS: Main: 224047104 11:28:44 INFO - PROCESS | 448 | 11:28:46 INFO - PROCESS | 448 | Cycle 1(1): loaded http://localhost:50099/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50099/tests/kraken/driver.html?testName=ai-astar) 11:28:46 INFO - PROCESS | 448 | RSS: Main: 266633216 11:28:46 INFO - PROCESS | 448 | 11:28:46 INFO - PROCESS | 448 | __start_tp_report 11:28:46 INFO - PROCESS | 448 | _x_x_mozilla_page_load 11:28:46 INFO - PROCESS | 448 | _x_x_mozilla_page_load_details 11:28:46 INFO - PROCESS | 448 | |i|pagename|runs| 11:28:46 INFO - PROCESS | 448 | |0;ai-astar;103;112;110;110;111;109;109;111;110;110 11:28:46 INFO - PROCESS | 448 | |1;audio-beat-detection;140;120;117;173;116;119;146;117;150;118 11:28:46 INFO - PROCESS | 448 | |2;audio-dft;161;161;160;161;159;160;159;161;160;161 11:28:46 INFO - PROCESS | 448 | |3;audio-fft;74;75;74;112;75;75;74;75;97;75 11:28:46 INFO - PROCESS | 448 | |4;audio-oscillator;83;84;116;83;84;83;121;83;83;131 11:28:46 INFO - PROCESS | 448 | |5;imaging-gaussian-blur;117;116;117;116;117;117;117;117;117;116 11:28:46 INFO - PROCESS | 448 | |6;imaging-darkroom;145;146;146;145;146;146;146;146;147;146 11:28:46 INFO - PROCESS | 448 | |7;imaging-desaturate;95;95;95;96;95;96;95;95;95;95 11:28:46 INFO - PROCESS | 448 | |8;json-parse-financial;50;53;52;50;52;52;51;53;51;53 11:28:46 INFO - PROCESS | 448 | |9;json-stringify-tinderbox;60;60;58;60;60;60;59;60;59;60 11:28:46 INFO - PROCESS | 448 | |10;stanford-crypto-aes;76;75;75;74;75;74;77;74;74;74 11:28:46 INFO - PROCESS | 448 | |11;stanford-crypto-ccm;126;119;118;118;116;118;119;118;174;126 11:28:46 INFO - PROCESS | 448 | |12;stanford-crypto-pbkdf2;168;157;156;160;157;163;159;158;157;154 11:28:46 INFO - PROCESS | 448 | |13;stanford-crypto-sha256-iterative;64;65;68;66;67;62;66;64;62;64 11:28:46 INFO - PROCESS | 448 | __end_tp_report 11:28:46 INFO - PROCESS | 448 | __start_cc_report 11:28:46 INFO - PROCESS | 448 | _x_x_mozilla_cycle_collect,1682 11:28:46 INFO - PROCESS | 448 | __end_cc_report 11:28:46 INFO - PROCESS | 448 | __startTimestamp1467397726796__endTimestamp 11:28:46 INFO - PROCESS | 448 | 11:28:46 INFO - PROCESS | 448 | ------- Summary: start ------- 11:28:46 INFO - PROCESS | 448 | Number of tests: 14 11:28:46 INFO - PROCESS | 448 | 11:28:46 INFO - PROCESS | 448 | [#0] ai-astar Cycles:10 Average:109.50 Median:110.00 stddev:2.46 (2.2%) stddev-sans-first:0.97 11:28:46 INFO - PROCESS | 448 | Values: 103.0 112.0 110.0 110.0 111.0 109.0 109.0 111.0 110.0 110.0 11:28:46 INFO - PROCESS | 448 | 11:28:46 INFO - PROCESS | 448 | [#1] audio-beat-detection Cycles:10 Average:131.60 Median:130.00 stddev:19.66 (15.1%) stddev-sans-first:20.62 11:28:46 INFO - PROCESS | 448 | Values: 140.0 120.0 117.0 173.0 116.0 119.0 146.0 117.0 150.0 118.0 11:28:46 INFO - PROCESS | 448 | 11:28:46 INFO - PROCESS | 448 | [#2] audio-dft Cycles:10 Average:160.30 Median:161.00 stddev:0.82 (0.5%) stddev-sans-first:0.83 11:28:46 INFO - PROCESS | 448 | Values: 161.0 161.0 160.0 161.0 159.0 160.0 159.0 161.0 160.0 161.0 11:28:46 INFO - PROCESS | 448 | 11:28:46 INFO - PROCESS | 448 | [#3] audio-fft Cycles:10 Average:80.60 Median:75.00 stddev:13.09 (17.5%) stddev-sans-first:13.67 11:28:46 INFO - PROCESS | 448 | Values: 74.0 75.0 74.0 112.0 75.0 75.0 74.0 75.0 97.0 75.0 11:28:46 INFO - PROCESS | 448 | 11:28:46 INFO - PROCESS | 448 | [#4] audio-oscillator Cycles:10 Average:95.10 Median:83.00 stddev:19.36 (23.3%) stddev-sans-first:20.04 11:28:46 INFO - PROCESS | 448 | Values: 83.0 84.0 116.0 83.0 84.0 83.0 121.0 83.0 83.0 131.0 11:28:46 INFO - PROCESS | 448 | 11:28:46 INFO - PROCESS | 448 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 11:28:46 INFO - PROCESS | 448 | Values: 117.0 116.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 116.0 11:28:46 INFO - PROCESS | 448 | 11:28:46 INFO - PROCESS | 448 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.50 11:28:46 INFO - PROCESS | 448 | Values: 145.0 146.0 146.0 145.0 146.0 146.0 146.0 146.0 147.0 146.0 11:28:46 INFO - PROCESS | 448 | 11:28:46 INFO - PROCESS | 448 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 11:28:46 INFO - PROCESS | 448 | Values: 95.0 95.0 95.0 96.0 95.0 96.0 95.0 95.0 95.0 95.0 11:28:46 INFO - PROCESS | 448 | 11:28:46 INFO - PROCESS | 448 | [#8] json-parse-financial Cycles:10 Average:51.70 Median:52.00 stddev:1.16 (2.2%) stddev-sans-first:1.05 11:28:46 INFO - PROCESS | 448 | Values: 50.0 53.0 52.0 50.0 52.0 52.0 51.0 53.0 51.0 53.0 11:28:46 INFO - PROCESS | 448 | 11:28:46 INFO - PROCESS | 448 | [#9] json-stringify-tinderbox Cycles:10 Average:59.60 Median:60.00 stddev:0.70 (1.2%) stddev-sans-first:0.73 11:28:46 INFO - PROCESS | 448 | Values: 60.0 60.0 58.0 60.0 60.0 60.0 59.0 60.0 59.0 60.0 11:28:46 INFO - PROCESS | 448 | 11:28:46 INFO - PROCESS | 448 | [#10] stanford-crypto-aes Cycles:10 Average:74.80 Median:75.00 stddev:1.03 (1.4%) stddev-sans-first:1.00 11:28:46 INFO - PROCESS | 448 | Values: 76.0 75.0 75.0 74.0 75.0 74.0 77.0 74.0 74.0 74.0 11:28:46 INFO - PROCESS | 448 | 11:28:46 INFO - PROCESS | 448 | [#11] stanford-crypto-ccm Cycles:10 Average:125.20 Median:119.00 stddev:17.49 (14.7%) stddev-sans-first:18.54 11:28:46 INFO - PROCESS | 448 | Values: 126.0 119.0 118.0 118.0 116.0 118.0 119.0 118.0 174.0 126.0 11:28:46 INFO - PROCESS | 448 | 11:28:46 INFO - PROCESS | 448 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.90 Median:158.50 stddev:4.01 (2.5%) stddev-sans-first:2.57 11:28:46 INFO - PROCESS | 448 | Values: 168.0 157.0 156.0 160.0 157.0 163.0 159.0 158.0 157.0 154.0 11:28:46 INFO - PROCESS | 448 | 11:28:46 INFO - PROCESS | 448 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.80 Median:65.50 stddev:1.99 (3.0%) stddev-sans-first:2.09 11:28:46 INFO - PROCESS | 448 | Values: 64.0 65.0 68.0 66.0 67.0 62.0 66.0 64.0 62.0 64.0 11:28:46 INFO - PROCESS | 448 | -------- Summary: end -------- 11:28:46 INFO - PROCESS | 448 | 11:28:47 INFO - TEST-INFO | 448: exit 0 11:28:47 INFO - TEST-OK | kraken | took 60526ms 11:28:47 INFO - SUITE-END | took 1173s 11:28:47 INFO - Completed test suite (00:19:33) 11:28:47 INFO - javascript benchmark 11:28:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3095.7213850753433, 3096.3652451247494, 3109.54911537827, 3135.3415782685634, 3167.4456970030255, 5289.047971365153, 5293.232481290211, 5361.169018802082, 5363.785448582057, 5382.300300960875, 5330.28041214436, 5356.303680521536, 5367.973160134204, 5377.381601115872, 5383.084875571152, 4787.521247875211, 4878.292647566101, 4897.436794768594, 4907.6073914086965, 5020.322256495381, 4921.532454416824, 4925.0, 4956.2070068789, 4980.153373926441, 4986.775595098211, 4813.855584332476, 4815.398075240612, 4854.2718592211095, 4864.391951006124, 4877.829275975341, 4838.903221935541, 4860.756962151913, 4862.781174847105, 4948.282499037619, 4986.376702912136, 4874.951250487486, 4886.291487734258, 4900.754962251909, 4918.877028074291, 4920.827771028033, 5264.789408423697, 5346.064438723208, 5443.618946673734, 5484.945150548523, 5508.421615730331, 5802.12968054791, 5825.330087040003, 5853.560982926298, 5855.180274761537, 5863.70681465925, 5659.094544872801, 5728.684922329312, 5732.0542110551705, 5737.770489180428, 5738.42615738427, 5371.704556249405, 5380.408155102975, 5389.541888939445, 5487.341519017744, 5506.834794956158, 5983.341832398432, 5995.0, 5995.880082398415, 5996.640201587831, 5999.430054144849, 5542.224088627595, 5594.664320140804, 5758.136279558016, 5767.163761254678, 5768.134779783066, 5713.685747283939, 5818.912716309259, 5823.5923485355615, 5828.88342233153, 5836.2412886325355, 5702.116171993348, 5730.054541000772, 5735.254416925773, 5741.62679425836, 5745.339285982082, 5607.80372686954, 5633.0, 5688.5733569981585, 5743.8564035899435, 5744.942550574524, 4359.716618419856, 4389.341598760211, 4395.230834603932, 4418.116376724668, 4431.8005689743395, 3897.6881849451975, 3921.6470517653547, 3929.724919255682, 3953.031507280735, 3964.0288129408477, 5296.788128474818, 5301.655392399482, 5347.759350829222, 5354.598405119632, 5378.005069062236, 5736.68448235351, 5738.139279108167, 5741.511971482387, 5765.827025189251, 5783.0, 5408.621396502286, 5416.7562459688625, 5419.0, 5420.214068959979, 5427.348718153847, 4899.853004409873, 4956.90086198274, 4978.626603004789, 4981.153203955337, 4994.450610432849, 5964.314103878023, 5992.191054207713, 5998.370171131968, 6001.279846418371, 6002.519798416116, 5671.688057156896, 5686.630369026, 5690.715464226855, 5692.032354499662, 5695.857603559944, 5713.028785106625, 5765.106408506688, 5841.94158058431, 5842.2405087338375, 5892.882142357043, 5593.804216852391, 5601.04782187021, 5613.663180209201, 5614.157876318422, 5616.971915140398, 5611.551075913999, 5643.35101463337, 5683.0, 5696.572757043321, 5699.715014249188, 5660.349059858169, 5665.49010589049, 5678.68767217807, 5692.430756924275, 5727.570432217683, 5658.0, 5658.321001479849, 5658.801941932013, 5660.773569057192, 5670.007748643889, 5433.239346491416, 5476.069068258326, 5515.806946756844, 5593.720313984366, 5596.440355964371, 5647.15292706081, 5690.2887139107615, 5696.430356964271, 5741.081426971665, 5747.137929310469, 5564.610477266552, 5567.860803479945, 5568.192612071146, 5576.944230557642, 5577.9442205577425], "value": 5302.517658133552, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [592.5792687192094, 613.8281281241249, 620.2742790934607, 629.25747617811, 633.7528363938063, 33552.16119597011, 36677.44983825245, 36729.449058264116, 36738.26523469529, 44042.0, 43395.566044339546, 47542.28686569704, 47626.28560571586, 47751.522484775145, 47825.0, 9040.141186587263, 9189.954050229773, 9196.172344488994, 9197.448153110834, 9198.632054717804, 8925.464472131693, 8985.0, 9010.774730631754, 9013.32400069994, 9019.54902254888, 9005.819883602324, 9033.819323613523, 9049.95475022624, 9053.547322633875, 9053.909460905372, 8962.551872406386, 8986.55067246635, 9007.099290071006, 9007.459552426875, 9013.369064165445, 8940.061293564147, 9021.594028268744, 9027.729168124966, 9032.367734258605, 9036.593353299051, 43572.128557428674, 43782.0, 43924.0, 43940.0, 43952.78023609894, 3384.086296699877, 3403.149212696826, 3441.4665726812386, 3509.6314886937016, 3871.399933010388, 33992.32015359704, 34201.82899085488, 34430.31139377198, 35626.0, 35795.64204357949, 4273.18809426208, 4355.150745604608, 4381.649468042581, 4383.364412160251, 4453.643708503312, 336221.0, 337646.0, 337833.0, 338344.0, 340036.0, 36701.0, 37673.62326376701, 37701.62298377036, 60357.0, 61241.38758612446, 39436.60563394329, 39518.20963580712, 39595.60404395919, 39597.0, 39620.0, 15502.534923952075, 15573.922130389275, 15598.220088995731, 15714.371425142866, 15734.449294274646, 12780.297083660487, 12810.039247056508, 12869.613911582668, 12964.675883102998, 13029.804552931713, 8984.146506081912, 9083.727488175366, 9089.22741566961, 9145.359824812333, 9166.037566055602, 3327.667233276653, 3434.9828250859086, 3466.0, 3500.334936362083, 3551.1654761131113, 998.256299057207, 1055.8996895294936, 1068.8770791359093, 1146.4267866066966, 1161.0653423993765, 33096.0, 33440.49839252413, 33480.0, 33538.0, 33979.0, 1148.8736239013701, 1167.3229526874393, 1172.3903570143477, 1200.363807182195, 1216.558378321674, 17122.571935701457, 17168.39910603123, 17493.91253043752, 17573.384931527336, 17656.91171544134, 542724.0, 546741.0, 549420.0, 550128.0, 550762.0, 60785.0, 62286.0, 62407.6879615599, 62408.0, 62523.374766251756, 1246.8316777235138, 1363.2025265219957, 1413.3639862062114, 1419.5386499387535, 1419.9432022719182, 33171.33657326888, 34330.82834585911, 34494.82752586221, 34875.65124348825, 34985.0, 51980.0, 52289.47710522846, 52731.20903186532, 52771.0, 52865.735671321396, 383327.0, 384117.0, 384171.0, 385170.0, 385484.0, 26519.86740066287, 26768.59847102334, 27198.72801271962, 27321.45357092887, 30005.399892002475, 49666.50333496763, 49973.250401243284, 50548.0, 50721.0, 51381.0, 42186.57813421949, 43102.0, 43103.7844810774, 43574.34638480362, 44214.11571768611, 42297.365539517545, 42874.78562607167, 43376.0, 43394.78302608467, 43609.41785662825, 41772.79113604413, 42565.0, 42809.57190428056, 42947.9263018427, 43149.56850431456, 36710.8164459176, 38024.80987595044, 38201.23597528089, 38589.0, 38719.419208712454, 28415.0, 28712.712872871005, 28818.423631527672, 28838.855805721676, 29061.0], "value": 19268.02538734454, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [407.8042539581001, 409.5699515508715, 411.7262020756197, 415.2228462181861, 428.96353809926177, 18859.339923102692, 19566.11952462139, 20511.743708192087, 20772.688409673847, 20776.792232077692, 13155.802662960063, 13160.670983225424, 13165.078444508888, 15907.52277431676, 19194.328198513056, 5266.81566145185, 5447.536959358449, 5597.832065038056, 6063.393660633923, 6115.816525504242, 5926.674032928187, 5988.251468566429, 6006.609570377911, 6024.759009639609, 6028.849278768044, 5401.567874570044, 5481.095619222823, 5489.505944464997, 5498.945010549884, 5977.013792724195, 5494.203340515623, 5500.889982200373, 5503.422140675251, 5506.807261745819, 5524.944750552483, 5210.713410762407, 5429.267048948421, 5429.56563474921, 5434.864128396782, 5435.918461223085, 14194.929025354808, 14281.78577321341, 14408.351624176938, 19779.406617801487, 24172.879135604384, 2321.7330007049236, 2346.8591884486987, 2615.9346016349555, 2692.909371704463, 3031.3937212557576, 10491.10825579819, 10545.156387488982, 11018.063464605519, 11204.047655949254, 11225.438728063646, 1902.1060101752155, 1997.3708281891159, 2039.5309078911932, 2051.887146206958, 2054.4555692741437, 80685.0, 85703.57148214281, 86034.0, 86581.0, 88946.99999999936, 11609.245399049034, 11611.825822612667, 11632.883671163348, 11781.469833857496, 11973.880261197452, 15971.121588312522, 16230.51308460748, 16238.67522649564, 16271.26779294911, 16678.833211667727, 8295.917040829636, 8315.0, 8441.15588441151, 8536.0, 8660.48037117775, 8156.225158609923, 8225.670973161126, 8270.37972152091, 8379.120192379713, 8384.580770961427, 5022.573081288058, 5130.820421285237, 5143.177091665316, 5162.432132465426, 5273.551748101454, 2075.9273425430038, 2085.124247815921, 2099.0537788956663, 2101.810837024675, 2176.3906106290265, 783.7100272899064, 982.94102353859, 1028.99485502572, 1052.5158427123456, 1066.7546464313252, 20249.291274805604, 20410.28564000253, 20532.281370151974, 20569.89715051445, 20607.278745243846, 958.6692591056075, 999.9900001000043, 1012.6607586458472, 1042.588177669816, 1069.1767339148812, 10571.947140264403, 11184.888151118548, 11267.0, 11319.094472442184, 11387.943060284646, 345966.0, 373291.0, 374725.0, 485915.0, 491145.0, 82204.17795822085, 88414.55792721124, 95971.0, 96461.51769241109, 96983.0, 1008.324422636835, 1008.8991100889999, 1033.9379637221791, 1046.0689985912543, 1051.495282264502, 18193.45419637413, 18275.45173644793, 18922.3377181798, 18958.170708060454, 19030.42908712741, 39568.60431395764, 39976.60023399729, 42142.157156856076, 42642.36036459517, 43986.34020489631, 53325.73337133289, 54190.18714719361, 54414.7279263617, 58999.41000590111, 60443.09335359885, 7468.3278504934815, 7728.381729461517, 8847.380683352361, 9121.392359586369, 9124.95437522808, 10494.265401421828, 13397.397117129947, 13542.661433464242, 13788.103773254707, 13821.861781382058, 11775.882241177478, 12016.399180040788, 12063.336516491678, 12168.08739344535, 12518.499260029497, 11952.593510849367, 12140.514379424723, 12248.38758062111, 12602.49590016389, 12743.93628031854, 12062.276263424223, 12320.383980801103, 12327.439816202464, 12447.751044979232, 12790.232586044867, 9063.728088157366, 9113.453192808453, 9195.218406435528, 9267.67563135287, 9333.439993600407, 9533.570989305637, 11364.829527556927, 11965.940170299093, 12450.81323780126, 12490.0], "value": 9300.223377092369, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1339.196482110733, 1504.0449314685175, 1544.8918575699702, 1658.6268089679822, 1820.2355010895424, 8640.524771137585, 9093.590788414529, 9111.453312801228, 9345.252379809615, 9354.672586459475, 9111.635534578625, 9278.489683067428, 9288.628454861815, 9293.0, 9298.25613950884, 2416.142269494335, 2449.9955018442442, 2450.3384086296687, 2451.914183003595, 2453.2027091195346, 2312.5721741477796, 2412.7587241275905, 2473.6907886514186, 2473.826832121752, 2479.070348619268, 2424.3211900667843, 2437.9634305485342, 2453.7546245375497, 2453.865037422941, 2466.5930121529927, 2308.284431826131, 2315.5947709150832, 2347.1667558016916, 2348.189874493297, 2352.4589344450874, 2358.7641235876445, 2387.307680772574, 2420.47959688666, 2423.7697418745192, 2424.260600516842, 8113.472624279462, 8306.003279606486, 9168.0, 9268.443893366351, 9292.72121836346, 5118.795248190068, 5266.657667251617, 5278.709670968095, 5349.3045904032615, 5358.33020872391, 3450.551428314328, 3497.475378693191, 3498.073010652179, 3583.6416358363954, 3602.2615363850346, 1080.556971641631, 1106.6292791914718, 1108.4014632098656, 1109.290054365207, 1112.5605385872616, 13050.934745326307, 13182.143160694524, 13252.867471325357, 13268.73462530744, 13279.73440531184, 4849.345338379344, 4927.334809800631, 4987.700737955734, 4996.200607902791, 5060.240963855377, 11016.394098324668, 11033.172512061628, 11040.723981900517, 11051.392173430539, 11054.392008439612, 5547.362053363915, 5551.722413879371, 5560.276314342485, 5572.637778544382, 5573.359063707726, 4970.304157417964, 5038.370203724535, 5047.394312682502, 5108.106081435734, 5122.257272695439, 4044.8584299549375, 4062.207869465485, 4102.50769907607, 4140.710150289511, 4170.311898536707, 1278.213898452445, 1291.464042422403, 1300.1159211735921, 1305.9738805223842, 1312.3766211049865, 930.8417569013284, 971.5676523946917, 983.2920297385871, 990.2226751999646, 994.9900500995042, 5999.820005399758, 6046.153538504613, 6116.0, 6141.0, 6237.251529816361, 483.2485485070749, 488.1579275749375, 491.8868660208172, 508.329005712456, 510.3263691926695, 4049.5950404959267, 4131.462909821704, 4153.54311025787, 4207.642350400189, 4232.894177645522, 11339.716507087389, 11504.194706370641, 11533.423328833525, 11642.708932276591, 11648.592299269485, 11381.943090284496, 11452.083833293316, 11463.942680286546, 11464.4840982156, 11473.36896470702, 8044.2760151586635, 8617.870731939025, 8734.475931444007, 8744.606492707844, 8745.781355466164, 6000.0, 6001.4298641628975, 6013.428724271187, 6219.689015549114, 6266.905996409966, 11004.889951100708, 11103.222774405715, 11204.719882003015, 11213.271137376045, 11215.102791776475, 10674.46627668598, 11105.611303604335, 11360.03439707634, 11494.367809770543, 11525.711857203636, 8321.916780832114, 8377.539235342114, 8431.451955622864, 8443.577821109044, 8471.195236452528, 8749.16882896124, 8853.380263381501, 8866.689665861923, 8874.733757987271, 8901.109889011048, 7929.286364227247, 8046.839063218586, 8090.110087890445, 8256.587170641564, 8309.335253179852, 7783.260590243918, 7796.961015194887, 8020.639071241691, 8176.713815016446, 8183.181681831769, 7385.372243359375, 7427.368673662799, 7437.851242975002, 7459.0, 7466.290702383265, 5193.143131383279, 5378.811741589026, 5464.300865962948, 5504.174373843955, 5536.307961504812, 3971.424143499234, 5012.899742005066, 5243.790248390022, 5247.842564723064, 5428.185772134211], "value": 4744.031796415528, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [347.2672660685953, 348.7976973355454, 356.9072041269269, 359.0001844862058, 359.29040145712236, 5336.066188417031, 5369.24830523727, 5371.838844834651, 5371.91942120868, 5402.0, 5268.367795864501, 5290.7354632268425, 5342.465753424655, 5355.518003379695, 5356.678599284046, 3758.5113935188524, 3984.9439898426867, 4185.434966279544, 4190.245755763976, 4197.307444271707, 4156.43888075109, 4165.604267594574, 4169.353750168729, 4174.833006679729, 4196.328587426013, 4004.879853604382, 4180.498340199165, 4190.832366705328, 4199.916001679964, 4201.243776120297, 4107.466029416187, 4196.139791342767, 4196.433481479991, 4202.1175553134035, 4205.621494065549, 3740.3641380965028, 3742.288965096623, 3743.3262012837677, 3744.925101497955, 3759.661630453272, 5226.189940559181, 5233.906437425022, 5235.816746413857, 5243.659162154486, 5251.474852514756, 4532.546745325441, 4751.3585665935, 4754.0, 4819.42166939966, 4821.807127714887, 5592.406164243172, 5605.243292155588, 5607.345832979281, 5634.183043458716, 5657.405972372882, 4092.1406504634065, 4095.24238015968, 4099.1801639672185, 4106.67146628269, 4112.609302116294, 5459.788785541862, 5560.638558493725, 5603.943960560383, 5778.3643799182055, 5785.904541070549, 4058.9502301338225, 4106.864430496125, 4121.9381709274385, 4123.340265557496, 4145.274576949082, 4183.288840897055, 4190.329547272483, 4192.182524407711, 4194.6853985951175, 4199.811008504625, 4579.755919599373, 4710.4347478302825, 4740.644451666139, 4770.7853146607795, 4785.760711964457, 5502.257195278667, 5512.586556008316, 5531.3362396512675, 5554.333479982428, 5598.356189038232, 1391.559735673573, 1410.153907655419, 1412.6185929798896, 1420.453125546672, 1424.9241822424003, 898.5462341517623, 936.9718908432758, 938.7934654376027, 952.9850708994899, 956.4887477785082, 4745.745770758862, 4753.310769938409, 4755.2153894607, 4763.761422030297, 4770.401915358394, 5043.36957880265, 5049.394072711299, 5052.9242061369105, 5076.466970968069, 5085.355615080138, 4770.379850619467, 4787.736674482867, 4796.77682191046, 4798.3042458843975, 5036.420811606639, 3010.7440867526066, 3021.561873528326, 3026.3190782073857, 3035.165329534396, 3054.2975115723507, 5871.941280587225, 5873.0, 5937.643741375531, 5938.851528711817, 5948.7323070461935, 5569.0254205513875, 5822.796202132905, 5827.621204621686, 5837.124431335249, 5861.186630417424, 5834.329052159056, 5847.0, 5849.976254155506, 5861.9413805861395, 5873.853153671278, 5454.945450545444, 5664.603477756517, 5679.0, 5739.71301434935, 5758.683272420057, 5650.152477128464, 5673.74468148926, 5688.0, 5731.0, 5737.91393129095, 5668.886622267614, 5811.186433899342, 5823.592348535732, 5848.0, 5930.140129681258, 3986.880393588197, 4045.4134150548593, 4157.542670306203, 4186.120914607966, 4202.26460369428, 5679.914801278067, 5690.374058853606, 5693.5160511357, 5710.5717071219, 5729.770809167587, 5410.2696136022705, 5618.494335509824, 5621.606487545832, 5625.634333768292, 5652.463016013472, 5550.139728342114, 5559.749811258423, 5575.804846830341, 5586.190002449704, 5589.720513974204, 5270.762815673227, 5497.945020549743, 5510.9448905510435, 5541.445855414427, 5562.525930628468, 5622.690752008515, 5654.886902261849, 5654.943450565442, 5669.4047125051275, 5679.943200567942, 5530.557555395479, 5531.0, 5533.889322213614, 5561.221428999862, 5564.4713752193475], "value": 4231.399868553484, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [741.6959046790817, 766.0156698642243, 769.7844603511015, 794.9602519874009, 819.7090033038274, 14447.349869255882, 15177.392904283843, 15271.6945661087, 15338.616534586641, 15363.155026473554, 15064.548063558083, 15677.29452174652, 15679.764803527956, 16312.918435407806, 16373.0, 808.2119933065259, 819.6229734322189, 826.1284345016036, 826.396730386818, 826.8387664405443, 659.4295934017089, 784.3920961255016, 807.317816445103, 810.2059981218409, 820.8481430935296, 840.7898025493627, 842.4271495383138, 844.1642773654099, 844.1811442900377, 846.3398549131687, 845.8815765792793, 846.2087947768856, 847.821957388949, 848.101012926294, 848.8641817309232, 505.92411138329174, 604.0425924909024, 617.7930393318244, 619.8202521268872, 620.3269452643887, 15723.685526289524, 15730.9213453932, 15739.842601573951, 15806.288717007763, 15825.0, 13656.317184140753, 14188.361523731353, 14246.07400518963, 14250.2162381069, 14253.928730356281, 13126.86873131266, 13160.6709832254, 13171.47314107444, 13191.142575732643, 13277.46890124394, 4494.16857881293, 4500.459944806611, 4549.385832912581, 4555.589996900262, 4666.2767271073035, 82016.58991705063, 82649.0, 82828.58585707094, 83958.74061889137, 84515.0, 11212.719682008015, 11464.541418343173, 11534.077273818075, 11692.766144677058, 11836.408179590986, 21505.24731634385, 22102.336929891808, 22116.33650990473, 22127.336179914306, 22131.336059918227, 8286.295664868554, 8906.86639700405, 8920.152585504497, 8954.462732236087, 9053.049429809907, 4779.354787103766, 4947.307376967227, 5032.949670503248, 5099.0, 5147.485251474823, 3585.103724068983, 3723.851045958131, 3730.7015438764834, 3736.0, 3737.271232109767, 639.9712012959428, 652.2792314492417, 659.0147729144959, 660.6894759463045, 662.3078882567728, 741.6625435426868, 772.5967114859055, 788.6056971514242, 796.259478684817, 800.5956991719145, 9944.850827237597, 10517.684469465928, 10579.682609521727, 10622.628208012837, 10637.30857494276, 736.8378956629533, 743.2381808646073, 753.0661979145929, 758.3023618271204, 782.2920257167273, 4861.854144375674, 4941.45643979162, 4967.806780976594, 4972.8756781080765, 5026.623003274769, 83588.16411835926, 106982.0, 111757.0, 113660.0, 114411.0, 100648.0, 100845.49577252066, 101016.49491752642, 101751.4912425448, 101947.4902625482, 87321.0, 88574.55712721395, 88978.0, 90507.0, 90959.99999999868, 9374.859377109486, 9538.95230523843, 9557.856632150384, 9654.71035868925, 9676.41941483485, 37455.2508949814, 41902.0, 52239.73880130575, 52532.737336313076, 53399.199012015626, 74486.62756686182, 79787.60106199431, 79853.60073199598, 80681.0, 82660.17339826525, 12109.757804843677, 12152.331621760888, 12325.085260880858, 12374.381280935737, 12465.439055242718, 13998.160110393408, 14167.0, 14257.358418870968, 14349.497767578085, 14390.568282951528, 10021.549030293509, 13155.408006639533, 13429.798553021908, 13480.123791953492, 13834.65413364674, 13649.931750341582, 13801.0, 14005.159690418608, 14099.859001409855, 14209.644758881112, 14595.124292542481, 14770.778438323649, 14822.925885370503, 14881.181535015678, 14888.404463821325, 11480.94259528697, 11792.0, 11849.703757406134, 12242.02063834909, 12415.875841241472, 12203.755924881276, 12321.44553495077, 12438.568042908819, 12503.249805011728, 12600.906668787471], "value": 7765.438351228217, "unit": "score"}], "name": "dromaeo_css", "value": 7274.037900101545, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 112.0, 110.0, 110.0, 111.0, 109.0, 109.0, 111.0, 110.0, 110.0], "value": 109.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 120.0, 117.0, 173.0, 116.0, 119.0, 146.0, 117.0, 150.0, 118.0], "value": 131.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 160.0, 161.0, 159.0, 160.0, 159.0, 161.0, 160.0, 161.0], "value": 160.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 74.0, 112.0, 75.0, 75.0, 74.0, 75.0, 97.0, 75.0], "value": 80.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 116.0, 83.0, 84.0, 83.0, 121.0, 83.0, 83.0, 131.0], "value": 95.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 145.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 53.0, 52.0, 50.0, 52.0, 52.0, 51.0, 53.0, 51.0, 53.0], "value": 51.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 58.0, 60.0, 60.0, 60.0, 59.0, 60.0, 59.0, 60.0], "value": 59.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 75.0, 74.0, 75.0, 74.0, 77.0, 74.0, 74.0, 74.0], "value": 74.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 119.0, 118.0, 118.0, 116.0, 118.0, 119.0, 118.0, 174.0, 126.0], "value": 125.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 157.0, 156.0, 160.0, 157.0, 163.0, 159.0, 158.0, 157.0, 154.0], "value": 158.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 68.0, 66.0, 67.0, 62.0, 66.0, 64.0, 62.0, 64.0], "value": 64.8, "unit": "score"}], "name": "kraken", "value": 1469.9, "alertThreshold": 2.0}]} 11:28:48 INFO - Return code: 0 11:28:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:28:48 INFO - # TBPL SUCCESS # 11:28:48 INFO - Running post-action listener: _resource_record_post_action 11:28:48 INFO - ##### 11:28:48 INFO - ##### Finished run-tests step (success) 11:28:48 INFO - ##### 11:28:48 INFO - Running post-run listener: _resource_record_post_run 11:28:48 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 570507264; Read time: 8; Write time: 395892 11:28:48 INFO - TinderboxPrint: CPU usage
13.0% 11:28:48 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 11:28:48 INFO - TinderboxPrint: I/O write bytes / time
570,507,264 / 395,892 11:28:48 INFO - TinderboxPrint: CPU idle
8,270.1 (87.0%) 11:28:48 INFO - TinderboxPrint: CPU user
1,195.1 (12.6%) 11:28:48 INFO - TinderboxPrint: Swap in / out
0 / 0 11:28:48 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 273170432; Read time: 0; Write time: 210852 11:28:48 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 297336832; Read time: 0; Write time: 185040 11:28:48 INFO - Running post-run listener: _upload_blobber_files 11:28:48 INFO - Blob upload gear active. 11:28:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:28:48 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:28:48 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:28:48 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:28:49 INFO - (blobuploader) - INFO - Open directory for files ... 11:28:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:28:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:28:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:28:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:28:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:28:49 INFO - (blobuploader) - INFO - Done attempting. 11:28:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:28:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:28:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:28:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:28:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:28:51 INFO - (blobuploader) - INFO - Done attempting. 11:28:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:28:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:28:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:28:56 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:28:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:28:56 INFO - (blobuploader) - INFO - Done attempting. 11:28:56 INFO - (blobuploader) - INFO - Iteration through files over. 11:28:56 INFO - Return code: 0 11:28:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:28:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:28:56 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/69cbb4171b1ab55d8b8b3baf4d87aa808dd712426f6a3fd0c1cc20d04a4bb87aa2eee07e4da25ce141cd2a80f9edf6a8ebdb5388be654b104b7e4d531f6e5a13", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ed54ac131dc91c80ef71487c8f6afc77e16b2c0a4d0144d99ab0897fd160661919170d621c6554b943b13da45df48059619d1e467133de13ff441ca86cd9e098", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/eaf5f3dd072cb35e92eccad8960a81c0c15b856a8932d8dbfca1eb8e685504d679aed3a6d592e33737758775b50fc8462a22347eb45a170bc9099b096a8d7826"} 11:28:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:28:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:28:56 INFO - Contents: 11:28:56 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/69cbb4171b1ab55d8b8b3baf4d87aa808dd712426f6a3fd0c1cc20d04a4bb87aa2eee07e4da25ce141cd2a80f9edf6a8ebdb5388be654b104b7e4d531f6e5a13", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ed54ac131dc91c80ef71487c8f6afc77e16b2c0a4d0144d99ab0897fd160661919170d621c6554b943b13da45df48059619d1e467133de13ff441ca86cd9e098", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/eaf5f3dd072cb35e92eccad8960a81c0c15b856a8932d8dbfca1eb8e685504d679aed3a6d592e33737758775b50fc8462a22347eb45a170bc9099b096a8d7826"} 11:28:56 INFO - Running post-run listener: copy_logs_to_upload_dir 11:28:56 INFO - Copying logs to upload dir... 11:28:56 INFO - mkdir: /builds/slave/test/build/upload/logs 11:28:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.538517 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-07-01 11:28:55.375477) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-01 11:28:55.378753) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1467395456.9183-1780684504 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/69cbb4171b1ab55d8b8b3baf4d87aa808dd712426f6a3fd0c1cc20d04a4bb87aa2eee07e4da25ce141cd2a80f9edf6a8ebdb5388be654b104b7e4d531f6e5a13", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ed54ac131dc91c80ef71487c8f6afc77e16b2c0a4d0144d99ab0897fd160661919170d621c6554b943b13da45df48059619d1e467133de13ff441ca86cd9e098", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/eaf5f3dd072cb35e92eccad8960a81c0c15b856a8932d8dbfca1eb8e685504d679aed3a6d592e33737758775b50fc8462a22347eb45a170bc9099b096a8d7826"} build_url:https://queue.taskcluster.net/v1/task/Yl6O7QocSEa_LgZ_0hZvMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011327 build_url: 'https://queue.taskcluster.net/v1/task/Yl6O7QocSEa_LgZ_0hZvMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/69cbb4171b1ab55d8b8b3baf4d87aa808dd712426f6a3fd0c1cc20d04a4bb87aa2eee07e4da25ce141cd2a80f9edf6a8ebdb5388be654b104b7e4d531f6e5a13", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ed54ac131dc91c80ef71487c8f6afc77e16b2c0a4d0144d99ab0897fd160661919170d621c6554b943b13da45df48059619d1e467133de13ff441ca86cd9e098", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/eaf5f3dd072cb35e92eccad8960a81c0c15b856a8932d8dbfca1eb8e685504d679aed3a6d592e33737758775b50fc8462a22347eb45a170bc9099b096a8d7826"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-01 11:28:55.404964) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 11:28:55.405307) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1467395456.9183-1780684504 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004482 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 11:28:55.487629) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-01 11:28:55.487986) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-01 11:28:55.488343) ========= ========= Total master_lag: 0.16 =========