builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-027 starttime: 1468376253.0 results: success (0) buildid: 20160712113033 builduid: 8cca8c68f3464c57a6d6ceda6bed02dc revision: 55922a4a546c9a6b5c6842aeb00b65c10b29bfc2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-12 19:17:32.999100) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-12 19:17:32.999518) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-12 19:17:33.000075) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-12 19:17:33.015856) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 19:17:33.016137) ========= 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=1f5564757af27664ca02d71f000001b0-1468376220.467006-964018221 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-12 19:17:33-- 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% 43.3M=0s 2016-07-12 19:17:33 (43.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.137559 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 19:17:33.167310) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 19:17:33.167630) ========= 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=1f5564757af27664ca02d71f000001b0-1468376220.467006-964018221 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015594 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 19:17:33.216676) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 19:17:33.216993) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 55922a4a546c9a6b5c6842aeb00b65c10b29bfc2 --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 55922a4a546c9a6b5c6842aeb00b65c10b29bfc2 --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=1f5564757af27664ca02d71f000001b0-1468376220.467006-964018221 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-12 19:17:33,274 truncating revision to first 12 chars 2016-07-12 19:17:33,274 Setting DEBUG logging. 2016-07-12 19:17:33,274 attempt 1/10 2016-07-12 19:17:33,274 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/55922a4a546c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-12 19:17:33,578 unpacking tar archive at: fx-team-55922a4a546c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.631295 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 19:17:33.862099) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-12 19:17:33.862475) ========= script_repo_revision: 55922a4a546c9a6b5c6842aeb00b65c10b29bfc2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-12 19:17:33.863051) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-12 19:17:33.863338) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-12 19:17:33.874562) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-07-12 19:17:33.874965) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=1f5564757af27664ca02d71f000001b0-1468376220.467006-964018221 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:17:34 INFO - MultiFileLogger online at 20160712 19:17:34 in /builds/slave/test 19:17:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 19:17:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:17:34 INFO - {'append_to_log': False, 19:17:34 INFO - 'base_work_dir': '/builds/slave/test', 19:17:34 INFO - 'blob_upload_branch': 'Fx-Team', 19:17:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:17:34 INFO - 'branch': 'Fx-Team', 19:17:34 INFO - 'buildbot_json_path': 'buildprops.json', 19:17:34 INFO - 'config_files': ('talos/linux_config.py',), 19:17:34 INFO - 'default_actions': ('clobber', 19:17:34 INFO - 'read-buildbot-config', 19:17:34 INFO - 'download-and-extract', 19:17:34 INFO - 'populate-webroot', 19:17:34 INFO - 'create-virtualenv', 19:17:34 INFO - 'install', 19:17:34 INFO - 'run-tests'), 19:17:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:17:34 INFO - 'download_minidump_stackwalk': True, 19:17:34 INFO - 'download_symbols': 'ondemand', 19:17:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:17:34 INFO - 'tooltool.py': '/tools/tooltool.py', 19:17:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:17:34 INFO - '/tools/misc-python/virtualenv.py')}, 19:17:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:17:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:17:34 INFO - 'installer_path': 'installer.exe', 19:17:34 INFO - 'log_level': 'info', 19:17:34 INFO - 'log_name': 'talos', 19:17:34 INFO - 'log_to_console': True, 19:17:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:17:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:17:34 INFO - 'opt_config_files': (), 19:17:34 INFO - 'pip_index': False, 19:17:34 INFO - 'sps_profile': False, 19:17:34 INFO - 'sps_profile_interval': 0, 19:17:34 INFO - 'suite': 'dromaeojs-e10s', 19:17:34 INFO - 'system_bits': '32', 19:17:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:17:34 INFO - 'title': 'talos-linux64-ix-027', 19:17:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:17:34 INFO - 'use_talos_json': True, 19:17:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:17:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:17:34 INFO - 'work_dir': 'build'} 19:17:34 INFO - ##### 19:17:34 INFO - ##### Running clobber step. 19:17:34 INFO - ##### 19:17:34 INFO - Running pre-action listener: _resource_record_pre_action 19:17:34 INFO - Running main action method: clobber 19:17:34 INFO - rmtree: /builds/slave/test/build 19:17:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:17:34 INFO - Running post-action listener: _resource_record_post_action 19:17:34 INFO - ##### 19:17:34 INFO - ##### Finished clobber step (success) 19:17:34 INFO - ##### 19:17:34 INFO - ##### 19:17:34 INFO - ##### Running read-buildbot-config step. 19:17:34 INFO - ##### 19:17:34 INFO - Running pre-action listener: _resource_record_pre_action 19:17:34 INFO - Running main action method: read_buildbot_config 19:17:34 INFO - Using buildbot properties: 19:17:34 INFO - { 19:17:34 INFO - "project": "", 19:17:34 INFO - "product": "firefox", 19:17:34 INFO - "script_repo_revision": "production", 19:17:34 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 19:17:34 INFO - "repository": "", 19:17:34 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 19:17:34 INFO - "buildid": "20160712113033", 19:17:34 INFO - "pgo_build": "True", 19:17:34 INFO - "basedir": "/builds/slave/test", 19:17:34 INFO - "buildnumber": 920, 19:17:34 INFO - "slavename": "talos-linux64-ix-027", 19:17:34 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 19:17:34 INFO - "platform": "ubuntu64_hw", 19:17:34 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 19:17:34 INFO - "branch": "fx-team", 19:17:34 INFO - "repo_path": "integration/fx-team", 19:17:34 INFO - "revision": "55922a4a546c9a6b5c6842aeb00b65c10b29bfc2", 19:17:34 INFO - "stage_platform": "linux64-pgo", 19:17:34 INFO - "builduid": "8cca8c68f3464c57a6d6ceda6bed02dc", 19:17:34 INFO - "slavebuilddir": "test" 19:17:34 INFO - } 19:17:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/dVV6kjT8RjGFQjlhC-YxNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 19:17:34 INFO - Running post-action listener: _resource_record_post_action 19:17:34 INFO - ##### 19:17:34 INFO - ##### Finished read-buildbot-config step (success) 19:17:34 INFO - ##### 19:17:34 INFO - ##### 19:17:34 INFO - ##### Running download-and-extract step. 19:17:34 INFO - ##### 19:17:34 INFO - Running pre-action listener: _resource_record_pre_action 19:17:34 INFO - Running main action method: download_and_extract 19:17:34 INFO - mkdir: /builds/slave/test/build/tests 19:17:34 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')]} 19:17:34 INFO - https://queue.taskcluster.net/v1/task/dVV6kjT8RjGFQjlhC-YxNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 19:17:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dVV6kjT8RjGFQjlhC-YxNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:17:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dVV6kjT8RjGFQjlhC-YxNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:17:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dVV6kjT8RjGFQjlhC-YxNA/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 19:17:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dVV6kjT8RjGFQjlhC-YxNA/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 19:17:35 INFO - Downloaded 1361 bytes. 19:17:35 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:17:35 INFO - Using the following test package requirements: 19:17:35 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 19:17:35 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:17:35 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:17:35 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:17:35 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:17:35 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:17:35 INFO - u'jsshell-linux-x86_64.zip'], 19:17:35 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:17:35 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:17:35 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 19:17:35 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:17:35 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:17:35 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:17:35 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:17:35 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:17:35 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:17:35 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:17:35 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:17:35 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:17:35 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')]} 19:17:35 INFO - https://queue.taskcluster.net/v1/task/dVV6kjT8RjGFQjlhC-YxNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:17:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dVV6kjT8RjGFQjlhC-YxNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:17:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dVV6kjT8RjGFQjlhC-YxNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:17:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dVV6kjT8RjGFQjlhC-YxNA/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 19:17:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dVV6kjT8RjGFQjlhC-YxNA/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 19:17:37 INFO - Downloaded 24319804 bytes. 19:17:37 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'] 19:17:37 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 19:17:38 INFO - Return code: 0 19:17:38 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 19:17: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')]} 19:17:38 INFO - https://queue.taskcluster.net/v1/task/dVV6kjT8RjGFQjlhC-YxNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:17:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dVV6kjT8RjGFQjlhC-YxNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:17:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dVV6kjT8RjGFQjlhC-YxNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:17:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dVV6kjT8RjGFQjlhC-YxNA/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 19:17:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dVV6kjT8RjGFQjlhC-YxNA/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 19:17:40 INFO - Downloaded 24319804 bytes. 19:17:40 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'] 19:17:40 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 19:17:41 INFO - Return code: 0 19:17: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')]} 19:17:41 INFO - https://queue.taskcluster.net/v1/task/dVV6kjT8RjGFQjlhC-YxNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:17:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dVV6kjT8RjGFQjlhC-YxNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 19:17:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dVV6kjT8RjGFQjlhC-YxNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 19:17:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dVV6kjT8RjGFQjlhC-YxNA/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 19:17:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dVV6kjT8RjGFQjlhC-YxNA/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 19:17:42 INFO - Downloaded 14403317 bytes. 19:17:42 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'] 19:17:42 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 19:17:42 INFO - Return code: 0 19:17:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 19:17:42 INFO - https://queue.taskcluster.net/v1/task/dVV6kjT8RjGFQjlhC-YxNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:17:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dVV6kjT8RjGFQjlhC-YxNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:17:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dVV6kjT8RjGFQjlhC-YxNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:17:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dVV6kjT8RjGFQjlhC-YxNA/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 19:17:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dVV6kjT8RjGFQjlhC-YxNA/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 19:17:44 INFO - Downloaded 60493091 bytes. 19:17:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dVV6kjT8RjGFQjlhC-YxNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:17:44 INFO - mkdir: /builds/slave/test/properties 19:17:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:17:44 INFO - Writing to file /builds/slave/test/properties/build_url 19:17:44 INFO - Contents: 19:17:44 INFO - build_url:https://queue.taskcluster.net/v1/task/dVV6kjT8RjGFQjlhC-YxNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:17:44 INFO - Running post-action listener: _resource_record_post_action 19:17:44 INFO - Running post-action listener: set_extra_try_arguments 19:17:44 INFO - ##### 19:17:44 INFO - ##### Finished download-and-extract step (success) 19:17:44 INFO - ##### 19:17:44 INFO - ##### 19:17:44 INFO - ##### Running populate-webroot step. 19:17:44 INFO - ##### 19:17:44 INFO - Running pre-action listener: _resource_record_pre_action 19:17:44 INFO - Running main action method: populate_webroot 19:17:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:17:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:17:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:17:44 INFO - '--tppagecycles', 19:17:44 INFO - '7'], 19:17:44 INFO - 'tests': ['tsvgm']}}, 19:17:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:17:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:17:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:17:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:17:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:17:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:17:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:17:44 INFO - 'talos_options': ['--disable-e10s'], 19:17:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:17:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:17:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:17:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:17:44 INFO - 'talos_options': ['--disable-e10s'], 19:17:44 INFO - 'tests': ['damp', 'tps']}, 19:17:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:17:44 INFO - 'tests': ['damp', 'tps']}, 19:17:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:17:44 INFO - 'tests': ['dromaeo_dom']}, 19:17:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:17:44 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:17:44 INFO - 'tests': ['basic_compositor_video']}, 19:17:44 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:17:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:17:44 INFO - 'tests': ['a11yr', 19:17:44 INFO - 'ts_paint', 19:17:44 INFO - 'tpaint', 19:17:44 INFO - 'sessionrestore', 19:17:44 INFO - 'sessionrestore_no_auto_restore', 19:17:44 INFO - 'tabpaint']}, 19:17:44 INFO - 'other-e10s': {'tests': ['a11yr', 19:17:44 INFO - 'ts_paint', 19:17:44 INFO - 'tpaint', 19:17:44 INFO - 'sessionrestore', 19:17:44 INFO - 'sessionrestore_no_auto_restore', 19:17:44 INFO - 'tabpaint']}, 19:17:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:17:44 INFO - 'ts_paint', 19:17:44 INFO - 'tpaint', 19:17:44 INFO - 'sessionrestore', 19:17:44 INFO - 'sessionrestore_no_auto_restore', 19:17:44 INFO - 'tabpaint']}, 19:17:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:17:44 INFO - 'ts_paint', 19:17:44 INFO - 'tpaint', 19:17:44 INFO - 'sessionrestore', 19:17:44 INFO - 'sessionrestore_no_auto_restore', 19:17:44 INFO - 'tabpaint']}, 19:17:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:17:44 INFO - 'tests': ['a11yr', 19:17:44 INFO - 'ts_paint', 19:17:44 INFO - 'tpaint', 19:17:44 INFO - 'sessionrestore', 19:17:44 INFO - 'sessionrestore_no_auto_restore', 19:17:44 INFO - 'tabpaint']}, 19:17:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:17:44 INFO - 'tests': ['a11yr', 19:17:44 INFO - 'ts_paint', 19:17:44 INFO - 'tpaint', 19:17:44 INFO - 'sessionrestore', 19:17:44 INFO - 'sessionrestore_no_auto_restore', 19:17:44 INFO - 'tabpaint']}, 19:17:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:17:44 INFO - 'tests': ['tsvgx', 19:17:44 INFO - 'tsvgr_opacity', 19:17:44 INFO - 'tart', 19:17:44 INFO - 'tscrollx', 19:17:44 INFO - 'cart']}, 19:17:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:17:44 INFO - 'tsvgr_opacity', 19:17:44 INFO - 'tart', 19:17:44 INFO - 'tscrollx', 19:17:44 INFO - 'cart']}, 19:17:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:17:44 INFO - 'talos_options': ['--disable-e10s'], 19:17:44 INFO - 'tests': ['tp5o']}, 19:17:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:17:44 INFO - 'tests': ['tp5o']}, 19:17:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:17:44 INFO - 'talos_options': ['--disable-e10s', 19:17:44 INFO - '--xperf_path', 19:17:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:17:44 INFO - 'tests': ['tp5n']}, 19:17:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:17:44 INFO - 'talos_options': ['--xperf_path', 19:17:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:17:44 INFO - 'tests': ['tp5n']}}, 19:17:44 INFO - 'talos.zip': {'path': '', 19:17:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:17:44 INFO - Running post-action listener: _resource_record_post_action 19:17:44 INFO - ##### 19:17:44 INFO - ##### Finished populate-webroot step (success) 19:17:44 INFO - ##### 19:17:44 INFO - ##### 19:17:44 INFO - ##### Running create-virtualenv step. 19:17:44 INFO - ##### 19:17:44 INFO - Running pre-action listener: _resource_record_pre_action 19:17:44 INFO - Running main action method: create_virtualenv 19:17:44 INFO - Creating virtualenv /builds/slave/test/build/venv 19:17:44 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 19:17:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:17:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:17:44 INFO - Using real prefix '/usr' 19:17:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:17:45 INFO - Installing distribute.............................................................................................................................................................................................done. 19:17:47 INFO - Installing pip.................done. 19:17:47 INFO - Return code: 0 19:17:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:17:47 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')]} 19:17:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:17:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:17:47 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')]} 19:17:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:17:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:17:47 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 0x1a84030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d45180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d433b0>, '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 0x1d442b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d44740>, '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': '1f5564757af27664ca02d71f000001b0-1468376220.467006-964018221', '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 19:17:47 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 19:17:47 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 19:17:47 INFO - Using env: {'DISPLAY': ':0', 19:17:47 INFO - 'HOME': '/home/cltbld', 19:17:47 INFO - 'LANG': 'en_US.UTF-8', 19:17:47 INFO - 'LANGUAGE': 'en_US:en', 19:17:47 INFO - 'LOGNAME': 'cltbld', 19:17:47 INFO - 'MAIL': '/var/mail/cltbld', 19:17:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:17:47 INFO - 'MOZ_NO_REMOTE': '1', 19:17:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:17:47 INFO - 'NO_EM_RESTART': '1', 19:17:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:17:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:17:47 INFO - 'PWD': '/builds/slave/test', 19:17:47 INFO - 'SHELL': '/bin/bash', 19:17:47 INFO - 'SHLVL': '1', 19:17:47 INFO - 'TERM': 'linux', 19:17:47 INFO - 'TMOUT': '86400', 19:17:47 INFO - 'USER': 'cltbld', 19:17:47 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1468376220.467006-964018221', 19:17:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:17:47 INFO - '_': '/tools/buildbot/bin/python'} 19:17:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:17:47 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 19:17:47 INFO - Cleaning up... 19:17:47 INFO - Return code: 0 19:17:47 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:17:47 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')]} 19:17:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:17:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:17:47 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')]} 19:17:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:17:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:17:47 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 0x1a84030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d45180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d433b0>, '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 0x1d442b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d44740>, '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': '1f5564757af27664ca02d71f000001b0-1468376220.467006-964018221', '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 19:17:47 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 19:17:47 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 19:17:47 INFO - Using env: {'DISPLAY': ':0', 19:17:47 INFO - 'HOME': '/home/cltbld', 19:17:47 INFO - 'LANG': 'en_US.UTF-8', 19:17:47 INFO - 'LANGUAGE': 'en_US:en', 19:17:47 INFO - 'LOGNAME': 'cltbld', 19:17:47 INFO - 'MAIL': '/var/mail/cltbld', 19:17:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:17:47 INFO - 'MOZ_NO_REMOTE': '1', 19:17:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:17:47 INFO - 'NO_EM_RESTART': '1', 19:17:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:17:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:17:47 INFO - 'PWD': '/builds/slave/test', 19:17:47 INFO - 'SHELL': '/bin/bash', 19:17:47 INFO - 'SHLVL': '1', 19:17:47 INFO - 'TERM': 'linux', 19:17:47 INFO - 'TMOUT': '86400', 19:17:47 INFO - 'USER': 'cltbld', 19:17:47 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1468376220.467006-964018221', 19:17:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:17:47 INFO - '_': '/tools/buildbot/bin/python'} 19:17:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:17:47 INFO - Downloading/unpacking psutil>=3.1.1 19:17:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:17:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:17:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:17:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:17:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:17:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:17:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:17:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:17:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:17:50 INFO - Installing collected packages: psutil 19:17:50 INFO - Running setup.py install for psutil 19:17:50 INFO - building 'psutil._psutil_linux' extension 19:17:50 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 19:17:50 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 19:17:50 INFO - building 'psutil._psutil_posix' extension 19:17:50 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 19:17:50 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 19:17:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:17:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:17:50 INFO - Successfully installed psutil 19:17:50 INFO - Cleaning up... 19:17:50 INFO - Return code: 0 19:17:50 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:17:50 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')]} 19:17:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:17:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:17:50 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')]} 19:17:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:17:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:17:50 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 0x1a84030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d45180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d433b0>, '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 0x1d442b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d44740>, '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': '1f5564757af27664ca02d71f000001b0-1468376220.467006-964018221', '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 19:17:50 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 19:17:50 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 19:17:50 INFO - Using env: {'DISPLAY': ':0', 19:17:50 INFO - 'HOME': '/home/cltbld', 19:17:50 INFO - 'LANG': 'en_US.UTF-8', 19:17:50 INFO - 'LANGUAGE': 'en_US:en', 19:17:50 INFO - 'LOGNAME': 'cltbld', 19:17:50 INFO - 'MAIL': '/var/mail/cltbld', 19:17:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:17:50 INFO - 'MOZ_NO_REMOTE': '1', 19:17:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:17:50 INFO - 'NO_EM_RESTART': '1', 19:17:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:17:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:17:50 INFO - 'PWD': '/builds/slave/test', 19:17:50 INFO - 'SHELL': '/bin/bash', 19:17:50 INFO - 'SHLVL': '1', 19:17:50 INFO - 'TERM': 'linux', 19:17:50 INFO - 'TMOUT': '86400', 19:17:50 INFO - 'USER': 'cltbld', 19:17:50 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1468376220.467006-964018221', 19:17:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:17:50 INFO - '_': '/tools/buildbot/bin/python'} 19:17:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:17:50 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:17:50 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 19:17:50 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 19:17:50 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 19:17:50 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 19:17:50 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 19:17:50 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 19:17:52 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:17:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:17:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:17:52 INFO - Installing collected packages: mozsystemmonitor 19:17:52 INFO - Running setup.py install for mozsystemmonitor 19:17:52 INFO - Successfully installed mozsystemmonitor 19:17:52 INFO - Cleaning up... 19:17:52 INFO - Return code: 0 19:17:52 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:17: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')]} 19:17:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:17:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:17: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')]} 19:17:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:17:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:17:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1a84030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d45180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d433b0>, '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 0x1d442b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d44740>, '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': '1f5564757af27664ca02d71f000001b0-1468376220.467006-964018221', '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 19:17:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 19:17:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 19:17:52 INFO - Using env: {'DISPLAY': ':0', 19:17:52 INFO - 'HOME': '/home/cltbld', 19:17:52 INFO - 'LANG': 'en_US.UTF-8', 19:17:52 INFO - 'LANGUAGE': 'en_US:en', 19:17:52 INFO - 'LOGNAME': 'cltbld', 19:17:52 INFO - 'MAIL': '/var/mail/cltbld', 19:17:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:17:52 INFO - 'MOZ_NO_REMOTE': '1', 19:17:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:17:52 INFO - 'NO_EM_RESTART': '1', 19:17:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:17:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:17:52 INFO - 'PWD': '/builds/slave/test', 19:17:52 INFO - 'SHELL': '/bin/bash', 19:17:52 INFO - 'SHLVL': '1', 19:17:52 INFO - 'TERM': 'linux', 19:17:52 INFO - 'TMOUT': '86400', 19:17:52 INFO - 'USER': 'cltbld', 19:17:52 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1468376220.467006-964018221', 19:17:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:17:52 INFO - '_': '/tools/buildbot/bin/python'} 19:17:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:17:53 INFO - Downloading/unpacking jsonschema==2.5.1 19:17:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:17:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:17:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:17:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:17:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:17:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:17:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:17:54 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:17: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 19:17: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 19:17: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 19:17: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 19:17: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 19:17: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 19:17:55 INFO - Downloading functools32-3.2.3-2.tar.gz 19:17:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:17:55 INFO - warning: no files found matching '*.txt' 19:17:55 INFO - no previously-included directories found matching 'build' 19:17:55 INFO - no previously-included directories found matching 'dist' 19:17:55 INFO - no previously-included directories found matching '.git*' 19:17:55 INFO - Installing collected packages: jsonschema, functools32 19:17:55 INFO - Running setup.py install for functools32 19:17:55 INFO - warning: no files found matching '*.txt' 19:17:55 INFO - no previously-included directories found matching 'build' 19:17:55 INFO - no previously-included directories found matching 'dist' 19:17:55 INFO - no previously-included directories found matching '.git*' 19:17:55 INFO - Successfully installed jsonschema functools32 19:17:55 INFO - Cleaning up... 19:17:55 INFO - Return code: 0 19:17:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:17:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:17:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:17:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:17:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:17:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:17:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:17:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1a84030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d45180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d433b0>, '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 0x1d442b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d44740>, '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': '1f5564757af27664ca02d71f000001b0-1468376220.467006-964018221', '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 19:17:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 19:17:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:17:55 INFO - Using env: {'DISPLAY': ':0', 19:17:55 INFO - 'HOME': '/home/cltbld', 19:17:55 INFO - 'LANG': 'en_US.UTF-8', 19:17:55 INFO - 'LANGUAGE': 'en_US:en', 19:17:55 INFO - 'LOGNAME': 'cltbld', 19:17:55 INFO - 'MAIL': '/var/mail/cltbld', 19:17:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:17:55 INFO - 'MOZ_NO_REMOTE': '1', 19:17:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:17:55 INFO - 'NO_EM_RESTART': '1', 19:17:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:17:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:17:55 INFO - 'PWD': '/builds/slave/test', 19:17:55 INFO - 'SHELL': '/bin/bash', 19:17:55 INFO - 'SHLVL': '1', 19:17:55 INFO - 'TERM': 'linux', 19:17:55 INFO - 'TMOUT': '86400', 19:17:55 INFO - 'USER': 'cltbld', 19:17:55 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1468376220.467006-964018221', 19:17:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:17:55 INFO - '_': '/tools/buildbot/bin/python'} 19:17:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:17:55 INFO - Downloading/unpacking blobuploader==1.2.4 19:17:55 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 19:17:55 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 19:17:55 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 19:17:55 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 19:17:55 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 19:17:55 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 19:17:57 INFO - Downloading blobuploader-1.2.4.tar.gz 19:17:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:17:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:17:57 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 19:17:57 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 19:17:57 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 19:17:57 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 19:17:57 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 19:17:57 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 19:17:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:17:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:17:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:17:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:17:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:17:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:17:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:17:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:17:58 INFO - Downloading docopt-0.6.1.tar.gz 19:17:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:17:58 INFO - Installing collected packages: blobuploader, requests, docopt 19:17:58 INFO - Running setup.py install for blobuploader 19:17:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:17:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:17:58 INFO - Running setup.py install for requests 19:17:58 INFO - Running setup.py install for docopt 19:17:58 INFO - Successfully installed blobuploader requests docopt 19:17:58 INFO - Cleaning up... 19:17:58 INFO - Return code: 0 19:17:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:17:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:17:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:17:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:17:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:17:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:17:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:17:58 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 0x1a84030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d45180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d433b0>, '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 0x1d442b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d44740>, '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': '1f5564757af27664ca02d71f000001b0-1468376220.467006-964018221', '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 19:17:58 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 19:17:58 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 19:17:58 INFO - Using env: {'DISPLAY': ':0', 19:17:58 INFO - 'HOME': '/home/cltbld', 19:17:58 INFO - 'LANG': 'en_US.UTF-8', 19:17:58 INFO - 'LANGUAGE': 'en_US:en', 19:17:58 INFO - 'LOGNAME': 'cltbld', 19:17:58 INFO - 'MAIL': '/var/mail/cltbld', 19:17:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:17:58 INFO - 'MOZ_NO_REMOTE': '1', 19:17:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:17:58 INFO - 'NO_EM_RESTART': '1', 19:17:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:17:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:17:58 INFO - 'PWD': '/builds/slave/test', 19:17:58 INFO - 'SHELL': '/bin/bash', 19:17:58 INFO - 'SHLVL': '1', 19:17:58 INFO - 'TERM': 'linux', 19:17:58 INFO - 'TMOUT': '86400', 19:17:58 INFO - 'USER': 'cltbld', 19:17:58 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1468376220.467006-964018221', 19:17:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:17:58 INFO - '_': '/tools/buildbot/bin/python'} 19:17:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:17:59 INFO - Running setup.py (path:/tmp/pip-YzITDm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:17:59 INFO - Running setup.py (path:/tmp/pip-4sTyJd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:17:59 INFO - Running setup.py (path:/tmp/pip-IdAH0x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:17:59 INFO - Running setup.py (path:/tmp/pip-MWOWBF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:17:59 INFO - Running setup.py (path:/tmp/pip-oWbawf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:17:59 INFO - Running setup.py (path:/tmp/pip-WrjmsZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:17:59 INFO - Running setup.py (path:/tmp/pip-ANGSzC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:17:59 INFO - Running setup.py (path:/tmp/pip-VzjbBQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:17:59 INFO - Running setup.py (path:/tmp/pip-j4u8Pg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:17:59 INFO - Running setup.py (path:/tmp/pip-LXoIqm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:17:59 INFO - Running setup.py (path:/tmp/pip-0v0_uo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:17:59 INFO - Running setup.py (path:/tmp/pip-j905qP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:18:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:18:00 INFO - Running setup.py (path:/tmp/pip-8TQ0rf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:18:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:18:00 INFO - Running setup.py (path:/tmp/pip-PrQS3t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:18:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:18:00 INFO - Running setup.py (path:/tmp/pip-_eafTs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:18:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:18:00 INFO - Running setup.py (path:/tmp/pip-gjfXm7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:18:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:18:00 INFO - Running setup.py (path:/tmp/pip-FUqiXg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:18:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:18:00 INFO - Running setup.py install for manifestparser 19:18:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:18:00 INFO - Running setup.py install for mozcrash 19:18:00 INFO - Running setup.py install for mozdebug 19:18:00 INFO - Running setup.py install for mozdevice 19:18:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:18:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:18:00 INFO - Running setup.py install for mozfile 19:18:00 INFO - Running setup.py install for mozhttpd 19:18:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:18:01 INFO - Running setup.py install for mozinfo 19:18:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:18:01 INFO - Running setup.py install for mozInstall 19:18:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:18:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:18:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:18:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:18:01 INFO - Running setup.py install for mozleak 19:18:01 INFO - Running setup.py install for mozlog 19:18:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:18:01 INFO - Running setup.py install for moznetwork 19:18:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:18:01 INFO - Running setup.py install for mozprocess 19:18:01 INFO - Running setup.py install for mozprofile 19:18:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:18:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:18:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:18:01 INFO - Running setup.py install for mozrunner 19:18:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:18:01 INFO - Running setup.py install for mozscreenshot 19:18:01 INFO - Running setup.py install for moztest 19:18:02 INFO - Running setup.py install for mozversion 19:18:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:18:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:18:02 INFO - Cleaning up... 19:18:02 INFO - Return code: 0 19:18:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:18:02 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')]} 19:18:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:18:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18:02 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')]} 19:18:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:18:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18:02 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 0x1a84030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d45180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d433b0>, '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 0x1d442b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d44740>, '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': '1f5564757af27664ca02d71f000001b0-1468376220.467006-964018221', '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 19:18:02 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 19:18:02 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 19:18:02 INFO - Using env: {'DISPLAY': ':0', 19:18:02 INFO - 'HOME': '/home/cltbld', 19:18:02 INFO - 'LANG': 'en_US.UTF-8', 19:18:02 INFO - 'LANGUAGE': 'en_US:en', 19:18:02 INFO - 'LOGNAME': 'cltbld', 19:18:02 INFO - 'MAIL': '/var/mail/cltbld', 19:18:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:18:02 INFO - 'MOZ_NO_REMOTE': '1', 19:18:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:18:02 INFO - 'NO_EM_RESTART': '1', 19:18:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:18:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:18:02 INFO - 'PWD': '/builds/slave/test', 19:18:02 INFO - 'SHELL': '/bin/bash', 19:18:02 INFO - 'SHLVL': '1', 19:18:02 INFO - 'TERM': 'linux', 19:18:02 INFO - 'TMOUT': '86400', 19:18:02 INFO - 'USER': 'cltbld', 19:18:02 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1468376220.467006-964018221', 19:18:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:18:02 INFO - '_': '/tools/buildbot/bin/python'} 19:18:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:18:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:18:02 INFO - Running setup.py (path:/tmp/pip-8polcd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:18:02 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)) 19:18:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:18:02 INFO - Running setup.py (path:/tmp/pip-50JyAj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:18:02 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)) 19:18:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:18:02 INFO - Running setup.py (path:/tmp/pip-hTmbp4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:18:02 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)) 19:18:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:18:02 INFO - Running setup.py (path:/tmp/pip-JdYkb6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:18:02 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)) 19:18:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:18:02 INFO - Running setup.py (path:/tmp/pip-PtuGoJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:18:02 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)) 19:18:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:18:02 INFO - Running setup.py (path:/tmp/pip-z8Fejw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:18:02 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)) 19:18:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:18:02 INFO - Running setup.py (path:/tmp/pip-wPvnju-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:18:02 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)) 19:18:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:18:02 INFO - Running setup.py (path:/tmp/pip-PZfXr1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:18:03 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)) 19:18:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:18:03 INFO - Running setup.py (path:/tmp/pip-ghuEnM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:18:03 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)) 19:18:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:18:03 INFO - Running setup.py (path:/tmp/pip-5UitlK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:18:03 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)) 19:18:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:18:03 INFO - Running setup.py (path:/tmp/pip-6_lACZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:18:03 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)) 19:18:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:18:03 INFO - Running setup.py (path:/tmp/pip-_lCMY7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:18:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 19:18:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:18:03 INFO - Running setup.py (path:/tmp/pip-q3uCUT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:18:03 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)) 19:18:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:18:03 INFO - Running setup.py (path:/tmp/pip-Zb8nXB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:18:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 19:18:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:18:03 INFO - Running setup.py (path:/tmp/pip-WX2u3j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:18:03 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)) 19:18:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:18:03 INFO - Running setup.py (path:/tmp/pip-vTIIZe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:18:03 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)) 19:18:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:18:03 INFO - Running setup.py (path:/tmp/pip-sWUKWZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:18:03 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)) 19:18:03 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)) 19:18:03 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)) 19:18:03 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)) 19:18:03 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)) 19:18:03 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)) 19:18:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:18:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:18:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:18:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:18:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:18:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:18:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:18:05 INFO - Downloading blessings-1.6.tar.gz 19:18:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:18:05 INFO - Installing collected packages: blessings 19:18:05 INFO - Running setup.py install for blessings 19:18:05 INFO - Successfully installed blessings 19:18:05 INFO - Cleaning up... 19:18:05 INFO - Return code: 0 19:18:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:18:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:18:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:18:06 INFO - Reading from file tmpfile_stdout 19:18:06 INFO - Current package versions: 19:18:06 INFO - argparse == 1.2.1 19:18:06 INFO - blessings == 1.6 19:18:06 INFO - blobuploader == 1.2.4 19:18:06 INFO - docopt == 0.6.1 19:18:06 INFO - functools32 == 3.2.3-2 19:18:06 INFO - jsonschema == 2.5.1 19:18:06 INFO - manifestparser == 1.1 19:18:06 INFO - mozInstall == 1.12 19:18:06 INFO - mozcrash == 0.17 19:18:06 INFO - mozdebug == 0.1 19:18:06 INFO - mozdevice == 0.48 19:18:06 INFO - mozfile == 1.2 19:18:06 INFO - mozhttpd == 0.7 19:18:06 INFO - mozinfo == 0.9 19:18:06 INFO - mozleak == 0.1 19:18:06 INFO - mozlog == 3.2 19:18:06 INFO - moznetwork == 0.27 19:18:06 INFO - mozprocess == 0.23 19:18:06 INFO - mozprofile == 0.28 19:18:06 INFO - mozrunner == 6.12 19:18:06 INFO - mozscreenshot == 0.1 19:18:06 INFO - mozsystemmonitor == 0.3 19:18:06 INFO - moztest == 0.7 19:18:06 INFO - mozversion == 1.4 19:18:06 INFO - psutil == 3.1.1 19:18:06 INFO - requests == 1.2.3 19:18:06 INFO - wsgiref == 0.1.2 19:18:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:18:06 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')]} 19:18:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:18:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18:06 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')]} 19:18:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:18:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18:06 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 0x1a84030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d45180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d433b0>, '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 0x1d442b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d44740>, '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': '1f5564757af27664ca02d71f000001b0-1468376220.467006-964018221', '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 19:18:06 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 19:18:06 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 19:18:06 INFO - Using env: {'DISPLAY': ':0', 19:18:06 INFO - 'HOME': '/home/cltbld', 19:18:06 INFO - 'LANG': 'en_US.UTF-8', 19:18:06 INFO - 'LANGUAGE': 'en_US:en', 19:18:06 INFO - 'LOGNAME': 'cltbld', 19:18:06 INFO - 'MAIL': '/var/mail/cltbld', 19:18:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:18:06 INFO - 'MOZ_NO_REMOTE': '1', 19:18:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:18:06 INFO - 'NO_EM_RESTART': '1', 19:18:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:18:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:18:06 INFO - 'PWD': '/builds/slave/test', 19:18:06 INFO - 'SHELL': '/bin/bash', 19:18:06 INFO - 'SHLVL': '1', 19:18:06 INFO - 'TERM': 'linux', 19:18:06 INFO - 'TMOUT': '86400', 19:18:06 INFO - 'USER': 'cltbld', 19:18:06 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1468376220.467006-964018221', 19:18:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:18:06 INFO - '_': '/tools/buildbot/bin/python'} 19:18:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:18:06 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)) 19:18:06 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)) 19:18:06 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)) 19:18:06 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)) 19:18:06 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)) 19:18:06 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)) 19:18:06 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)) 19:18:06 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)) 19:18:06 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)) 19:18:06 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)) 19:18:06 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)) 19:18:06 INFO - Cleaning up... 19:18:06 INFO - Return code: 0 19:18:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:18:06 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')]} 19:18:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:18:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18:06 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')]} 19:18:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:18:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18:06 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 0x1a84030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d45180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d433b0>, '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 0x1d442b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d44740>, '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': '1f5564757af27664ca02d71f000001b0-1468376220.467006-964018221', '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 19:18:06 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 19:18:06 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 19:18:06 INFO - Using env: {'DISPLAY': ':0', 19:18:06 INFO - 'HOME': '/home/cltbld', 19:18:06 INFO - 'LANG': 'en_US.UTF-8', 19:18:06 INFO - 'LANGUAGE': 'en_US:en', 19:18:06 INFO - 'LOGNAME': 'cltbld', 19:18:06 INFO - 'MAIL': '/var/mail/cltbld', 19:18:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:18:06 INFO - 'MOZ_NO_REMOTE': '1', 19:18:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:18:06 INFO - 'NO_EM_RESTART': '1', 19:18:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:18:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:18:06 INFO - 'PWD': '/builds/slave/test', 19:18:06 INFO - 'SHELL': '/bin/bash', 19:18:06 INFO - 'SHLVL': '1', 19:18:06 INFO - 'TERM': 'linux', 19:18:06 INFO - 'TMOUT': '86400', 19:18:06 INFO - 'USER': 'cltbld', 19:18:06 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1468376220.467006-964018221', 19:18:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:18:06 INFO - '_': '/tools/buildbot/bin/python'} 19:18:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:18:06 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:18:06 INFO - Cleaning up... 19:18:06 INFO - Return code: 0 19:18:06 INFO - Running post-action listener: _resource_record_post_action 19:18:06 INFO - Running post-action listener: _start_resource_monitoring 19:18:06 INFO - Starting resource monitoring. 19:18:06 INFO - ##### 19:18:06 INFO - ##### Finished create-virtualenv step (success) 19:18:06 INFO - ##### 19:18:06 INFO - ##### 19:18:06 INFO - ##### Running install step. 19:18:06 INFO - ##### 19:18:06 INFO - Running pre-action listener: _resource_record_pre_action 19:18:06 INFO - Running main action method: install 19:18:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:18:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:18:06 INFO - Reading from file tmpfile_stdout 19:18:06 INFO - Detecting whether we're running mozinstall >=1.0... 19:18:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:18:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:18:06 INFO - Reading from file tmpfile_stdout 19:18:06 INFO - Output received: 19:18:06 INFO - Usage: mozinstall [options] installer 19:18:06 INFO - Options: 19:18:06 INFO - -h, --help show this help message and exit 19:18:06 INFO - -d DEST, --destination=DEST 19:18:06 INFO - Directory to install application into. [default: 19:18:06 INFO - "/builds/slave/test"] 19:18:06 INFO - --app=APP Application being installed. [default: firefox] 19:18:06 INFO - mkdir: /builds/slave/test/build/application 19:18:06 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'] 19:18:06 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 19:18:24 INFO - Reading from file tmpfile_stdout 19:18:24 INFO - Output received: 19:18:24 INFO - /builds/slave/test/build/application/firefox/firefox 19:18:24 INFO - Running post-action listener: _resource_record_post_action 19:18:24 INFO - ##### 19:18:24 INFO - ##### Finished install step (success) 19:18:24 INFO - ##### 19:18:24 INFO - ##### 19:18:24 INFO - ##### Running run-tests step. 19:18:24 INFO - ##### 19:18:24 INFO - Running pre-action listener: _resource_record_pre_action 19:18:24 INFO - Running main action method: run_tests 19:18:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:18:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:18:24 INFO - Python 2.7.3 19:18:24 INFO - Return code: 0 19:18:24 INFO - grabbing minidump binary from tooltool 19:18:24 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')]} 19:18:24 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 0x1d433b0>, '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 0x1d442b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d44740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:18:24 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 19:18:24 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 19:18:24 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 19:18:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:18:24 INFO - Return code: 0 19:18:24 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:18:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:18:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:18:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:18:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:18:24 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dVV6kjT8RjGFQjlhC-YxNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 19:18:24 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dVV6kjT8RjGFQjlhC-YxNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-027 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 19:18:24 INFO - Using env: {'DISPLAY': ':0', 19:18:24 INFO - 'HOME': '/home/cltbld', 19:18:24 INFO - 'LANG': 'en_US.UTF-8', 19:18:24 INFO - 'LANGUAGE': 'en_US:en', 19:18:24 INFO - 'LOGNAME': 'cltbld', 19:18:24 INFO - 'MAIL': '/var/mail/cltbld', 19:18:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:18:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:18:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:18:24 INFO - 'MOZ_NO_REMOTE': '1', 19:18:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:18:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:18:24 INFO - 'NO_EM_RESTART': '1', 19:18:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:18:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:18:24 INFO - 'PWD': '/builds/slave/test', 19:18:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:18:24 INFO - 'SHELL': '/bin/bash', 19:18:24 INFO - 'SHLVL': '1', 19:18:24 INFO - 'TERM': 'linux', 19:18:24 INFO - 'TMOUT': '86400', 19:18:24 INFO - 'USER': 'cltbld', 19:18:24 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1468376220.467006-964018221', 19:18:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:18:24 INFO - '_': '/tools/buildbot/bin/python'} 19:18:24 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dVV6kjT8RjGFQjlhC-YxNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 19:18:24 INFO - mozversion application_buildid: 20160712113033 19:18:24 INFO - mozversion application_changeset: 55922a4a546c9a6b5c6842aeb00b65c10b29bfc2 19:18:24 INFO - mozversion application_display_name: Nightly 19:18:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:18:24 INFO - mozversion application_name: Firefox 19:18:24 INFO - mozversion application_remotingname: firefox 19:18:24 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 19:18:24 INFO - mozversion application_vendor: Mozilla 19:18:24 INFO - mozversion application_version: 50.0a1 19:18:24 INFO - mozversion platform_buildid: 20160712113033 19:18:24 INFO - mozversion platform_changeset: 55922a4a546c9a6b5c6842aeb00b65c10b29bfc2 19:18:24 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 19:18:24 INFO - mozversion platform_version: 50.0a1 19:18:24 INFO - using testdate: 1468376304 19:18:24 INFO - actual date: 1468376304 19:18:24 INFO - starting webserver on 'localhost:38380' 19:18:24 INFO - SUITE-START | Running 2 tests 19:18:24 INFO - TEST-START | dromaeo_css 19:18:24 INFO - operating with platform_type : linux_ 19:18:24 INFO - Initialising browser for dromaeo_css test... 19:18:24 INFO - TEST-INFO | started process 13779 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKIGR6r/profile http://localhost:38380/getInfo.html) 19:18:28 INFO - PROCESS | 13779 | __metrics Screen width/height:1600/1200 19:18:28 INFO - PROCESS | 13779 | colorDepth:24 19:18:28 INFO - PROCESS | 13779 | Browser inner width/height: 1024/697 19:18:28 INFO - PROCESS | 13779 | __metrics 19:18:29 ERROR - PROCESS | 13779 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2964: TypeError: this.tabs is undefined 19:18:30 INFO - TEST-INFO | 13779: exit 0 19:18:30 INFO - Browser initialized. 19:18:30 INFO - Running cycle 1/1 for dromaeo_css test... 19:18:30 INFO - TEST-INFO | started process 13897 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKIGR6r/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:18:42 INFO - PROCESS | 13897 | RSS: Main: 168140800 19:18:42 INFO - PROCESS | 13897 | 19:19:31 INFO - PROCESS | 13897 | 1468376371770 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] 19:21:39 INFO - PROCESS | 13897 | Cycle 1(1): loaded http://localhost:38380/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38380/tests/dromaeo/cssquery-ext.html) 19:21:41 INFO - PROCESS | 13897 | RSS: Main: 170848256 19:21:41 INFO - PROCESS | 13897 | 19:24:43 INFO - PROCESS | 13897 | Cycle 1(1): loaded http://localhost:38380/tests/dromaeo/cssquery-ext.html (next: http://localhost:38380/tests/dromaeo/cssquery-jquery.html) 19:24:43 INFO - PROCESS | 13897 | RSS: Main: 168210432 19:24:43 INFO - PROCESS | 13897 | 19:27:45 INFO - PROCESS | 13897 | Cycle 1(1): loaded http://localhost:38380/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38380/tests/dromaeo/cssquery-mootools.html) 19:27:46 INFO - PROCESS | 13897 | RSS: Main: 171761664 19:27:46 INFO - PROCESS | 13897 | 19:30:48 INFO - PROCESS | 13897 | Cycle 1(1): loaded http://localhost:38380/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38380/tests/dromaeo/cssquery-prototype.html) 19:30:48 INFO - PROCESS | 13897 | RSS: Main: 166670336 19:30:48 INFO - PROCESS | 13897 | 19:33:51 INFO - PROCESS | 13897 | Cycle 1(1): loaded http://localhost:38380/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38380/tests/dromaeo/cssquery-yui.html) 19:33:51 INFO - PROCESS | 13897 | RSS: Main: 168898560 19:33:51 INFO - PROCESS | 13897 | 19:36:54 INFO - PROCESS | 13897 | Cycle 1(1): loaded http://localhost:38380/tests/dromaeo/cssquery-yui.html (next: http://localhost:38380/tests/dromaeo/cssquery-dojo.html) 19:36:54 INFO - PROCESS | 13897 | RSS: Main: 169803776 19:36:54 INFO - PROCESS | 13897 | 19:36:54 INFO - PROCESS | 13897 | __start_tp_report 19:36:54 INFO - PROCESS | 13897 | _x_x_mozilla_page_load 19:36:54 INFO - PROCESS | 13897 | _x_x_mozilla_page_load_details 19:36:54 INFO - PROCESS | 13897 | |i|pagename|runs| 19:36:54 INFO - PROCESS | 13897 | |0;dojo.html;3109.098361475172;3121.391328690906;3140.262038420969;3150.6061742282213;3157.6052993375843;5614.522765564927;5641.717914104299;5662.971685141579;5666.093425051992;5679;5491.917621235684;5592.5805564582715;5612.186232996213;5663.490285874271;5665.12190610456;5018.749062546867;5098;5117.565006974393;5132.563732082759;5244.108501554726;5080.110980578384;5172.40517340505;5217.37391513019;5219.973900130513;5231.424543300234;347.0993838985932;5110.923336149961;5198.220266959967;5208.374995000624;5237.580993520509;5083.212102124176;5087.771050302746;5098.898022039539;5111.514406131449;5113.2330150477355;5066.265391518246;5068.619853511002;5078.64449488536;5095.643304968654;5122.76947537358;5460.645058071253;5549.250851135126;5596.048671725816;5620.775168993277;5622.409646987089;5969.731362088716;5983.252093488314;5994.520438364921;5995.700214989233;5998.220231369937;6137.6624285664275;6147.661878596676;6150.384961503859;6152.938470615281;6156.599821011665;5568.136938774496;5605.775768969277;5606.187102870102;5648.096304591246;5703.486686198262;6077.574569780073;6094.695265236809;6101.420365065312;6109.11417844419;6111.297200821873;5697.4302569742695;5875.206847075676;5903.173555702205;5924.318703349084;5941.732622031933;5848;5880.235569375954;5894;5921.911171332434;5948.702564871739;5905.940940590625;5917.733701983421;5949.524038076944;5959.374265702126;5971.402859713994;5869.4717475427415;5922.437368449991;5956.374580668968;5981.461668449861;5997.190379298739;4467;4506.459224893034;4535.773211339486;4582.633389328846;4624.491305956342;4032.6169013944213;4058.350663893763;4072.205919845661;4083.1221287422754;4099.159672267178;5597.916031259534;5700.515456186187;5784.421557844182;5785.363610002896;5787.536997040227;6066.545009124334;6096.587161059637;6098.674287528808;6110.796104529107;6119.969400152971;5688.11834165705;5734.971325143348;5765.135229715576;5766;5786.913196302059;5059.2916991621205;5112.769925353368;5166.070107380708;5174.508421699932;5178.275041494194;6277.1525844011385;6292.433680968735;6296.905546416808;6298.811035668938;6315.084312774622;6061.636301821904;6071.51427885768;6082.574219804571;6086.239220097488;6100.664463454553;5977.163197152489;6122.39815511198;6205.03821907605;6211.192544969125;6278.058291256166;5915.319738230159;5922.1412895130825;5925.911111333419;5928.34788173292;5959.791407300723;5978.372270911492;6017.849553761191;6024.0662697282;6028.547858910687;6030.396960303934;5642.633228840113;5800.912986305125;5833.329167145663;5857.26784151981;5873.4126587340925;5801.709914504342;5853.619514731528;5857.209276747584;5860.94139058621;5881.029630110984;5665.546756259571;5818.476337129509;5818.912716309174;5854.063349864001;5858.150568167677;5705.572082093942;5747.683877386617;5785.537157027512;5812.3025236971835;5815.4184581543195;5721.313442386941;5732.484076432974;5749.425057494217;5764.279465066867;5776.104703770922 19:36:54 INFO - PROCESS | 13897 | |1;ext.html;543.6626043254141;587.8442212813604;600.0489224579042;612.4243211381302;622.1259130921057;38869.80565097174;44329.7783511082;44404.999999999956;44575.77712111439;44724.329135062915;44532.77733611336;45147.54852451474;45391.54608453914;45446.318305225446;45584;8824.779380515474;8921.77695557613;8983.595738191798;8986.415882967618;8999.730008099768;8870.73387798367;8918.375713700043;8970.59632316544;8984.865227021568;8986.820263594724;8928.732138035837;8938.374313798036;8954.776130596721;8992.775180620503;9006.819863602725;8920.152585504367;8950;8959.641614335418;9000.819983600357;9007.909920900773;8839.513826739527;8914.643414263423;8920.241779448756;8926.86609700855;8934.151255630704;34039.659603403896;42175.57824421778;42463.57536424658;42621;42823.35764963528;3247.480403135487;3431.9313613727836;3469.254110366258;3515.472679098156;3608.657177568127;31626.367472650418;31886;32010.679893201002;32219.838900805345;33083.50374744381;4349.217140914634;4365.454318210223;4375.803088861009;4377.6935614507;4438.600525952647;319853;322614;323048;324335;325016;33781.49327760086;33887.83056084704;33927.32145357128;34013.489797653056;35438;35750.28499429997;37559.248815023544;37925.62074379276;37964.05089872775;38014.42978355327;15502.612434689223;15643.217839108;15670.608234793994;15675.137867417401;15707;13041.152325098838;13052.54316098932;13129.277889715966;13162.60512184636;13168.275744834125;8548.786280343042;8601.13988601135;8609.956950215334;8614.224719775126;8670.13298670128;3221.8711251550144;3259.1037464697397;3288.621808492006;3298.307355455381;3305.5702758641223;1095.2169199022737;1128.7358158861962;1163.9825402618967;1198.3768440410938;1227.7053507158219;33602.66397335995;34210.14474638154;34345.82827085898;34414.82792586021;34457.31085378279;1122.057471723756;1140.2417392434104;1147.4262868565718;1151.717829131868;1201.7836789377996;17906.55233619144;18108.547286317946;18119.63760724778;18128.637427251644;18296.45110646656;155610;155894;156756;591889;603372;61755;62401.37598624046;62433.375666243664;62540;62578.37421625816;1295.792673172288;1358.280111540885;1369.8630136986221;1379.7309524642599;1388.8333399992066;33048.33903321872;33117.051907542496;33237;33439.996800096036;33826.661733383335;54692;54810.355689329386;54864.45135548753;55084;55276;365109;367870.8032299214;368074;368753;498571;28412.57381139243;28927.56608650914;29402.264943376587;29471.410571788874;29531.704682952895;51042.744786275834;51369.743151284005;52046.73976630244;52170.739146304026;52792.20811687751;44060.779696101315;44482.777586111864;45123.323150152115;45453;45660.77169614131;43540.78229608832;43929.56070439383;44071;44852;45592.316115257636;43384.783076084415;44381;44462.333065003404;44587;46729.53270467252;38670.41994370143;38988.2202355957;39942.600573993885;40063.599364007154;40206.396904045876;30074.699253008064;30317.242068948453;30341.848290758404;30461.390772184874;30909.381812364078 19:36:54 INFO - PROCESS | 13897 | |2;jquery.html;396.1482811954298;397.3225650266296;400.61340806122087;402.1153462382758;419.8383622305411;14340.856591434083;18789.71815422768;18906.62186756264;20285.188592456303;20310.390688279356;19545.902270488663;19597;19911.502212444695;20230.696539551882;20363.490912727153;5682.346530149044;5782.884342313172;5835.737391817378;5863.706814659271;5879.088741245114;5692.203091567184;5751.712414379285;5842.649441033552;5844.941550584483;5847.122931560279;5704.942950570483;5714.799982000631;5725.513331366818;5779.9422005779825;5843.912341314884;5756.827295181151;5785.971070144665;5789.478946894778;5792.826215213529;5793.957087724208;5131.846044618667;5212.713300768456;5218.217267409919;5237.633365664405;5248.134057880445;23893.7610623895;24144.517109657885;24213;24296.39259018521;24488.265352039467;2364.6807680963193;2404.026369320428;2532.3036165054573;2556.9744302556924;2570.139003433852;14927.925360373129;15159.621009474851;15295.541133766004;15529.36941621136;15762.290696918666;1897.4307707687776;1934.6807776716826;1937.9496851580266;1959.5982823521144;2063.772984971652;79391;82985.17014829894;83240.75138872983;83963.7405438919;84943.57528212319;9170.86243706345;9538.761530961781;10917.672469825919;10973.231873768918;11069.5572177112;15042.172680502677;15086.924565377103;15148.863835212404;15166.24168791578;15171.24143792806;8232.464889782144;8449.493030418194;8581.485110893367;8604.48373097616;8651.091635378321;8284.337253019865;8299.211574900375;8352.498850069016;8463.195996380335;8551.315894728406;6598.37315455031;6699.899501507482;6700.525884305445;6797.5581587196675;6868.862622747617;1951.443838506019;1961.146901098027;1962.7154062660834;1985.334912804198;2025.1798021801194;992.3797626483448;1034.9896501035043;1097.1880808201872;1135.7785231879704;1170.4030944218339;18054.90972545155;20402.38792836217;20770;21036;21116.260930867345;1034.9327293725885;1035.8756949166147;1054.681647940075;1063.5214153630898;1115.9163062770324;11680.131179011318;11688.298702077902;11788.29270243771;11909;12035.217710848767;493051;506541;516708;520168;526781;85563;88327;90490.54754726184;94921;95823;1003.0972125087479;1028.228828378716;1045.3153184664056;1059.0521483272428;1069.1393428290146;17752.733708994117;18148;18279.451616451526;18617.06914654289;18647.160877760805;31140.53289200709;36977.44533832048;42599.7870010648;44661.55338446574;44705.55294447014;60032.699836500535;66354;68478.65760671165;68532.657336713;68734.3126568748;7540.396768258636;7885.172056934169;8037.196280371916;8872.822543549222;9148.588313525774;10323.896761032594;14502.709945801236;14640.633984150481;14775.704485910006;15016.849831501546;11904.642860714192;12046.638600841989;12191;12282.447289871798;12690;12560.37198140071;12636.684082898;12683.42924568415;12711.36443177819;12765.297908615115;12470.127091103535;12605.684857878627;12767.680807979876;12824.29466379358;12878.935605321913;8175.632096555551;8193.221643943816;8246.917530824616;8289.751307460545;8375.748727538183;9298.256139508958;11773.76452470963;12151;13057.673558161123;13115.475380984653 19:36:54 INFO - PROCESS | 13897 | |3;mootools.html;1524.5350168198702;1539.8537138971797;1689.4509284482547;1794.8653850961182;1808.61114860305;7970.72102476412;8501.617427215775;8872.512011839346;9007.234385077269;9026.187643112118;8844.513551754651;9141.45151290923;9175.449473031622;9198.172164505193;9250.167484926355;2307.1924826310783;2348.9060437582475;2351.412146963259;2360.079568968104;2366.3137690069943;2341.438054866837;2348.635961425982;2411.5538625354366;2421.5520128776143;2422.648715936188;2343.1137933963155;2347.1550241912896;2359.6696462495265;2424.793892519138;2425.223928342931;2312.9884350578222;2318.907243710258;2322.5006623576014;2329.04509151248;2376.085207195225;2274.7725227477285;2301.2290882554366;2308.988455057731;2312.7224733032144;2313.201945328859;9342.299327550461;9363.4381937084;9414.482203478807;9419.670311539063;9422.34043616947;5272.789088436458;5276.287701160332;5385.8114965976;5391.946080539223;5394.406615272317;3426.9657303427143;3453.9827300863585;3466.2201004773974;3500.6149323574386;3663;1210.4976434779555;1216.3614102596118;1220.2495465288873;1254.40415802494;1256.2462522486526;12833.486660533568;12886.226826390353;12914.741705165845;12916.354182290848;12932.094753367268;4477.485089214782;4620.653450991122;4701.717896926195;4759.357486739246;4766.213574760195;10801.459927003618;10900.454977251105;10952.945235273774;10958.178136639784;10986.615468458725;5263.4473380295285;5301.966116607225;5310.601704872072;5311;5325.094733895247;4391.560843915647;4847.80608775652;4864.391951006124;5007.148784706608;5007.924881126786;4090.426189005559;4097.385392191195;4157.251694694924;4160.313548264563;4176;1303.9413226404833;1308.6335825968745;1312.8293321868096;1321.4714114354335;1337.251139361941;872.4590753732599;940.8203240933038;941.0213378086713;1031.257494603884;1053.9262251642313;6047.78832740852;6220.565442521296;6251.562390632703;6258.3428739982555;6273.560850740496;994.22450488619;1004.9748756281006;1013.0426746724274;1021.8569400283966;1032.7727899862018;4047;4099.446574712376;4104.507459104927;4134.37984302357;4277.230098582285;11411.657650270505;11742.060635149168;11746.353950532803;11778.823317650242;11832.408379580986;11544.59593914209;11613.535458581562;11641.76716465666;11685.298882067103;11701.590444334408;8073.354131669453;8387.035490918623;8606.913930860612;8783.34124940632;8836.955815220883;6136.2636483622255;6232.8130156095385;6233.470155036873;6256.812295631138;6336.9049464259;10590.682279531626;10731.89268107309;10847.24069315172;10858.945705271422;10930.672079837617;10795;10929.83605245906;10976.506057227603;11039.116870650168;11095.389753563632;7247.8550428990075;7919.247671471201;7964.123946365779;8068.636911338886;8228.588570571328;8976.820463590822;9021.909780902108;9035;9068.455892646462;9144.63421463134;7528.28481294298;7763.262490063435;8203.507789532647;8241.917580824114;8292.04641466239;7887.369010479033;7966.522008679498;7978.92021079805;8051.51690898548;8051.637676304464;7155.463340249398;7366.447516436181;7414.332710056121;7453.105627324539;7454.813629659302;4780.163471392423;4781.6891902026255;4787.497312782108;4793.328933949319;4815.759212039454;5303.946960530346;5451.64564303319;5474.781008759605;5478.561715062865;5481.5066644000635 19:36:54 INFO - PROCESS | 13897 | |4;prototype.html;332.40001796756854;334.25127713920824;335.2574048482611;340.6014962493882;341.1097036734125;5518.69647169406;5572.832815015551;5577.9163312550245;5578.298618921227;5591.8602034949145;5496.6258435391155;5529.30883639545;5534.695591742453;5536.280283563131;5545.502714267155;4098.405731168986;4221.387898754679;4314.245007123756;4339.19724850902;4349.13017396522;4317.244482215616;4322.610965013148;4327.783610819462;4343.348497725335;4368.49762277339;4340.632700699285;4347.804348804311;4350.390945267665;4360.6075453209205;4372.650187984954;4252.170826688797;4275.9786201068955;4313.913721725579;4315.036658320457;4319.503257125408;3800.1069748609057;3804.353259945788;3812.8370846891685;3820.9557886530574;3823;5419.214213938996;5427.62006659534;5440.755166017539;5440.83677489672;5450.781968721247;4876.707397556158;4966.652334336598;4975.601951843843;4994.650374473788;5015.924761128586;5797.246357973479;5808.59339846211;5819.825405237807;5837.3287071986415;5847.26909136358;4212.978935105336;4230.2174097792;4239.788010599457;4241.1093670329265;4250.171216612762;5743.282089738783;6010.609310394854;6051.606645568024;6052.606580572248;6070.726817293233;4166.8333266669;4169.56219596944;4179.1014931789205;4182.351735481006;4190.784672444956;4166.937495937564;4188.28799104153;4200.474940632421;4220.430241917302;4237.194932962727;4781.713097214179;4884.340614017134;4930.531599498042;4935;4940.580050695659;5870.148828419855;5873.706314684248;5885.764569417175;5888.941110588839;5904.645721256738;1477.6527516033723;1494.499342720201;1499.8151460346423;1501.144347721788;1504.9172295523633;919.172744529915;939.4645052320112;950.9857352139724;951.1867353412871;953.3707752883064;5024.824131155392;5042.697438153723;5060.418051924003;5065.594752419797;5109.6021145938275;5285.339332583427;5292.841214763564;5321.600879934021;5347.331583552056;5368.91946620801;5069.645124841226;5099.490050994871;5335.3864305604575;5739.540836733051;5807.82576522705;3173.508106243536;3195.344954284366;3218.1471909943884;3219;3226.628937672198;6081.483073938764;6169.704362083923;6220.937790622126;6233.2208473940755;6239;6128.356522565066;6128.908066379008;6161.322254551996;6163.691815409212;6170.5372097092895;6196.47329976948;6198.81403557894;6212.006079027425;6212.1303017577575;6218.409251121137;5826.70866456684;6009.248843894513;6026.969865150646;6042.456178943916;6051.425114614105;5902.61632993854;5963.92649323126;5984.414130255399;5989.580729348903;6013.819585412444;5967.46292833647;6233.438990490878;6238.6880655966115;6241.96879015602;6248.4376406123665;4226.2392769300595;4226.408302837666;4249.936250956176;4251.192273468031;4254.702170848011;5833.445822646841;5986.850328741816;6012.835379263374;6040;6052.757889684363;5857.58996870215;5894.469497745224;5896.761680047238;5904.911426328695;5906.468417842415;5691.886162276648;5870.180244124335;5895.351511333835;5909.734061967308;5941.1385349123275;5852.268466441695;5887.617304875341;5894.263217097863;5894.2926848778425;5895.823125306248;5905.940940590539;5939.554533409925;5941.792037278675;5945.762169513171;5946.672932988554;5688.345840228427;5804.709764511673;5816.302043754777;5834.591578589458;5845.3277873045145 19:36:54 INFO - PROCESS | 13897 | |5;yui.html;709.8615769924867;722.3426681719636;753.7248904149986;767.7044337929897;783.4398405140323;14815.925920370397;15819.446319378823;15842.68314633708;15849.92075039626;15856.52430427086;14955.775663365059;15088.547343579683;15225.39098436064;15280.69438611227;15290.46483373082;661.2296674374348;780.0756104016758;793.4763056382789;810.8337790752881;816.4733746733353;813.5728742410223;819.9262066414021;820.0528389709895;827.1025936858516;827.2761333832897;858.1547176031604;859.5014891362995;865.2040123086775;867.7787164273102;868.4615538366222;862.344618090256;863.0937515608585;863.48622569571;865.5455885660048;865.7575878753928;635.9904601430982;638.6551262318343;638.8275165705234;640.7757284950277;641.0608458608161;14375.78436323456;14396.424143034266;14418.279086045655;14451.855481445156;14546.34541445627;14371.425142994267;14666.413343466249;14732.779008314883;14812.851871481254;14872.330745116496;11898.46456909441;12018.286100872085;12108.757824843453;12296.139270251086;12315.815262771066;3882.6893848492055;3960.4059391091278;3964.5044369453817;3981.422693709425;4087.407325937752;81447.59276203581;83924;83950;83982.58008709918;84194;11073.5570577176;11150.276815230825;11286.095789552466;11305.152113591514;11435;21988.120475180815;22245.11019559232;22576.84277822714;22731.318060458212;22834.086636534354;9037.186653201243;9039.367244292967;9142.131497507726;9180.6786762463;9352.438853668802;4807.831725889577;4919.852404427873;4943.28322393251;4968.701877887338;5066.898662026812;3519.7536172468194;3637.1089083174793;3638.3632864248652;3638.581563120222;3640.9453858192146;668.1547841979899;701.0885848397063;706.2654838967417;713.290276175209;714.6855383631186;606.4693393280879;682.2631557917438;750.9774706758806;761.8133557278502;776.3386353204147;9694.418334899929;9950.601975921027;9951.15415189717;9976.501174941224;10810.189235807346;586.7828903305718;722.6278466589711;744;750;755.5164694595463;4370.54109318517;4595.6783025187915;4621.112354321552;4708.270218116198;4741.596964258008;129512;131571;131844.3407782955;134153;135453;112327.43836280766;112644.86196242378;114527.42736286265;114749.4262528682;116123;83267.58366208251;95297;99749;100022;102710;9920.156786672926;10022;10024.348417352849;10096.293259471766;10407.84388234162;37872.81063594665;44698.776506118564;51429.48570514247;52147;53466;79620.60189699015;81461;83061;83140;84703;13397.531086412318;13473.393697283449;13658.521951731642;13775.862241377457;13816.585502434944;15298;15452.922735386252;15500.5349839505;15745.13401762914;16275.674486510441;12055.21641093326;14272.143671379336;14902;14979.700405992036;15082.622934426727;12748.936255318664;12822.807657885325;13018.869811301765;13463.730725385241;14180.858191417954;14088.647783805487;14503.709925801213;14894.79540362938;15199.696006080037;15388.38446462129;10890.466976521564;11379.146564007568;11878.881211187778;11917.880821191677;12328.137030408145;12202.511899523919;12373.75252494927;12640.241585504898;12730.936345318585;12908.483660653845 19:36:54 INFO - PROCESS | 13897 | __end_tp_report 19:36:54 INFO - PROCESS | 13897 | __start_cc_report 19:36:54 INFO - PROCESS | 13897 | _x_x_mozilla_cycle_collect,354 19:36:54 INFO - PROCESS | 13897 | __end_cc_report 19:36:54 INFO - PROCESS | 13897 | __startTimestamp1468377414451__endTimestamp 19:36:54 INFO - PROCESS | 13897 | 19:36:54 INFO - PROCESS | 13897 | ------- Summary: start ------- 19:36:54 INFO - PROCESS | 13897 | Number of tests: 6 19:36:54 INFO - PROCESS | 13897 | 19:36:54 INFO - PROCESS | 13897 | [#0] dojo.html Cycles:165 Average:5544.81 Median:5785.36 stddev:764.78 (13.2%) stddev-sans-first:742.87 19:36:54 INFO - PROCESS | 13897 | Values: 3109.1 3121.4 3140.3 3150.6 3157.6 5614.5 5641.7 5663.0 5666.1 5679.0 5491.9 5592.6 5612.2 5663.5 5665.1 5018.7 5098.0 5117.6 5132.6 5244.1 5080.1 5172.4 5217.4 5220.0 5231.4 347.1 5110.9 5198.2 5208.4 5237.6 5083.2 5087.8 5098.9 5111.5 5113.2 5066.3 5068.6 5078.6 5095.6 5122.8 5460.6 5549.3 5596.0 5620.8 5622.4 5969.7 5983.3 5994.5 5995.7 5998.2 6137.7 6147.7 6150.4 6152.9 6156.6 5568.1 5605.8 5606.2 5648.1 5703.5 6077.6 6094.7 6101.4 6109.1 6111.3 5697.4 5875.2 5903.2 5924.3 5941.7 5848.0 5880.2 5894.0 5921.9 5948.7 5905.9 5917.7 5949.5 5959.4 5971.4 5869.5 5922.4 5956.4 5981.5 5997.2 4467.0 4506.5 4535.8 4582.6 4624.5 4032.6 4058.4 4072.2 4083.1 4099.2 5597.9 5700.5 5784.4 5785.4 5787.5 6066.5 6096.6 6098.7 6110.8 6120.0 5688.1 5735.0 5765.1 5766.0 5786.9 5059.3 5112.8 5166.1 5174.5 5178.3 6277.2 6292.4 6296.9 6298.8 6315.1 6061.6 6071.5 6082.6 6086.2 6100.7 5977.2 6122.4 6205.0 6211.2 6278.1 5915.3 5922.1 5925.9 5928.3 5959.8 5978.4 6017.8 6024.1 6028.5 6030.4 5642.6 5800.9 5833.3 5857.3 5873.4 5801.7 5853.6 5857.2 5860.9 5881.0 5665.5 5818.5 5818.9 5854.1 5858.2 5705.6 5747.7 5785.5 5812.3 5815.4 5721.3 5732.5 5749.4 5764.3 5776.1 19:36:54 INFO - PROCESS | 13897 | 19:36:54 INFO - PROCESS | 13897 | [#1] ext.html Cycles:180 Average:51891.45 Median:39465.41 stddev:99482.47 (252.1%) stddev-sans-first:99686.84 19:36:54 INFO - PROCESS | 13897 | Values: 543.7 587.8 600.0 612.4 622.1 38869.8 44329.8 44405.0 44575.8 44724.3 44532.8 45147.5 45391.5 45446.3 45584.0 8824.8 8921.8 8983.6 8986.4 8999.7 8870.7 8918.4 8970.6 8984.9 8986.8 8928.7 8938.4 8954.8 8992.8 9006.8 8920.2 8950.0 8959.6 9000.8 9007.9 8839.5 8914.6 8920.2 8926.9 8934.2 34039.7 42175.6 42463.6 42621.0 42823.4 3247.5 3431.9 3469.3 3515.5 3608.7 31626.4 31886.0 32010.7 32219.8 33083.5 4349.2 4365.5 4375.8 4377.7 4438.6 319853.0 322614.0 323048.0 324335.0 325016.0 33781.5 33887.8 33927.3 34013.5 35438.0 35750.3 37559.2 37925.6 37964.1 38014.4 15502.6 15643.2 15670.6 15675.1 15707.0 13041.2 13052.5 13129.3 13162.6 13168.3 8548.8 8601.1 8610.0 8614.2 8670.1 3221.9 3259.1 3288.6 3298.3 3305.6 1095.2 1128.7 1164.0 1198.4 1227.7 33602.7 34210.1 34345.8 34414.8 34457.3 1122.1 1140.2 1147.4 1151.7 1201.8 17906.6 18108.5 18119.6 18128.6 18296.5 155610.0 155894.0 156756.0 591889.0 603372.0 61755.0 62401.4 62433.4 62540.0 62578.4 1295.8 1358.3 1369.9 1379.7 1388.8 33048.3 33117.1 33237.0 33440.0 33826.7 54692.0 54810.4 54864.5 55084.0 55276.0 365109.0 367870.8 368074.0 368753.0 498571.0 28412.6 28927.6 29402.3 29471.4 29531.7 51042.7 51369.7 52046.7 52170.7 52792.2 44060.8 44482.8 45123.3 45453.0 45660.8 43540.8 43929.6 44071.0 44852.0 45592.3 43384.8 44381.0 44462.3 44587.0 46729.5 38670.4 38988.2 39942.6 40063.6 40206.4 30074.7 30317.2 30341.8 30461.4 30909.4 19:36:54 INFO - PROCESS | 13897 | 19:36:54 INFO - PROCESS | 13897 | [#2] jquery.html Cycles:180 Average:30242.86 Median:24254.70 stddev:84456.03 (348.2%) stddev-sans-first:84663.21 19:36:54 INFO - PROCESS | 13897 | Values: 396.1 397.3 400.6 402.1 419.8 14340.9 18789.7 18906.6 20285.2 20310.4 19545.9 19597.0 19911.5 20230.7 20363.5 5682.3 5782.9 5835.7 5863.7 5879.1 5692.2 5751.7 5842.6 5844.9 5847.1 5704.9 5714.8 5725.5 5779.9 5843.9 5756.8 5786.0 5789.5 5792.8 5794.0 5131.8 5212.7 5218.2 5237.6 5248.1 23893.8 24144.5 24213.0 24296.4 24488.3 2364.7 2404.0 2532.3 2557.0 2570.1 14927.9 15159.6 15295.5 15529.4 15762.3 1897.4 1934.7 1937.9 1959.6 2063.8 79391.0 82985.2 83240.8 83963.7 84943.6 9170.9 9538.8 10917.7 10973.2 11069.6 15042.2 15086.9 15148.9 15166.2 15171.2 8232.5 8449.5 8581.5 8604.5 8651.1 8284.3 8299.2 8352.5 8463.2 8551.3 6598.4 6699.9 6700.5 6797.6 6868.9 1951.4 1961.1 1962.7 1985.3 2025.2 992.4 1035.0 1097.2 1135.8 1170.4 18054.9 20402.4 20770.0 21036.0 21116.3 1034.9 1035.9 1054.7 1063.5 1115.9 11680.1 11688.3 11788.3 11909.0 12035.2 493051.0 506541.0 516708.0 520168.0 526781.0 85563.0 88327.0 90490.5 94921.0 95823.0 1003.1 1028.2 1045.3 1059.1 1069.1 17752.7 18148.0 18279.5 18617.1 18647.2 31140.5 36977.4 42599.8 44661.6 44705.6 60032.7 66354.0 68478.7 68532.7 68734.3 7540.4 7885.2 8037.2 8872.8 9148.6 10323.9 14502.7 14640.6 14775.7 15016.8 11904.6 12046.6 12191.0 12282.4 12690.0 12560.4 12636.7 12683.4 12711.4 12765.3 12470.1 12605.7 12767.7 12824.3 12878.9 8175.6 8193.2 8246.9 8289.8 8375.7 9298.3 11773.8 12151.0 13057.7 13115.5 19:36:54 INFO - PROCESS | 13897 | 19:36:54 INFO - PROCESS | 13897 | [#3] mootools.html Cycles:180 Average:6041.02 Median:4334.40 stddev:3510.66 (81.0%) stddev-sans-first:3504.10 19:36:54 INFO - PROCESS | 13897 | Values: 1524.5 1539.9 1689.5 1794.9 1808.6 7970.7 8501.6 8872.5 9007.2 9026.2 8844.5 9141.5 9175.4 9198.2 9250.2 2307.2 2348.9 2351.4 2360.1 2366.3 2341.4 2348.6 2411.6 2421.6 2422.6 2343.1 2347.2 2359.7 2424.8 2425.2 2313.0 2318.9 2322.5 2329.0 2376.1 2274.8 2301.2 2309.0 2312.7 2313.2 9342.3 9363.4 9414.5 9419.7 9422.3 5272.8 5276.3 5385.8 5391.9 5394.4 3427.0 3454.0 3466.2 3500.6 3663.0 1210.5 1216.4 1220.2 1254.4 1256.2 12833.5 12886.2 12914.7 12916.4 12932.1 4477.5 4620.7 4701.7 4759.4 4766.2 10801.5 10900.5 10952.9 10958.2 10986.6 5263.4 5302.0 5310.6 5311.0 5325.1 4391.6 4847.8 4864.4 5007.1 5007.9 4090.4 4097.4 4157.3 4160.3 4176.0 1303.9 1308.6 1312.8 1321.5 1337.3 872.5 940.8 941.0 1031.3 1053.9 6047.8 6220.6 6251.6 6258.3 6273.6 994.2 1005.0 1013.0 1021.9 1032.8 4047.0 4099.4 4104.5 4134.4 4277.2 11411.7 11742.1 11746.4 11778.8 11832.4 11544.6 11613.5 11641.8 11685.3 11701.6 8073.4 8387.0 8606.9 8783.3 8837.0 6136.3 6232.8 6233.5 6256.8 6336.9 10590.7 10731.9 10847.2 10858.9 10930.7 10795.0 10929.8 10976.5 11039.1 11095.4 7247.9 7919.2 7964.1 8068.6 8228.6 8976.8 9021.9 9035.0 9068.5 9144.6 7528.3 7763.3 8203.5 8241.9 8292.0 7887.4 7966.5 7978.9 8051.5 8051.6 7155.5 7366.4 7414.3 7453.1 7454.8 4780.2 4781.7 4787.5 4793.3 4815.8 5303.9 5451.6 5474.8 5478.6 5481.5 19:36:54 INFO - PROCESS | 13897 | 19:36:54 INFO - PROCESS | 13897 | [#4] prototype.html Cycles:180 Average:4884.25 Median:5532.00 stddev:1447.58 (26.2%) stddev-sans-first:1410.74 19:36:54 INFO - PROCESS | 13897 | Values: 332.4 334.3 335.3 340.6 341.1 5518.7 5572.8 5577.9 5578.3 5591.9 5496.6 5529.3 5534.7 5536.3 5545.5 4098.4 4221.4 4314.2 4339.2 4349.1 4317.2 4322.6 4327.8 4343.3 4368.5 4340.6 4347.8 4350.4 4360.6 4372.7 4252.2 4276.0 4313.9 4315.0 4319.5 3800.1 3804.4 3812.8 3821.0 3823.0 5419.2 5427.6 5440.8 5440.8 5450.8 4876.7 4966.7 4975.6 4994.7 5015.9 5797.2 5808.6 5819.8 5837.3 5847.3 4213.0 4230.2 4239.8 4241.1 4250.2 5743.3 6010.6 6051.6 6052.6 6070.7 4166.8 4169.6 4179.1 4182.4 4190.8 4166.9 4188.3 4200.5 4220.4 4237.2 4781.7 4884.3 4930.5 4935.0 4940.6 5870.1 5873.7 5885.8 5888.9 5904.6 1477.7 1494.5 1499.8 1501.1 1504.9 919.2 939.5 951.0 951.2 953.4 5024.8 5042.7 5060.4 5065.6 5109.6 5285.3 5292.8 5321.6 5347.3 5368.9 5069.6 5099.5 5335.4 5739.5 5807.8 3173.5 3195.3 3218.1 3219.0 3226.6 6081.5 6169.7 6220.9 6233.2 6239.0 6128.4 6128.9 6161.3 6163.7 6170.5 6196.5 6198.8 6212.0 6212.1 6218.4 5826.7 6009.2 6027.0 6042.5 6051.4 5902.6 5963.9 5984.4 5989.6 6013.8 5967.5 6233.4 6238.7 6242.0 6248.4 4226.2 4226.4 4249.9 4251.2 4254.7 5833.4 5986.9 6012.8 6040.0 6052.8 5857.6 5894.5 5896.8 5904.9 5906.5 5691.9 5870.2 5895.4 5909.7 5941.1 5852.3 5887.6 5894.3 5894.3 5895.8 5905.9 5939.6 5941.8 5945.8 5946.7 5688.3 5804.7 5816.3 5834.6 5845.3 19:36:54 INFO - PROCESS | 13897 | 19:36:54 INFO - PROCESS | 13897 | [#5] yui.html Cycles:180 Average:22542.84 Median:3639.76 stddev:33863.81 (930.4%) stddev-sans-first:33919.12 19:36:54 INFO - PROCESS | 13897 | Values: 709.9 722.3 753.7 767.7 783.4 14815.9 15819.4 15842.7 15849.9 15856.5 14955.8 15088.5 15225.4 15280.7 15290.5 661.2 780.1 793.5 810.8 816.5 813.6 819.9 820.1 827.1 827.3 858.2 859.5 865.2 867.8 868.5 862.3 863.1 863.5 865.5 865.8 636.0 638.7 638.8 640.8 641.1 14375.8 14396.4 14418.3 14451.9 14546.3 14371.4 14666.4 14732.8 14812.9 14872.3 11898.5 12018.3 12108.8 12296.1 12315.8 3882.7 3960.4 3964.5 3981.4 4087.4 81447.6 83924.0 83950.0 83982.6 84194.0 11073.6 11150.3 11286.1 11305.2 11435.0 21988.1 22245.1 22576.8 22731.3 22834.1 9037.2 9039.4 9142.1 9180.7 9352.4 4807.8 4919.9 4943.3 4968.7 5066.9 3519.8 3637.1 3638.4 3638.6 3640.9 668.2 701.1 706.3 713.3 714.7 606.5 682.3 751.0 761.8 776.3 9694.4 9950.6 9951.2 9976.5 10810.2 586.8 722.6 744.0 750.0 755.5 4370.5 4595.7 4621.1 4708.3 4741.6 129512.0 131571.0 131844.3 134153.0 135453.0 112327.4 112644.9 114527.4 114749.4 116123.0 83267.6 95297.0 99749.0 100022.0 102710.0 9920.2 10022.0 10024.3 10096.3 10407.8 37872.8 44698.8 51429.5 52147.0 53466.0 79620.6 81461.0 83061.0 83140.0 84703.0 13397.5 13473.4 13658.5 13775.9 13816.6 15298.0 15452.9 15500.5 15745.1 16275.7 12055.2 14272.1 14902.0 14979.7 15082.6 12748.9 12822.8 13018.9 13463.7 14180.9 14088.6 14503.7 14894.8 15199.7 15388.4 10890.5 11379.1 11878.9 11917.9 12328.1 12202.5 12373.8 12640.2 12730.9 12908.5 19:36:54 INFO - PROCESS | 13897 | -------- Summary: end -------- 19:36:54 INFO - PROCESS | 13897 | 19:36:55 INFO - TEST-INFO | 13897: exit 0 19:36:55 INFO - TEST-OK | dromaeo_css | took 1110881ms 19:36:55 INFO - TEST-START | kraken 19:36:55 INFO - operating with platform_type : linux_ 19:36:55 INFO - Initialising browser for kraken test... 19:36:55 INFO - TEST-INFO | started process 14134 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp71VVFE/profile http://localhost:38380/getInfo.html) 19:36:59 INFO - PROCESS | 14134 | __metrics Screen width/height:1600/1200 19:36:59 INFO - PROCESS | 14134 | colorDepth:24 19:36:59 INFO - PROCESS | 14134 | Browser inner width/height: 1024/697 19:36:59 INFO - PROCESS | 14134 | __metrics 19:37:00 ERROR - PROCESS | 14134 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2964: TypeError: this.tabs is undefined 19:37:00 INFO - TEST-INFO | 14134: exit 0 19:37:00 INFO - Browser initialized. 19:37:00 INFO - Running cycle 1/1 for kraken test... 19:37:00 INFO - TEST-INFO | started process 14252 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp71VVFE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:37:12 INFO - PROCESS | 14252 | RSS: Main: 167292928 19:37:12 INFO - PROCESS | 14252 | 19:37:15 INFO - PROCESS | 14252 | Cycle 1(1): loaded http://localhost:38380/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38380/tests/kraken/driver.html?testName=audio-beat-detection) 19:37:16 INFO - PROCESS | 14252 | RSS: Main: 172871680 19:37:16 INFO - PROCESS | 14252 | 19:37:18 INFO - PROCESS | 14252 | Cycle 1(1): loaded http://localhost:38380/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38380/tests/kraken/driver.html?testName=audio-dft) 19:37:19 INFO - PROCESS | 14252 | RSS: Main: 172531712 19:37:19 INFO - PROCESS | 14252 | 19:37:22 INFO - PROCESS | 14252 | Cycle 1(1): loaded http://localhost:38380/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38380/tests/kraken/driver.html?testName=audio-fft) 19:37:22 INFO - PROCESS | 14252 | RSS: Main: 167641088 19:37:22 INFO - PROCESS | 14252 | 19:37:24 INFO - PROCESS | 14252 | Cycle 1(1): loaded http://localhost:38380/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38380/tests/kraken/driver.html?testName=audio-oscillator) 19:37:25 INFO - PROCESS | 14252 | RSS: Main: 167952384 19:37:25 INFO - PROCESS | 14252 | 19:37:27 INFO - PROCESS | 14252 | Cycle 1(1): loaded http://localhost:38380/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38380/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:37:28 INFO - PROCESS | 14252 | RSS: Main: 168247296 19:37:28 INFO - PROCESS | 14252 | 19:37:31 INFO - PROCESS | 14252 | Cycle 1(1): loaded http://localhost:38380/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38380/tests/kraken/driver.html?testName=imaging-darkroom) 19:37:32 INFO - PROCESS | 14252 | RSS: Main: 168423424 19:37:32 INFO - PROCESS | 14252 | 19:37:35 INFO - PROCESS | 14252 | Cycle 1(1): loaded http://localhost:38380/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38380/tests/kraken/driver.html?testName=imaging-desaturate) 19:37:36 INFO - PROCESS | 14252 | RSS: Main: 166150144 19:37:36 INFO - PROCESS | 14252 | 19:37:38 INFO - PROCESS | 14252 | Cycle 1(1): loaded http://localhost:38380/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38380/tests/kraken/driver.html?testName=json-parse-financial) 19:37:39 INFO - PROCESS | 14252 | RSS: Main: 167817216 19:37:39 INFO - PROCESS | 14252 | 19:37:41 INFO - PROCESS | 14252 | Cycle 1(1): loaded http://localhost:38380/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38380/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:37:41 INFO - PROCESS | 14252 | RSS: Main: 167829504 19:37:41 INFO - PROCESS | 14252 | 19:37:43 INFO - PROCESS | 14252 | Cycle 1(1): loaded http://localhost:38380/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38380/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:37:44 INFO - PROCESS | 14252 | RSS: Main: 167768064 19:37:44 INFO - PROCESS | 14252 | 19:37:46 INFO - PROCESS | 14252 | Cycle 1(1): loaded http://localhost:38380/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38380/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:37:46 INFO - PROCESS | 14252 | RSS: Main: 168685568 19:37:46 INFO - PROCESS | 14252 | 19:37:49 INFO - PROCESS | 14252 | Cycle 1(1): loaded http://localhost:38380/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38380/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:37:50 INFO - PROCESS | 14252 | RSS: Main: 169213952 19:37:50 INFO - PROCESS | 14252 | 19:37:52 INFO - PROCESS | 14252 | Cycle 1(1): loaded http://localhost:38380/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38380/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:37:53 INFO - PROCESS | 14252 | RSS: Main: 168968192 19:37:53 INFO - PROCESS | 14252 | 19:37:55 INFO - PROCESS | 14252 | Cycle 1(1): loaded http://localhost:38380/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38380/tests/kraken/driver.html?testName=ai-astar) 19:37:55 INFO - PROCESS | 14252 | RSS: Main: 169771008 19:37:55 INFO - PROCESS | 14252 | 19:37:55 INFO - PROCESS | 14252 | __start_tp_report 19:37:55 INFO - PROCESS | 14252 | _x_x_mozilla_page_load 19:37:55 INFO - PROCESS | 14252 | _x_x_mozilla_page_load_details 19:37:55 INFO - PROCESS | 14252 | |i|pagename|runs| 19:37:55 INFO - PROCESS | 14252 | |0;ai-astar;101;110;103;109;111;112;112;110;110;109 19:37:55 INFO - PROCESS | 14252 | |1;audio-beat-detection;147;119;150;171;119;152;145;120;193;118 19:37:55 INFO - PROCESS | 14252 | |2;audio-dft;163;162;162;162;163;164;165;165;161;167 19:37:55 INFO - PROCESS | 14252 | |3;audio-fft;76;74;76;146;77;76;75;75;191;76 19:37:55 INFO - PROCESS | 14252 | |4;audio-oscillator;84;84;149;85;85;90;144;83;83;139 19:37:55 INFO - PROCESS | 14252 | |5;imaging-gaussian-blur;117;118;117;117;118;117;118;117;117;117 19:37:55 INFO - PROCESS | 14252 | |6;imaging-darkroom;148;148;148;147;146;147;148;147;147;147 19:37:55 INFO - PROCESS | 14252 | |7;imaging-desaturate;96;96;96;95;95;96;95;96;96;95 19:37:55 INFO - PROCESS | 14252 | |8;json-parse-financial;53;54;63;54;55;55;59;53;54;63 19:37:55 INFO - PROCESS | 14252 | |9;json-stringify-tinderbox;62;62;62;62;62;63;62;62;63;62 19:37:55 INFO - PROCESS | 14252 | |10;stanford-crypto-aes;76;76;76;76;76;75;75;75;80;76 19:37:55 INFO - PROCESS | 14252 | |11;stanford-crypto-ccm;129;119;127;138;122;133;124;131;158;121 19:37:55 INFO - PROCESS | 14252 | |12;stanford-crypto-pbkdf2;165;163;162;161;161;159;161;163;157;167 19:37:55 INFO - PROCESS | 14252 | |13;stanford-crypto-sha256-iterative;70;65;64;63;65;64;64;67;64;67 19:37:55 INFO - PROCESS | 14252 | __end_tp_report 19:37:55 INFO - PROCESS | 14252 | __start_cc_report 19:37:55 INFO - PROCESS | 14252 | _x_x_mozilla_cycle_collect,892 19:37:55 INFO - PROCESS | 14252 | __end_cc_report 19:37:55 INFO - PROCESS | 14252 | __startTimestamp1468377475444__endTimestamp 19:37:55 INFO - PROCESS | 14252 | 19:37:55 INFO - PROCESS | 14252 | ------- Summary: start ------- 19:37:55 INFO - PROCESS | 14252 | Number of tests: 14 19:37:55 INFO - PROCESS | 14252 | 19:37:55 INFO - PROCESS | 14252 | [#0] ai-astar Cycles:10 Average:108.70 Median:110.00 stddev:3.71 (3.4%) stddev-sans-first:2.70 19:37:55 INFO - PROCESS | 14252 | Values: 101.0 110.0 103.0 109.0 111.0 112.0 112.0 110.0 110.0 109.0 19:37:55 INFO - PROCESS | 14252 | 19:37:55 INFO - PROCESS | 14252 | [#1] audio-beat-detection Cycles:10 Average:143.40 Median:148.50 stddev:25.25 (17.0%) stddev-sans-first:26.75 19:37:55 INFO - PROCESS | 14252 | Values: 147.0 119.0 150.0 171.0 119.0 152.0 145.0 120.0 193.0 118.0 19:37:55 INFO - PROCESS | 14252 | 19:37:55 INFO - PROCESS | 14252 | [#2] audio-dft Cycles:10 Average:163.40 Median:163.50 stddev:1.84 (1.1%) stddev-sans-first:1.94 19:37:55 INFO - PROCESS | 14252 | Values: 163.0 162.0 162.0 162.0 163.0 164.0 165.0 165.0 161.0 167.0 19:37:55 INFO - PROCESS | 14252 | 19:37:55 INFO - PROCESS | 14252 | [#3] audio-fft Cycles:10 Average:94.20 Median:76.00 stddev:40.58 (53.4%) stddev-sans-first:42.50 19:37:55 INFO - PROCESS | 14252 | Values: 76.0 74.0 76.0 146.0 77.0 76.0 75.0 75.0 191.0 76.0 19:37:55 INFO - PROCESS | 14252 | 19:37:55 INFO - PROCESS | 14252 | [#4] audio-oscillator Cycles:10 Average:102.60 Median:84.00 stddev:28.73 (34.2%) stddev-sans-first:29.68 19:37:55 INFO - PROCESS | 14252 | Values: 84.0 84.0 149.0 85.0 85.0 90.0 144.0 83.0 83.0 139.0 19:37:55 INFO - PROCESS | 14252 | 19:37:55 INFO - PROCESS | 14252 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 19:37:55 INFO - PROCESS | 14252 | Values: 117.0 118.0 117.0 117.0 118.0 117.0 118.0 117.0 117.0 117.0 19:37:55 INFO - PROCESS | 14252 | 19:37:55 INFO - PROCESS | 14252 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.50 stddev:0.67 (0.5%) stddev-sans-first:0.67 19:37:55 INFO - PROCESS | 14252 | Values: 148.0 148.0 148.0 147.0 146.0 147.0 148.0 147.0 147.0 147.0 19:37:55 INFO - PROCESS | 14252 | 19:37:55 INFO - PROCESS | 14252 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 19:37:55 INFO - PROCESS | 14252 | Values: 96.0 96.0 96.0 95.0 95.0 96.0 95.0 96.0 96.0 95.0 19:37:55 INFO - PROCESS | 14252 | 19:37:55 INFO - PROCESS | 14252 | [#8] json-parse-financial Cycles:10 Average:56.30 Median:55.00 stddev:3.92 (7.1%) stddev-sans-first:3.97 19:37:55 INFO - PROCESS | 14252 | Values: 53.0 54.0 63.0 54.0 55.0 55.0 59.0 53.0 54.0 63.0 19:37:55 INFO - PROCESS | 14252 | 19:37:55 INFO - PROCESS | 14252 | [#9] json-stringify-tinderbox Cycles:10 Average:62.20 Median:62.00 stddev:0.42 (0.7%) stddev-sans-first:0.44 19:37:55 INFO - PROCESS | 14252 | Values: 62.0 62.0 62.0 62.0 62.0 63.0 62.0 62.0 63.0 62.0 19:37:55 INFO - PROCESS | 14252 | 19:37:55 INFO - PROCESS | 14252 | [#10] stanford-crypto-aes Cycles:10 Average:76.10 Median:76.00 stddev:1.45 (1.9%) stddev-sans-first:1.54 19:37:55 INFO - PROCESS | 14252 | Values: 76.0 76.0 76.0 76.0 76.0 75.0 75.0 75.0 80.0 76.0 19:37:55 INFO - PROCESS | 14252 | 19:37:55 INFO - PROCESS | 14252 | [#11] stanford-crypto-ccm Cycles:10 Average:130.20 Median:130.00 stddev:11.40 (8.8%) stddev-sans-first:12.08 19:37:55 INFO - PROCESS | 14252 | Values: 129.0 119.0 127.0 138.0 122.0 133.0 124.0 131.0 158.0 121.0 19:37:55 INFO - PROCESS | 14252 | 19:37:55 INFO - PROCESS | 14252 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.90 Median:162.50 stddev:2.85 (1.8%) stddev-sans-first:2.79 19:37:55 INFO - PROCESS | 14252 | Values: 165.0 163.0 162.0 161.0 161.0 159.0 161.0 163.0 157.0 167.0 19:37:55 INFO - PROCESS | 14252 | 19:37:55 INFO - PROCESS | 14252 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.30 Median:65.00 stddev:2.11 (3.2%) stddev-sans-first:1.39 19:37:55 INFO - PROCESS | 14252 | Values: 70.0 65.0 64.0 63.0 65.0 64.0 64.0 67.0 64.0 67.0 19:37:55 INFO - PROCESS | 14252 | -------- Summary: end -------- 19:37:55 INFO - PROCESS | 14252 | 19:37:56 INFO - TEST-INFO | 14252: exit 0 19:37:56 INFO - TEST-OK | kraken | took 61197ms 19:37:56 INFO - SUITE-END | took 1172s 19:37:56 INFO - Completed test suite (00:19:32) 19:37:56 INFO - javascript benchmark 19:37:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7420.508436176017, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3109.098361475172, 3121.391328690906, 3140.262038420969, 3150.6061742282213, 3157.6052993375843, 5614.522765564927, 5641.717914104299, 5662.971685141579, 5666.093425051992, 5679.0, 5491.917621235684, 5592.5805564582715, 5612.186232996213, 5663.490285874271, 5665.12190610456, 5018.749062546867, 5098.0, 5117.565006974393, 5132.563732082759, 5244.108501554726, 5080.110980578384, 5172.40517340505, 5217.37391513019, 5219.973900130513, 5231.424543300234, 347.0993838985932, 5110.923336149961, 5198.220266959967, 5208.374995000624, 5237.580993520509, 5083.212102124176, 5087.771050302746, 5098.898022039539, 5111.514406131449, 5113.2330150477355, 5066.265391518246, 5068.619853511002, 5078.64449488536, 5095.643304968654, 5122.76947537358, 5460.645058071253, 5549.250851135126, 5596.048671725816, 5620.775168993277, 5622.409646987089, 5969.731362088716, 5983.252093488314, 5994.520438364921, 5995.700214989233, 5998.220231369937, 6137.6624285664275, 6147.661878596676, 6150.384961503859, 6152.938470615281, 6156.599821011665, 5568.136938774496, 5605.775768969277, 5606.187102870102, 5648.096304591246, 5703.486686198262, 6077.574569780073, 6094.695265236809, 6101.420365065312, 6109.11417844419, 6111.297200821873, 5697.4302569742695, 5875.206847075676, 5903.173555702205, 5924.318703349084, 5941.732622031933, 5848.0, 5880.235569375954, 5894.0, 5921.911171332434, 5948.702564871739, 5905.940940590625, 5917.733701983421, 5949.524038076944, 5959.374265702126, 5971.402859713994, 5869.4717475427415, 5922.437368449991, 5956.374580668968, 5981.461668449861, 5997.190379298739, 4467.0, 4506.459224893034, 4535.773211339486, 4582.633389328846, 4624.491305956342, 4032.6169013944213, 4058.350663893763, 4072.205919845661, 4083.1221287422754, 4099.159672267178, 5597.916031259534, 5700.515456186187, 5784.421557844182, 5785.363610002896, 5787.536997040227, 6066.545009124334, 6096.587161059637, 6098.674287528808, 6110.796104529107, 6119.969400152971, 5688.11834165705, 5734.971325143348, 5765.135229715576, 5766.0, 5786.913196302059, 5059.2916991621205, 5112.769925353368, 5166.070107380708, 5174.508421699932, 5178.275041494194, 6277.1525844011385, 6292.433680968735, 6296.905546416808, 6298.811035668938, 6315.084312774622, 6061.636301821904, 6071.51427885768, 6082.574219804571, 6086.239220097488, 6100.664463454553, 5977.163197152489, 6122.39815511198, 6205.03821907605, 6211.192544969125, 6278.058291256166, 5915.319738230159, 5922.1412895130825, 5925.911111333419, 5928.34788173292, 5959.791407300723, 5978.372270911492, 6017.849553761191, 6024.0662697282, 6028.547858910687, 6030.396960303934, 5642.633228840113, 5800.912986305125, 5833.329167145663, 5857.26784151981, 5873.4126587340925, 5801.709914504342, 5853.619514731528, 5857.209276747584, 5860.94139058621, 5881.029630110984, 5665.546756259571, 5818.476337129509, 5818.912716309174, 5854.063349864001, 5858.150568167677, 5705.572082093942, 5747.683877386617, 5785.537157027512, 5812.3025236971835, 5815.4184581543195, 5721.313442386941, 5732.484076432974, 5749.425057494217, 5764.279465066867, 5776.104703770922], "value": 5493.988626269571, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [543.6626043254141, 587.8442212813604, 600.0489224579042, 612.4243211381302, 622.1259130921057, 38869.80565097174, 44329.7783511082, 44404.999999999956, 44575.77712111439, 44724.329135062915, 44532.77733611336, 45147.54852451474, 45391.54608453914, 45446.318305225446, 45584.0, 8824.779380515474, 8921.77695557613, 8983.595738191798, 8986.415882967618, 8999.730008099768, 8870.73387798367, 8918.375713700043, 8970.59632316544, 8984.865227021568, 8986.820263594724, 8928.732138035837, 8938.374313798036, 8954.776130596721, 8992.775180620503, 9006.819863602725, 8920.152585504367, 8950.0, 8959.641614335418, 9000.819983600357, 9007.909920900773, 8839.513826739527, 8914.643414263423, 8920.241779448756, 8926.86609700855, 8934.151255630704, 34039.659603403896, 42175.57824421778, 42463.57536424658, 42621.0, 42823.35764963528, 3247.480403135487, 3431.9313613727836, 3469.254110366258, 3515.472679098156, 3608.657177568127, 31626.367472650418, 31886.0, 32010.679893201002, 32219.838900805345, 33083.50374744381, 4349.217140914634, 4365.454318210223, 4375.803088861009, 4377.6935614507, 4438.600525952647, 319853.0, 322614.0, 323048.0, 324335.0, 325016.0, 33781.49327760086, 33887.83056084704, 33927.32145357128, 34013.489797653056, 35438.0, 35750.28499429997, 37559.248815023544, 37925.62074379276, 37964.05089872775, 38014.42978355327, 15502.612434689223, 15643.217839108, 15670.608234793994, 15675.137867417401, 15707.0, 13041.152325098838, 13052.54316098932, 13129.277889715966, 13162.60512184636, 13168.275744834125, 8548.786280343042, 8601.13988601135, 8609.956950215334, 8614.224719775126, 8670.13298670128, 3221.8711251550144, 3259.1037464697397, 3288.621808492006, 3298.307355455381, 3305.5702758641223, 1095.2169199022737, 1128.7358158861962, 1163.9825402618967, 1198.3768440410938, 1227.7053507158219, 33602.66397335995, 34210.14474638154, 34345.82827085898, 34414.82792586021, 34457.31085378279, 1122.057471723756, 1140.2417392434104, 1147.4262868565718, 1151.717829131868, 1201.7836789377996, 17906.55233619144, 18108.547286317946, 18119.63760724778, 18128.637427251644, 18296.45110646656, 155610.0, 155894.0, 156756.0, 591889.0, 603372.0, 61755.0, 62401.37598624046, 62433.375666243664, 62540.0, 62578.37421625816, 1295.792673172288, 1358.280111540885, 1369.8630136986221, 1379.7309524642599, 1388.8333399992066, 33048.33903321872, 33117.051907542496, 33237.0, 33439.996800096036, 33826.661733383335, 54692.0, 54810.355689329386, 54864.45135548753, 55084.0, 55276.0, 365109.0, 367870.8032299214, 368074.0, 368753.0, 498571.0, 28412.57381139243, 28927.56608650914, 29402.264943376587, 29471.410571788874, 29531.704682952895, 51042.744786275834, 51369.743151284005, 52046.73976630244, 52170.739146304026, 52792.20811687751, 44060.779696101315, 44482.777586111864, 45123.323150152115, 45453.0, 45660.77169614131, 43540.78229608832, 43929.56070439383, 44071.0, 44852.0, 45592.316115257636, 43384.783076084415, 44381.0, 44462.333065003404, 44587.0, 46729.53270467252, 38670.41994370143, 38988.2202355957, 39942.600573993885, 40063.599364007154, 40206.396904045876, 30074.699253008064, 30317.242068948453, 30341.848290758404, 30461.390772184874, 30909.381812364078], "value": 18885.582414952223, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [396.1482811954298, 397.3225650266296, 400.61340806122087, 402.1153462382758, 419.8383622305411, 14340.856591434083, 18789.71815422768, 18906.62186756264, 20285.188592456303, 20310.390688279356, 19545.902270488663, 19597.0, 19911.502212444695, 20230.696539551882, 20363.490912727153, 5682.346530149044, 5782.884342313172, 5835.737391817378, 5863.706814659271, 5879.088741245114, 5692.203091567184, 5751.712414379285, 5842.649441033552, 5844.941550584483, 5847.122931560279, 5704.942950570483, 5714.799982000631, 5725.513331366818, 5779.9422005779825, 5843.912341314884, 5756.827295181151, 5785.971070144665, 5789.478946894778, 5792.826215213529, 5793.957087724208, 5131.846044618667, 5212.713300768456, 5218.217267409919, 5237.633365664405, 5248.134057880445, 23893.7610623895, 24144.517109657885, 24213.0, 24296.39259018521, 24488.265352039467, 2364.6807680963193, 2404.026369320428, 2532.3036165054573, 2556.9744302556924, 2570.139003433852, 14927.925360373129, 15159.621009474851, 15295.541133766004, 15529.36941621136, 15762.290696918666, 1897.4307707687776, 1934.6807776716826, 1937.9496851580266, 1959.5982823521144, 2063.772984971652, 79391.0, 82985.17014829894, 83240.75138872983, 83963.7405438919, 84943.57528212319, 9170.86243706345, 9538.761530961781, 10917.672469825919, 10973.231873768918, 11069.5572177112, 15042.172680502677, 15086.924565377103, 15148.863835212404, 15166.24168791578, 15171.24143792806, 8232.464889782144, 8449.493030418194, 8581.485110893367, 8604.48373097616, 8651.091635378321, 8284.337253019865, 8299.211574900375, 8352.498850069016, 8463.195996380335, 8551.315894728406, 6598.37315455031, 6699.899501507482, 6700.525884305445, 6797.5581587196675, 6868.862622747617, 1951.443838506019, 1961.146901098027, 1962.7154062660834, 1985.334912804198, 2025.1798021801194, 992.3797626483448, 1034.9896501035043, 1097.1880808201872, 1135.7785231879704, 1170.4030944218339, 18054.90972545155, 20402.38792836217, 20770.0, 21036.0, 21116.260930867345, 1034.9327293725885, 1035.8756949166147, 1054.681647940075, 1063.5214153630898, 1115.9163062770324, 11680.131179011318, 11688.298702077902, 11788.29270243771, 11909.0, 12035.217710848767, 493051.0, 506541.0, 516708.0, 520168.0, 526781.0, 85563.0, 88327.0, 90490.54754726184, 94921.0, 95823.0, 1003.0972125087479, 1028.228828378716, 1045.3153184664056, 1059.0521483272428, 1069.1393428290146, 17752.733708994117, 18148.0, 18279.451616451526, 18617.06914654289, 18647.160877760805, 31140.53289200709, 36977.44533832048, 42599.7870010648, 44661.55338446574, 44705.55294447014, 60032.699836500535, 66354.0, 68478.65760671165, 68532.657336713, 68734.3126568748, 7540.396768258636, 7885.172056934169, 8037.196280371916, 8872.822543549222, 9148.588313525774, 10323.896761032594, 14502.709945801236, 14640.633984150481, 14775.704485910006, 15016.849831501546, 11904.642860714192, 12046.638600841989, 12191.0, 12282.447289871798, 12690.0, 12560.37198140071, 12636.684082898, 12683.42924568415, 12711.36443177819, 12765.297908615115, 12470.127091103535, 12605.684857878627, 12767.680807979876, 12824.29466379358, 12878.935605321913, 8175.632096555551, 8193.221643943816, 8246.917530824616, 8289.751307460545, 8375.748727538183, 9298.256139508958, 11773.76452470963, 12151.0, 13057.673558161123, 13115.475380984653], "value": 9653.753183431587, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1524.5350168198702, 1539.8537138971797, 1689.4509284482547, 1794.8653850961182, 1808.61114860305, 7970.72102476412, 8501.617427215775, 8872.512011839346, 9007.234385077269, 9026.187643112118, 8844.513551754651, 9141.45151290923, 9175.449473031622, 9198.172164505193, 9250.167484926355, 2307.1924826310783, 2348.9060437582475, 2351.412146963259, 2360.079568968104, 2366.3137690069943, 2341.438054866837, 2348.635961425982, 2411.5538625354366, 2421.5520128776143, 2422.648715936188, 2343.1137933963155, 2347.1550241912896, 2359.6696462495265, 2424.793892519138, 2425.223928342931, 2312.9884350578222, 2318.907243710258, 2322.5006623576014, 2329.04509151248, 2376.085207195225, 2274.7725227477285, 2301.2290882554366, 2308.988455057731, 2312.7224733032144, 2313.201945328859, 9342.299327550461, 9363.4381937084, 9414.482203478807, 9419.670311539063, 9422.34043616947, 5272.789088436458, 5276.287701160332, 5385.8114965976, 5391.946080539223, 5394.406615272317, 3426.9657303427143, 3453.9827300863585, 3466.2201004773974, 3500.6149323574386, 3663.0, 1210.4976434779555, 1216.3614102596118, 1220.2495465288873, 1254.40415802494, 1256.2462522486526, 12833.486660533568, 12886.226826390353, 12914.741705165845, 12916.354182290848, 12932.094753367268, 4477.485089214782, 4620.653450991122, 4701.717896926195, 4759.357486739246, 4766.213574760195, 10801.459927003618, 10900.454977251105, 10952.945235273774, 10958.178136639784, 10986.615468458725, 5263.4473380295285, 5301.966116607225, 5310.601704872072, 5311.0, 5325.094733895247, 4391.560843915647, 4847.80608775652, 4864.391951006124, 5007.148784706608, 5007.924881126786, 4090.426189005559, 4097.385392191195, 4157.251694694924, 4160.313548264563, 4176.0, 1303.9413226404833, 1308.6335825968745, 1312.8293321868096, 1321.4714114354335, 1337.251139361941, 872.4590753732599, 940.8203240933038, 941.0213378086713, 1031.257494603884, 1053.9262251642313, 6047.78832740852, 6220.565442521296, 6251.562390632703, 6258.3428739982555, 6273.560850740496, 994.22450488619, 1004.9748756281006, 1013.0426746724274, 1021.8569400283966, 1032.7727899862018, 4047.0, 4099.446574712376, 4104.507459104927, 4134.37984302357, 4277.230098582285, 11411.657650270505, 11742.060635149168, 11746.353950532803, 11778.823317650242, 11832.408379580986, 11544.59593914209, 11613.535458581562, 11641.76716465666, 11685.298882067103, 11701.590444334408, 8073.354131669453, 8387.035490918623, 8606.913930860612, 8783.34124940632, 8836.955815220883, 6136.2636483622255, 6232.8130156095385, 6233.470155036873, 6256.812295631138, 6336.9049464259, 10590.682279531626, 10731.89268107309, 10847.24069315172, 10858.945705271422, 10930.672079837617, 10795.0, 10929.83605245906, 10976.506057227603, 11039.116870650168, 11095.389753563632, 7247.8550428990075, 7919.247671471201, 7964.123946365779, 8068.636911338886, 8228.588570571328, 8976.820463590822, 9021.909780902108, 9035.0, 9068.455892646462, 9144.63421463134, 7528.28481294298, 7763.262490063435, 8203.507789532647, 8241.917580824114, 8292.04641466239, 7887.369010479033, 7966.522008679498, 7978.92021079805, 8051.51690898548, 8051.637676304464, 7155.463340249398, 7366.447516436181, 7414.332710056121, 7453.105627324539, 7454.813629659302, 4780.163471392423, 4781.6891902026255, 4787.497312782108, 4793.328933949319, 4815.759212039454, 5303.946960530346, 5451.64564303319, 5474.781008759605, 5478.561715062865, 5481.5066644000635], "value": 4808.428421399258, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [332.40001796756854, 334.25127713920824, 335.2574048482611, 340.6014962493882, 341.1097036734125, 5518.69647169406, 5572.832815015551, 5577.9163312550245, 5578.298618921227, 5591.8602034949145, 5496.6258435391155, 5529.30883639545, 5534.695591742453, 5536.280283563131, 5545.502714267155, 4098.405731168986, 4221.387898754679, 4314.245007123756, 4339.19724850902, 4349.13017396522, 4317.244482215616, 4322.610965013148, 4327.783610819462, 4343.348497725335, 4368.49762277339, 4340.632700699285, 4347.804348804311, 4350.390945267665, 4360.6075453209205, 4372.650187984954, 4252.170826688797, 4275.9786201068955, 4313.913721725579, 4315.036658320457, 4319.503257125408, 3800.1069748609057, 3804.353259945788, 3812.8370846891685, 3820.9557886530574, 3823.0, 5419.214213938996, 5427.62006659534, 5440.755166017539, 5440.83677489672, 5450.781968721247, 4876.707397556158, 4966.652334336598, 4975.601951843843, 4994.650374473788, 5015.924761128586, 5797.246357973479, 5808.59339846211, 5819.825405237807, 5837.3287071986415, 5847.26909136358, 4212.978935105336, 4230.2174097792, 4239.788010599457, 4241.1093670329265, 4250.171216612762, 5743.282089738783, 6010.609310394854, 6051.606645568024, 6052.606580572248, 6070.726817293233, 4166.8333266669, 4169.56219596944, 4179.1014931789205, 4182.351735481006, 4190.784672444956, 4166.937495937564, 4188.28799104153, 4200.474940632421, 4220.430241917302, 4237.194932962727, 4781.713097214179, 4884.340614017134, 4930.531599498042, 4935.0, 4940.580050695659, 5870.148828419855, 5873.706314684248, 5885.764569417175, 5888.941110588839, 5904.645721256738, 1477.6527516033723, 1494.499342720201, 1499.8151460346423, 1501.144347721788, 1504.9172295523633, 919.172744529915, 939.4645052320112, 950.9857352139724, 951.1867353412871, 953.3707752883064, 5024.824131155392, 5042.697438153723, 5060.418051924003, 5065.594752419797, 5109.6021145938275, 5285.339332583427, 5292.841214763564, 5321.600879934021, 5347.331583552056, 5368.91946620801, 5069.645124841226, 5099.490050994871, 5335.3864305604575, 5739.540836733051, 5807.82576522705, 3173.508106243536, 3195.344954284366, 3218.1471909943884, 3219.0, 3226.628937672198, 6081.483073938764, 6169.704362083923, 6220.937790622126, 6233.2208473940755, 6239.0, 6128.356522565066, 6128.908066379008, 6161.322254551996, 6163.691815409212, 6170.5372097092895, 6196.47329976948, 6198.81403557894, 6212.006079027425, 6212.1303017577575, 6218.409251121137, 5826.70866456684, 6009.248843894513, 6026.969865150646, 6042.456178943916, 6051.425114614105, 5902.61632993854, 5963.92649323126, 5984.414130255399, 5989.580729348903, 6013.819585412444, 5967.46292833647, 6233.438990490878, 6238.6880655966115, 6241.96879015602, 6248.4376406123665, 4226.2392769300595, 4226.408302837666, 4249.936250956176, 4251.192273468031, 4254.702170848011, 5833.445822646841, 5986.850328741816, 6012.835379263374, 6040.0, 6052.757889684363, 5857.58996870215, 5894.469497745224, 5896.761680047238, 5904.911426328695, 5906.468417842415, 5691.886162276648, 5870.180244124335, 5895.351511333835, 5909.734061967308, 5941.1385349123275, 5852.268466441695, 5887.617304875341, 5894.263217097863, 5894.2926848778425, 5895.823125306248, 5905.940940590539, 5939.554533409925, 5941.792037278675, 5945.762169513171, 5946.672932988554, 5688.345840228427, 5804.709764511673, 5816.302043754777, 5834.591578589458, 5845.3277873045145], "value": 4417.917804319249, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [709.8615769924867, 722.3426681719636, 753.7248904149986, 767.7044337929897, 783.4398405140323, 14815.925920370397, 15819.446319378823, 15842.68314633708, 15849.92075039626, 15856.52430427086, 14955.775663365059, 15088.547343579683, 15225.39098436064, 15280.69438611227, 15290.46483373082, 661.2296674374348, 780.0756104016758, 793.4763056382789, 810.8337790752881, 816.4733746733353, 813.5728742410223, 819.9262066414021, 820.0528389709895, 827.1025936858516, 827.2761333832897, 858.1547176031604, 859.5014891362995, 865.2040123086775, 867.7787164273102, 868.4615538366222, 862.344618090256, 863.0937515608585, 863.48622569571, 865.5455885660048, 865.7575878753928, 635.9904601430982, 638.6551262318343, 638.8275165705234, 640.7757284950277, 641.0608458608161, 14375.78436323456, 14396.424143034266, 14418.279086045655, 14451.855481445156, 14546.34541445627, 14371.425142994267, 14666.413343466249, 14732.779008314883, 14812.851871481254, 14872.330745116496, 11898.46456909441, 12018.286100872085, 12108.757824843453, 12296.139270251086, 12315.815262771066, 3882.6893848492055, 3960.4059391091278, 3964.5044369453817, 3981.422693709425, 4087.407325937752, 81447.59276203581, 83924.0, 83950.0, 83982.58008709918, 84194.0, 11073.5570577176, 11150.276815230825, 11286.095789552466, 11305.152113591514, 11435.0, 21988.120475180815, 22245.11019559232, 22576.84277822714, 22731.318060458212, 22834.086636534354, 9037.186653201243, 9039.367244292967, 9142.131497507726, 9180.6786762463, 9352.438853668802, 4807.831725889577, 4919.852404427873, 4943.28322393251, 4968.701877887338, 5066.898662026812, 3519.7536172468194, 3637.1089083174793, 3638.3632864248652, 3638.581563120222, 3640.9453858192146, 668.1547841979899, 701.0885848397063, 706.2654838967417, 713.290276175209, 714.6855383631186, 606.4693393280879, 682.2631557917438, 750.9774706758806, 761.8133557278502, 776.3386353204147, 9694.418334899929, 9950.601975921027, 9951.15415189717, 9976.501174941224, 10810.189235807346, 586.7828903305718, 722.6278466589711, 744.0, 750.0, 755.5164694595463, 4370.54109318517, 4595.6783025187915, 4621.112354321552, 4708.270218116198, 4741.596964258008, 129512.0, 131571.0, 131844.3407782955, 134153.0, 135453.0, 112327.43836280766, 112644.86196242378, 114527.42736286265, 114749.4262528682, 116123.0, 83267.58366208251, 95297.0, 99749.0, 100022.0, 102710.0, 9920.156786672926, 10022.0, 10024.348417352849, 10096.293259471766, 10407.84388234162, 37872.81063594665, 44698.776506118564, 51429.48570514247, 52147.0, 53466.0, 79620.60189699015, 81461.0, 83061.0, 83140.0, 84703.0, 13397.531086412318, 13473.393697283449, 13658.521951731642, 13775.862241377457, 13816.585502434944, 15298.0, 15452.922735386252, 15500.5349839505, 15745.13401762914, 16275.674486510441, 12055.21641093326, 14272.143671379336, 14902.0, 14979.700405992036, 15082.622934426727, 12748.936255318664, 12822.807657885325, 13018.869811301765, 13463.730725385241, 14180.858191417954, 14088.647783805487, 14503.709925801213, 14894.79540362938, 15199.696006080037, 15388.38446462129, 10890.466976521564, 11379.146564007568, 11878.881211187778, 11917.880821191677, 12328.137030408145, 12202.511899523919, 12373.75252494927, 12640.241585504898, 12730.936345318585, 12908.483660653845], "value": 7845.615503905297, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1524.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 110.0, 103.0, 109.0, 111.0, 112.0, 112.0, 110.0, 110.0, 109.0], "value": 108.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 119.0, 150.0, 171.0, 119.0, 152.0, 145.0, 120.0, 193.0, 118.0], "value": 143.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 162.0, 162.0, 163.0, 164.0, 165.0, 165.0, 161.0, 167.0], "value": 163.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 76.0, 146.0, 77.0, 76.0, 75.0, 75.0, 191.0, 76.0], "value": 94.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 149.0, 85.0, 85.0, 90.0, 144.0, 83.0, 83.0, 139.0], "value": 102.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 118.0, 117.0, 118.0, 117.0, 117.0, 117.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 148.0, 147.0, 146.0, 147.0, 148.0, 147.0, 147.0, 147.0], "value": 147.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 95.0, 95.0, 96.0, 95.0, 96.0, 96.0, 95.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 63.0, 54.0, 55.0, 55.0, 59.0, 53.0, 54.0, 63.0], "value": 56.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 62.0, 62.0, 63.0, 62.0, 62.0, 63.0, 62.0], "value": 62.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 76.0, 76.0, 75.0, 75.0, 75.0, 80.0, 76.0], "value": 76.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 119.0, 127.0, 138.0, 122.0, 133.0, 124.0, 131.0, 158.0, 121.0], "value": 130.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 163.0, 162.0, 161.0, 161.0, 159.0, 161.0, 163.0, 157.0, 167.0], "value": 161.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 65.0, 64.0, 63.0, 65.0, 64.0, 64.0, 67.0, 64.0, 67.0], "value": 65.3, "unit": "score"}]}]} 19:37:56 INFO - Return code: 0 19:37:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:37:56 ERROR - # TBPL SUCCESS # 19:37:56 INFO - Running post-action listener: _resource_record_post_action 19:37:56 INFO - ##### 19:37:56 INFO - ##### Finished run-tests step (success) 19:37:56 INFO - ##### 19:37:56 INFO - Running post-run listener: _resource_record_post_run 19:37:56 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 559329280; Read time: 20; Write time: 400912 19:37:56 INFO - TinderboxPrint: CPU usage
13.3% 19:37:56 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 19:37:56 INFO - TinderboxPrint: I/O write bytes / time
559,329,280 / 400,912 19:37:56 INFO - TinderboxPrint: CPU idle
8,234.8 (86.7%) 19:37:56 INFO - TinderboxPrint: CPU user
1,205.4 (12.7%) 19:37:56 INFO - TinderboxPrint: Swap in / out
0 / 0 19:37:56 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 257179648; Read time: 0; Write time: 218512 19:37:56 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 0; Write bytes: 298205184; Read time: 0; Write time: 182052 19:37:57 INFO - Running post-run listener: _upload_blobber_files 19:37:57 INFO - Blob upload gear active. 19:37:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:37:57 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 19:37:57 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'] 19:37:57 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 19:37:57 INFO - (blobuploader) - INFO - Open directory for files ... 19:37:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:37:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:37:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:38:01 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:38:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:38:01 INFO - (blobuploader) - INFO - Done attempting. 19:38:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:38:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:38:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:38:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:38:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:38:03 INFO - (blobuploader) - INFO - Done attempting. 19:38:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:38:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:38:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:38:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:38:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:38:03 INFO - (blobuploader) - INFO - Done attempting. 19:38:03 INFO - (blobuploader) - INFO - Iteration through files over. 19:38:03 INFO - Return code: 0 19:38:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:38:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:38:03 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f09073f164831224baf591a716c7014dec084ebeed58b03b5db29c9aa336c4988fd7fe6c2a816ca6ab91eb0700d0489bab332a1188cb0855f33aaa7779e0db72", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/730725060ac6fca8ec9eda56a8c73de47cf127cac0e69f8ba90ea7d27edd90d6a33f640d901bfe7db30d9734de0b4e4d07ceff13b9a8fd8a85b64ae22181f3da", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b3a3a824a18d4163e11c953278b198242b8c810198f49d17c6801d4156e7d2f6695ab76173ea92caccaf423235c81634630fe8a239566b533646d1e8582fcc91"} 19:38:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:38:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:38:03 INFO - Contents: 19:38:03 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f09073f164831224baf591a716c7014dec084ebeed58b03b5db29c9aa336c4988fd7fe6c2a816ca6ab91eb0700d0489bab332a1188cb0855f33aaa7779e0db72", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/730725060ac6fca8ec9eda56a8c73de47cf127cac0e69f8ba90ea7d27edd90d6a33f640d901bfe7db30d9734de0b4e4d07ceff13b9a8fd8a85b64ae22181f3da", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b3a3a824a18d4163e11c953278b198242b8c810198f49d17c6801d4156e7d2f6695ab76173ea92caccaf423235c81634630fe8a239566b533646d1e8582fcc91"} 19:38:03 INFO - Running post-run listener: copy_logs_to_upload_dir 19:38:03 INFO - Copying logs to upload dir... 19:38:03 INFO - mkdir: /builds/slave/test/build/upload/logs 19:38:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1229.928748 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-07-12 19:38:03.823147) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-12 19:38:03.826587) ========= 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=1f5564757af27664ca02d71f000001b0-1468376220.467006-964018221 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f09073f164831224baf591a716c7014dec084ebeed58b03b5db29c9aa336c4988fd7fe6c2a816ca6ab91eb0700d0489bab332a1188cb0855f33aaa7779e0db72", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/730725060ac6fca8ec9eda56a8c73de47cf127cac0e69f8ba90ea7d27edd90d6a33f640d901bfe7db30d9734de0b4e4d07ceff13b9a8fd8a85b64ae22181f3da", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b3a3a824a18d4163e11c953278b198242b8c810198f49d17c6801d4156e7d2f6695ab76173ea92caccaf423235c81634630fe8a239566b533646d1e8582fcc91"} build_url:https://queue.taskcluster.net/v1/task/dVV6kjT8RjGFQjlhC-YxNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011216 build_url: 'https://queue.taskcluster.net/v1/task/dVV6kjT8RjGFQjlhC-YxNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f09073f164831224baf591a716c7014dec084ebeed58b03b5db29c9aa336c4988fd7fe6c2a816ca6ab91eb0700d0489bab332a1188cb0855f33aaa7779e0db72", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/730725060ac6fca8ec9eda56a8c73de47cf127cac0e69f8ba90ea7d27edd90d6a33f640d901bfe7db30d9734de0b4e4d07ceff13b9a8fd8a85b64ae22181f3da", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b3a3a824a18d4163e11c953278b198242b8c810198f49d17c6801d4156e7d2f6695ab76173ea92caccaf423235c81634630fe8a239566b533646d1e8582fcc91"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-12 19:38:03.852364) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 19:38:03.852738) ========= 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=1f5564757af27664ca02d71f000001b0-1468376220.467006-964018221 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004466 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 19:38:03.938348) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-12 19:38:03.938716) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-12 19:38:03.939067) ========= ========= Total master_lag: 0.18 =========