builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-028 starttime: 1467785492.91 results: success (0) buildid: 20160705203035 builduid: 7dd269baf9164a7e8e03346a5c8413c8 revision: d8fa10d0a52eb52ee1fc46f88c37662c71af37a6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-05 23:11:32.909257) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-05 23:11:32.909988) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-05 23:11:32.910302) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-05 23:11:32.947904) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 23:11:32.948183) ========= 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=836cfdc75598d54cb747368e000001a9-1467783869.247480-1528355608 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-05 23:11: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.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 87.6M=0s 2016-07-05 23:11:33 (87.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.130449 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 23:11:33.095957) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 23:11:33.096270) ========= 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=836cfdc75598d54cb747368e000001a9-1467783869.247480-1528355608 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015676 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 23:11:33.160799) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 23:11:33.161155) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev d8fa10d0a52eb52ee1fc46f88c37662c71af37a6 --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 d8fa10d0a52eb52ee1fc46f88c37662c71af37a6 --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=836cfdc75598d54cb747368e000001a9-1467783869.247480-1528355608 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-05 23:11:33,605 truncating revision to first 12 chars 2016-07-05 23:11:33,605 Setting DEBUG logging. 2016-07-05 23:11:33,606 attempt 1/10 2016-07-05 23:11:33,606 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/d8fa10d0a52e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-05 23:11:34,128 unpacking tar archive at: fx-team-d8fa10d0a52e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.857123 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 23:11:34.033312) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-05 23:11:34.033610) ========= script_repo_revision: d8fa10d0a52eb52ee1fc46f88c37662c71af37a6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-05 23:11:34.033978) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-05 23:11:34.034258) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-05 23:11:34.085939) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-07-05 23:11:34.086221) ========= /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=836cfdc75598d54cb747368e000001a9-1467783869.247480-1528355608 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:11:34 INFO - MultiFileLogger online at 20160705 23:11:34 in /builds/slave/test 23:11: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 23:11:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:11:34 INFO - {'append_to_log': False, 23:11:34 INFO - 'base_work_dir': '/builds/slave/test', 23:11:34 INFO - 'blob_upload_branch': 'Fx-Team', 23:11:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:11:34 INFO - 'branch': 'Fx-Team', 23:11:34 INFO - 'buildbot_json_path': 'buildprops.json', 23:11:34 INFO - 'config_files': ('talos/linux_config.py',), 23:11:34 INFO - 'default_actions': ('clobber', 23:11:34 INFO - 'read-buildbot-config', 23:11:34 INFO - 'download-and-extract', 23:11:34 INFO - 'populate-webroot', 23:11:34 INFO - 'create-virtualenv', 23:11:34 INFO - 'install', 23:11:34 INFO - 'run-tests'), 23:11:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:11:34 INFO - 'download_minidump_stackwalk': True, 23:11:34 INFO - 'download_symbols': 'ondemand', 23:11:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:11:34 INFO - 'tooltool.py': '/tools/tooltool.py', 23:11:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:11:34 INFO - '/tools/misc-python/virtualenv.py')}, 23:11:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:11:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:11:34 INFO - 'installer_path': 'installer.exe', 23:11:34 INFO - 'log_level': 'info', 23:11:34 INFO - 'log_name': 'talos', 23:11:34 INFO - 'log_to_console': True, 23:11:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:11:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:11:34 INFO - 'opt_config_files': (), 23:11:34 INFO - 'pip_index': False, 23:11:34 INFO - 'sps_profile': False, 23:11:34 INFO - 'sps_profile_interval': 0, 23:11:34 INFO - 'suite': 'dromaeojs-e10s', 23:11:34 INFO - 'system_bits': '32', 23:11:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:11:34 INFO - 'title': 'talos-linux64-ix-028', 23:11:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:11:34 INFO - 'use_talos_json': True, 23:11:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:11:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:11:34 INFO - 'work_dir': 'build'} 23:11:34 INFO - ##### 23:11:34 INFO - ##### Running clobber step. 23:11:34 INFO - ##### 23:11:34 INFO - Running pre-action listener: _resource_record_pre_action 23:11:34 INFO - Running main action method: clobber 23:11:34 INFO - rmtree: /builds/slave/test/build 23:11:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:11:35 INFO - Running post-action listener: _resource_record_post_action 23:11:35 INFO - ##### 23:11:35 INFO - ##### Finished clobber step (success) 23:11:35 INFO - ##### 23:11:35 INFO - ##### 23:11:35 INFO - ##### Running read-buildbot-config step. 23:11:35 INFO - ##### 23:11:35 INFO - Running pre-action listener: _resource_record_pre_action 23:11:35 INFO - Running main action method: read_buildbot_config 23:11:35 INFO - Using buildbot properties: 23:11:35 INFO - { 23:11:35 INFO - "project": "", 23:11:35 INFO - "product": "firefox", 23:11:35 INFO - "script_repo_revision": "production", 23:11:35 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 23:11:35 INFO - "repository": "", 23:11:35 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 23:11:35 INFO - "buildid": "20160705203035", 23:11:35 INFO - "pgo_build": "True", 23:11:35 INFO - "basedir": "/builds/slave/test", 23:11:35 INFO - "buildnumber": 895, 23:11:35 INFO - "slavename": "talos-linux64-ix-028", 23:11:35 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 23:11:35 INFO - "platform": "ubuntu64_hw", 23:11:35 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 23:11:35 INFO - "branch": "fx-team", 23:11:35 INFO - "repo_path": "integration/fx-team", 23:11:35 INFO - "revision": "d8fa10d0a52eb52ee1fc46f88c37662c71af37a6", 23:11:35 INFO - "stage_platform": "linux64-pgo", 23:11:35 INFO - "builduid": "7dd269baf9164a7e8e03346a5c8413c8", 23:11:35 INFO - "slavebuilddir": "test" 23:11:35 INFO - } 23:11:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/c9ohSk8ATaS__Z6xrYWVVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 23:11:35 INFO - Running post-action listener: _resource_record_post_action 23:11:35 INFO - ##### 23:11:35 INFO - ##### Finished read-buildbot-config step (success) 23:11:35 INFO - ##### 23:11:35 INFO - ##### 23:11:35 INFO - ##### Running download-and-extract step. 23:11:35 INFO - ##### 23:11:35 INFO - Running pre-action listener: _resource_record_pre_action 23:11:35 INFO - Running main action method: download_and_extract 23:11:35 INFO - mkdir: /builds/slave/test/build/tests 23:11: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')]} 23:11:35 INFO - https://queue.taskcluster.net/v1/task/c9ohSk8ATaS__Z6xrYWVVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 23:11:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9ohSk8ATaS__Z6xrYWVVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 23:11:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9ohSk8ATaS__Z6xrYWVVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 23:11:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9ohSk8ATaS__Z6xrYWVVQ/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 23:11:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9ohSk8ATaS__Z6xrYWVVQ/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 23:11:37 INFO - Downloaded 1361 bytes. 23:11:37 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 23:11:37 INFO - Using the following test package requirements: 23:11:37 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 23:11:37 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:11:37 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 23:11:37 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:11:37 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 23:11:37 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:11:37 INFO - u'jsshell-linux-x86_64.zip'], 23:11:37 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:11:37 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 23:11:37 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 23:11:37 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:11:37 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 23:11:37 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:11:37 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 23:11:37 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:11:37 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 23:11:37 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:11:37 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 23:11:37 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:11:37 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')]} 23:11:37 INFO - https://queue.taskcluster.net/v1/task/c9ohSk8ATaS__Z6xrYWVVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:11:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9ohSk8ATaS__Z6xrYWVVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:11:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9ohSk8ATaS__Z6xrYWVVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:11:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9ohSk8ATaS__Z6xrYWVVQ/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 23:11:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9ohSk8ATaS__Z6xrYWVVQ/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 23:11:38 INFO - Downloaded 24300608 bytes. 23:11:38 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'] 23:11:38 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 23:11:40 INFO - Return code: 0 23:11:40 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 23:11:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 23:11:40 INFO - https://queue.taskcluster.net/v1/task/c9ohSk8ATaS__Z6xrYWVVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:11:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9ohSk8ATaS__Z6xrYWVVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:11:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9ohSk8ATaS__Z6xrYWVVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:11:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9ohSk8ATaS__Z6xrYWVVQ/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 23:11:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9ohSk8ATaS__Z6xrYWVVQ/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 23:11:41 INFO - Downloaded 24300608 bytes. 23:11:41 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'] 23:11:41 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 23:11:42 INFO - Return code: 0 23:11: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')]} 23:11:42 INFO - https://queue.taskcluster.net/v1/task/c9ohSk8ATaS__Z6xrYWVVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 23:11:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9ohSk8ATaS__Z6xrYWVVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 23:11:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9ohSk8ATaS__Z6xrYWVVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 23:11:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9ohSk8ATaS__Z6xrYWVVQ/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 23:11:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9ohSk8ATaS__Z6xrYWVVQ/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 23:11:43 INFO - Downloaded 14403333 bytes. 23:11:43 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'] 23:11:43 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 23:11:43 INFO - Return code: 0 23:11:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:11:43 INFO - https://queue.taskcluster.net/v1/task/c9ohSk8ATaS__Z6xrYWVVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 23:11:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9ohSk8ATaS__Z6xrYWVVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 23:11:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9ohSk8ATaS__Z6xrYWVVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 23:11:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9ohSk8ATaS__Z6xrYWVVQ/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 23:11:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9ohSk8ATaS__Z6xrYWVVQ/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 23:11:45 INFO - Downloaded 60337068 bytes. 23:11:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/c9ohSk8ATaS__Z6xrYWVVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 23:11:45 INFO - mkdir: /builds/slave/test/properties 23:11:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:11:45 INFO - Writing to file /builds/slave/test/properties/build_url 23:11:45 INFO - Contents: 23:11:45 INFO - build_url:https://queue.taskcluster.net/v1/task/c9ohSk8ATaS__Z6xrYWVVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 23:11:46 INFO - Running post-action listener: _resource_record_post_action 23:11:46 INFO - Running post-action listener: set_extra_try_arguments 23:11:46 INFO - ##### 23:11:46 INFO - ##### Finished download-and-extract step (success) 23:11:46 INFO - ##### 23:11:46 INFO - ##### 23:11:46 INFO - ##### Running populate-webroot step. 23:11:46 INFO - ##### 23:11:46 INFO - Running pre-action listener: _resource_record_pre_action 23:11:46 INFO - Running main action method: populate_webroot 23:11:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:11:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:11:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:11:46 INFO - '--tppagecycles', 23:11:46 INFO - '7'], 23:11:46 INFO - 'tests': ['tsvgm']}}, 23:11:46 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:11:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:11:46 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:11:46 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:11:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:11:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:11:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:11:46 INFO - 'talos_options': ['--disable-e10s'], 23:11:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:11:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:11:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:11:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:11:46 INFO - 'talos_options': ['--disable-e10s'], 23:11:46 INFO - 'tests': ['damp', 'tps']}, 23:11:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:11:46 INFO - 'tests': ['damp', 'tps']}, 23:11:46 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:11:46 INFO - 'tests': ['dromaeo_dom']}, 23:11:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:11:46 INFO - 'g4': {'talos_options': ['--disable-e10s'], 23:11:46 INFO - 'tests': ['basic_compositor_video']}, 23:11:46 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 23:11:46 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:11:46 INFO - 'tests': ['a11yr', 23:11:46 INFO - 'ts_paint', 23:11:46 INFO - 'tpaint', 23:11:46 INFO - 'sessionrestore', 23:11:46 INFO - 'sessionrestore_no_auto_restore', 23:11:46 INFO - 'tabpaint']}, 23:11:46 INFO - 'other-e10s': {'tests': ['a11yr', 23:11:46 INFO - 'ts_paint', 23:11:46 INFO - 'tpaint', 23:11:46 INFO - 'sessionrestore', 23:11:46 INFO - 'sessionrestore_no_auto_restore', 23:11:46 INFO - 'tabpaint']}, 23:11:46 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:11:46 INFO - 'ts_paint', 23:11:46 INFO - 'tpaint', 23:11:46 INFO - 'sessionrestore', 23:11:46 INFO - 'sessionrestore_no_auto_restore', 23:11:46 INFO - 'tabpaint']}, 23:11:46 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:11:46 INFO - 'ts_paint', 23:11:46 INFO - 'tpaint', 23:11:46 INFO - 'sessionrestore', 23:11:46 INFO - 'sessionrestore_no_auto_restore', 23:11:46 INFO - 'tabpaint']}, 23:11:46 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:11:46 INFO - 'tests': ['a11yr', 23:11:46 INFO - 'ts_paint', 23:11:46 INFO - 'tpaint', 23:11:46 INFO - 'sessionrestore', 23:11:46 INFO - 'sessionrestore_no_auto_restore', 23:11:46 INFO - 'tabpaint']}, 23:11:46 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:11:46 INFO - 'tests': ['a11yr', 23:11:46 INFO - 'ts_paint', 23:11:46 INFO - 'tpaint', 23:11:46 INFO - 'sessionrestore', 23:11:46 INFO - 'sessionrestore_no_auto_restore', 23:11:46 INFO - 'tabpaint']}, 23:11:46 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:11:46 INFO - 'tests': ['tsvgx', 23:11:46 INFO - 'tsvgr_opacity', 23:11:46 INFO - 'tart', 23:11:46 INFO - 'tscrollx', 23:11:46 INFO - 'cart']}, 23:11:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:11:46 INFO - 'tsvgr_opacity', 23:11:46 INFO - 'tart', 23:11:46 INFO - 'tscrollx', 23:11:46 INFO - 'cart']}, 23:11:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:11:46 INFO - 'talos_options': ['--disable-e10s'], 23:11:46 INFO - 'tests': ['tp5o']}, 23:11:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:11:46 INFO - 'tests': ['tp5o']}, 23:11:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:11:46 INFO - 'talos_options': ['--disable-e10s', 23:11:46 INFO - '--xperf_path', 23:11:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:11:46 INFO - 'tests': ['tp5n']}, 23:11:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:11:46 INFO - 'talos_options': ['--xperf_path', 23:11:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:11:46 INFO - 'tests': ['tp5n']}}, 23:11:46 INFO - 'talos.zip': {'path': '', 23:11:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:11:46 INFO - Running post-action listener: _resource_record_post_action 23:11:46 INFO - ##### 23:11:46 INFO - ##### Finished populate-webroot step (success) 23:11:46 INFO - ##### 23:11:46 INFO - ##### 23:11:46 INFO - ##### Running create-virtualenv step. 23:11:46 INFO - ##### 23:11:46 INFO - Running pre-action listener: _resource_record_pre_action 23:11:46 INFO - Running main action method: create_virtualenv 23:11:46 INFO - Creating virtualenv /builds/slave/test/build/venv 23:11:46 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 23:11:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:11:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:11:46 INFO - Using real prefix '/usr' 23:11:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:11:46 INFO - Installing distribute.............................................................................................................................................................................................done. 23:11:48 INFO - Installing pip.................done. 23:11:48 INFO - Return code: 0 23:11:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:11:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:11:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:11:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:11:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:11:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:11:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:11:48 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 0x27ff030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ac0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2abe3b0>, '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 0x2abf2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2abf740>, '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': '836cfdc75598d54cb747368e000001a9-1467783869.247480-1528355608', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:11:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 23:11:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 23:11:48 INFO - Using env: {'DISPLAY': ':0', 23:11:48 INFO - 'HOME': '/home/cltbld', 23:11:48 INFO - 'LANG': 'en_US.UTF-8', 23:11:48 INFO - 'LANGUAGE': 'en_US:en', 23:11:48 INFO - 'LOGNAME': 'cltbld', 23:11:48 INFO - 'MAIL': '/var/mail/cltbld', 23:11:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:11:48 INFO - 'MOZ_NO_REMOTE': '1', 23:11:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:11:48 INFO - 'NO_EM_RESTART': '1', 23:11:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:11:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:11:48 INFO - 'PWD': '/builds/slave/test', 23:11:48 INFO - 'SHELL': '/bin/bash', 23:11:48 INFO - 'SHLVL': '1', 23:11:48 INFO - 'TERM': 'linux', 23:11:48 INFO - 'TMOUT': '86400', 23:11:48 INFO - 'USER': 'cltbld', 23:11:48 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1467783869.247480-1528355608', 23:11:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:11:48 INFO - '_': '/tools/buildbot/bin/python'} 23:11:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:11:48 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 23:11:48 INFO - Cleaning up... 23:11:48 INFO - Return code: 0 23:11:48 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23:11:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:11:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:11:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:11:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:11:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:11:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:11:48 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 0x27ff030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ac0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2abe3b0>, '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 0x2abf2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2abf740>, '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': '836cfdc75598d54cb747368e000001a9-1467783869.247480-1528355608', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:11:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 23:11:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 23:11:48 INFO - Using env: {'DISPLAY': ':0', 23:11:48 INFO - 'HOME': '/home/cltbld', 23:11:48 INFO - 'LANG': 'en_US.UTF-8', 23:11:48 INFO - 'LANGUAGE': 'en_US:en', 23:11:48 INFO - 'LOGNAME': 'cltbld', 23:11:48 INFO - 'MAIL': '/var/mail/cltbld', 23:11:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:11:48 INFO - 'MOZ_NO_REMOTE': '1', 23:11:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:11:48 INFO - 'NO_EM_RESTART': '1', 23:11:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:11:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:11:48 INFO - 'PWD': '/builds/slave/test', 23:11:48 INFO - 'SHELL': '/bin/bash', 23:11:48 INFO - 'SHLVL': '1', 23:11:48 INFO - 'TERM': 'linux', 23:11:48 INFO - 'TMOUT': '86400', 23:11:48 INFO - 'USER': 'cltbld', 23:11:48 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1467783869.247480-1528355608', 23:11:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:11:48 INFO - '_': '/tools/buildbot/bin/python'} 23:11:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:11:49 INFO - Downloading/unpacking psutil>=3.1.1 23:11:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:11:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:11:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:11:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:11:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:11:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:11:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:11:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:11:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:11:51 INFO - Installing collected packages: psutil 23:11:51 INFO - Running setup.py install for psutil 23:11:51 INFO - building 'psutil._psutil_linux' extension 23:11:51 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 23:11:51 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 23:11:51 INFO - building 'psutil._psutil_posix' extension 23:11:51 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 23:11:51 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 23:11:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:11:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:11:51 INFO - Successfully installed psutil 23:11:51 INFO - Cleaning up... 23:11:51 INFO - Return code: 0 23:11:51 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 23:11:51 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')]} 23:11:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:11:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:11:51 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')]} 23:11:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:11:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:11:51 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 0x27ff030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ac0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2abe3b0>, '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 0x2abf2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2abf740>, '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': '836cfdc75598d54cb747368e000001a9-1467783869.247480-1528355608', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:11:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 23:11:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 23:11:51 INFO - Using env: {'DISPLAY': ':0', 23:11:51 INFO - 'HOME': '/home/cltbld', 23:11:51 INFO - 'LANG': 'en_US.UTF-8', 23:11:51 INFO - 'LANGUAGE': 'en_US:en', 23:11:51 INFO - 'LOGNAME': 'cltbld', 23:11:51 INFO - 'MAIL': '/var/mail/cltbld', 23:11:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:11:51 INFO - 'MOZ_NO_REMOTE': '1', 23:11:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:11:51 INFO - 'NO_EM_RESTART': '1', 23:11:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:11:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:11:51 INFO - 'PWD': '/builds/slave/test', 23:11:51 INFO - 'SHELL': '/bin/bash', 23:11:51 INFO - 'SHLVL': '1', 23:11:51 INFO - 'TERM': 'linux', 23:11:51 INFO - 'TMOUT': '86400', 23:11:51 INFO - 'USER': 'cltbld', 23:11:51 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1467783869.247480-1528355608', 23:11:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:11:51 INFO - '_': '/tools/buildbot/bin/python'} 23:11:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:11:52 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:11:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:11:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:11:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:11:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:11:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:11:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:11:53 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:11:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:11:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 23:11:54 INFO - Installing collected packages: mozsystemmonitor 23:11:54 INFO - Running setup.py install for mozsystemmonitor 23:11:54 INFO - Successfully installed mozsystemmonitor 23:11:54 INFO - Cleaning up... 23:11:54 INFO - Return code: 0 23:11:54 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 23:11:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 23:11:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:11:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:11:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 23:11:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:11:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:11:54 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 0x27ff030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ac0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2abe3b0>, '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 0x2abf2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2abf740>, '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': '836cfdc75598d54cb747368e000001a9-1467783869.247480-1528355608', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:11:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 23:11:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 23:11:54 INFO - Using env: {'DISPLAY': ':0', 23:11:54 INFO - 'HOME': '/home/cltbld', 23:11:54 INFO - 'LANG': 'en_US.UTF-8', 23:11:54 INFO - 'LANGUAGE': 'en_US:en', 23:11:54 INFO - 'LOGNAME': 'cltbld', 23:11:54 INFO - 'MAIL': '/var/mail/cltbld', 23:11:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:11:54 INFO - 'MOZ_NO_REMOTE': '1', 23:11:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:11:54 INFO - 'NO_EM_RESTART': '1', 23:11:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:11:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:11:54 INFO - 'PWD': '/builds/slave/test', 23:11:54 INFO - 'SHELL': '/bin/bash', 23:11:54 INFO - 'SHLVL': '1', 23:11:54 INFO - 'TERM': 'linux', 23:11:54 INFO - 'TMOUT': '86400', 23:11:54 INFO - 'USER': 'cltbld', 23:11:54 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1467783869.247480-1528355608', 23:11:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:11:54 INFO - '_': '/tools/buildbot/bin/python'} 23:11:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:11:54 INFO - Downloading/unpacking jsonschema==2.5.1 23:11:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:11:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:11:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:11:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:11:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:11:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:11:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:11:56 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 23:11:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:11:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:11:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:11:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:11:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:11:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:11:56 INFO - Downloading functools32-3.2.3-2.tar.gz 23:11:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:11:56 INFO - warning: no files found matching '*.txt' 23:11:56 INFO - no previously-included directories found matching 'build' 23:11:56 INFO - no previously-included directories found matching 'dist' 23:11:56 INFO - no previously-included directories found matching '.git*' 23:11:56 INFO - Installing collected packages: jsonschema, functools32 23:11:56 INFO - Running setup.py install for functools32 23:11:56 INFO - warning: no files found matching '*.txt' 23:11:56 INFO - no previously-included directories found matching 'build' 23:11:56 INFO - no previously-included directories found matching 'dist' 23:11:56 INFO - no previously-included directories found matching '.git*' 23:11:56 INFO - Successfully installed jsonschema functools32 23:11:56 INFO - Cleaning up... 23:11:56 INFO - Return code: 0 23:11:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:11:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:11:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:11:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:11:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:11:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:11:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:11:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x27ff030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ac0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2abe3b0>, '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 0x2abf2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2abf740>, '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': '836cfdc75598d54cb747368e000001a9-1467783869.247480-1528355608', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:11:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 23:11:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 23:11:56 INFO - Using env: {'DISPLAY': ':0', 23:11:56 INFO - 'HOME': '/home/cltbld', 23:11:56 INFO - 'LANG': 'en_US.UTF-8', 23:11:56 INFO - 'LANGUAGE': 'en_US:en', 23:11:56 INFO - 'LOGNAME': 'cltbld', 23:11:56 INFO - 'MAIL': '/var/mail/cltbld', 23:11:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:11:56 INFO - 'MOZ_NO_REMOTE': '1', 23:11:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:11:56 INFO - 'NO_EM_RESTART': '1', 23:11:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:11:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:11:56 INFO - 'PWD': '/builds/slave/test', 23:11:56 INFO - 'SHELL': '/bin/bash', 23:11:56 INFO - 'SHLVL': '1', 23:11:56 INFO - 'TERM': 'linux', 23:11:56 INFO - 'TMOUT': '86400', 23:11:56 INFO - 'USER': 'cltbld', 23:11:56 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1467783869.247480-1528355608', 23:11:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:11:56 INFO - '_': '/tools/buildbot/bin/python'} 23:11:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:11:56 INFO - Downloading/unpacking blobuploader==1.2.4 23:11:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:11:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:11:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:11:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:11:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:11:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:11:58 INFO - Downloading blobuploader-1.2.4.tar.gz 23:11:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:11:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:11: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 23:11: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 23:11: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 23:11: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 23:11: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 23:11: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 23:11:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:11:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:11:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:11:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:11:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:11:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:11:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:11:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:11:59 INFO - Downloading docopt-0.6.1.tar.gz 23:11:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:11:59 INFO - Installing collected packages: blobuploader, requests, docopt 23:11:59 INFO - Running setup.py install for blobuploader 23:11:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:11:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:11:59 INFO - Running setup.py install for requests 23:12:00 INFO - Running setup.py install for docopt 23:12:00 INFO - Successfully installed blobuploader requests docopt 23:12:00 INFO - Cleaning up... 23:12:00 INFO - Return code: 0 23:12:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:12:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:12:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:12:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:12:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:12:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:12:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:12:00 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 0x27ff030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ac0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2abe3b0>, '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 0x2abf2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2abf740>, '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': '836cfdc75598d54cb747368e000001a9-1467783869.247480-1528355608', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:12:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 23:12:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 23:12:00 INFO - Using env: {'DISPLAY': ':0', 23:12:00 INFO - 'HOME': '/home/cltbld', 23:12:00 INFO - 'LANG': 'en_US.UTF-8', 23:12:00 INFO - 'LANGUAGE': 'en_US:en', 23:12:00 INFO - 'LOGNAME': 'cltbld', 23:12:00 INFO - 'MAIL': '/var/mail/cltbld', 23:12:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:12:00 INFO - 'MOZ_NO_REMOTE': '1', 23:12:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:12:00 INFO - 'NO_EM_RESTART': '1', 23:12:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:12:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:12:00 INFO - 'PWD': '/builds/slave/test', 23:12:00 INFO - 'SHELL': '/bin/bash', 23:12:00 INFO - 'SHLVL': '1', 23:12:00 INFO - 'TERM': 'linux', 23:12:00 INFO - 'TMOUT': '86400', 23:12:00 INFO - 'USER': 'cltbld', 23:12:00 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1467783869.247480-1528355608', 23:12:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:12:00 INFO - '_': '/tools/buildbot/bin/python'} 23:12:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:12:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:12:00 INFO - Running setup.py (path:/tmp/pip-OWHEd_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:12:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:12:00 INFO - Running setup.py (path:/tmp/pip-oObf5x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:12:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:12:00 INFO - Running setup.py (path:/tmp/pip-cB0zQP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:12:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:12:00 INFO - Running setup.py (path:/tmp/pip-xKgmTY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:12:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:12:00 INFO - Running setup.py (path:/tmp/pip-2N85aF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:12:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:12:00 INFO - Running setup.py (path:/tmp/pip-ab0seu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:12:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:12:00 INFO - Running setup.py (path:/tmp/pip-Fa_iHT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:12:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:12:00 INFO - Running setup.py (path:/tmp/pip-54oPup-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:12:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:12:00 INFO - Running setup.py (path:/tmp/pip-iRjUZI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:12:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:12:01 INFO - Running setup.py (path:/tmp/pip-HfQbOV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:12:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:12:01 INFO - Running setup.py (path:/tmp/pip-B98lKT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:12:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:12:01 INFO - Running setup.py (path:/tmp/pip-cUbvBN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:12:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:12:01 INFO - Running setup.py (path:/tmp/pip-lJ8lJ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:12:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:12:01 INFO - Running setup.py (path:/tmp/pip-X5an0c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:12:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:12:01 INFO - Running setup.py (path:/tmp/pip-03Naf0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:12:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:12:01 INFO - Running setup.py (path:/tmp/pip-oEBpjm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:12:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:12:01 INFO - Running setup.py (path:/tmp/pip-mC5zip-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:12:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:12:01 INFO - Running setup.py install for manifestparser 23:12:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:12:01 INFO - Running setup.py install for mozcrash 23:12:01 INFO - Running setup.py install for mozdebug 23:12:01 INFO - Running setup.py install for mozdevice 23:12:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:12:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:12:02 INFO - Running setup.py install for mozfile 23:12:02 INFO - Running setup.py install for mozhttpd 23:12:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:12:02 INFO - Running setup.py install for mozinfo 23:12:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:12:02 INFO - Running setup.py install for mozInstall 23:12:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:12:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:12:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:12:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:12:02 INFO - Running setup.py install for mozleak 23:12:02 INFO - Running setup.py install for mozlog 23:12:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:12:02 INFO - Running setup.py install for moznetwork 23:12:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:12:02 INFO - Running setup.py install for mozprocess 23:12:02 INFO - Running setup.py install for mozprofile 23:12:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:12:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:12:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:12:02 INFO - Running setup.py install for mozrunner 23:12:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:12:03 INFO - Running setup.py install for mozscreenshot 23:12:03 INFO - Running setup.py install for moztest 23:12:03 INFO - Running setup.py install for mozversion 23:12:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:12:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:12:03 INFO - Cleaning up... 23:12:03 INFO - Return code: 0 23:12:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:12:03 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')]} 23:12:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:12:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:12:03 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')]} 23:12:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:12:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:12:03 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 0x27ff030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ac0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2abe3b0>, '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 0x2abf2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2abf740>, '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': '836cfdc75598d54cb747368e000001a9-1467783869.247480-1528355608', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:12:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 23:12:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 23:12:03 INFO - Using env: {'DISPLAY': ':0', 23:12:03 INFO - 'HOME': '/home/cltbld', 23:12:03 INFO - 'LANG': 'en_US.UTF-8', 23:12:03 INFO - 'LANGUAGE': 'en_US:en', 23:12:03 INFO - 'LOGNAME': 'cltbld', 23:12:03 INFO - 'MAIL': '/var/mail/cltbld', 23:12:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:12:03 INFO - 'MOZ_NO_REMOTE': '1', 23:12:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:12:03 INFO - 'NO_EM_RESTART': '1', 23:12:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:12:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:12:03 INFO - 'PWD': '/builds/slave/test', 23:12:03 INFO - 'SHELL': '/bin/bash', 23:12:03 INFO - 'SHLVL': '1', 23:12:03 INFO - 'TERM': 'linux', 23:12:03 INFO - 'TMOUT': '86400', 23:12:03 INFO - 'USER': 'cltbld', 23:12:03 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1467783869.247480-1528355608', 23:12:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:12:03 INFO - '_': '/tools/buildbot/bin/python'} 23:12:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:12:03 INFO - Running setup.py (path:/tmp/pip-bQfaTK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:12:03 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 23:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:12:03 INFO - Running setup.py (path:/tmp/pip-4DQIzJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:12:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:12:03 INFO - Running setup.py (path:/tmp/pip-nXtPRS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:12:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 23:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:12:03 INFO - Running setup.py (path:/tmp/pip-CBgj0s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:12:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 23:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:12:03 INFO - Running setup.py (path:/tmp/pip-BJtpyR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:12:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 23:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:12:03 INFO - Running setup.py (path:/tmp/pip-YRuxME-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:12:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 23:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:12:04 INFO - Running setup.py (path:/tmp/pip-WJ5INE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:12:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 23:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:12:04 INFO - Running setup.py (path:/tmp/pip-ErrC_e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:12:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 23:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:12:04 INFO - Running setup.py (path:/tmp/pip-HeIK4W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:12:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 23:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:12:04 INFO - Running setup.py (path:/tmp/pip-NRD95v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:12:04 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)) 23:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:12:04 INFO - Running setup.py (path:/tmp/pip-HodCpC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:12:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 23:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:12:04 INFO - Running setup.py (path:/tmp/pip-oAP8Ad-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:12:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 23:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:12:04 INFO - Running setup.py (path:/tmp/pip-r2PhYA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:12:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 23:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:12:04 INFO - Running setup.py (path:/tmp/pip-JEdBLa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:12:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 23:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:12:04 INFO - Running setup.py (path:/tmp/pip-eIQGCr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:12:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 23:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:12:04 INFO - Running setup.py (path:/tmp/pip-9vidiw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:12:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 23:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:12:04 INFO - Running setup.py (path:/tmp/pip-dRDnl7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:12:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 23:12:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:12:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:12:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 23:12:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 23:12:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 23:12:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:12:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:12:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:12:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:12:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:12:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:12:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:12:06 INFO - Downloading blessings-1.6.tar.gz 23:12:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:12:06 INFO - Installing collected packages: blessings 23:12:06 INFO - Running setup.py install for blessings 23:12:06 INFO - Successfully installed blessings 23:12:06 INFO - Cleaning up... 23:12:06 INFO - Return code: 0 23:12:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:12:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:12:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:12:07 INFO - Reading from file tmpfile_stdout 23:12:07 INFO - Current package versions: 23:12:07 INFO - argparse == 1.2.1 23:12:07 INFO - blessings == 1.6 23:12:07 INFO - blobuploader == 1.2.4 23:12:07 INFO - docopt == 0.6.1 23:12:07 INFO - functools32 == 3.2.3-2 23:12:07 INFO - jsonschema == 2.5.1 23:12:07 INFO - manifestparser == 1.1 23:12:07 INFO - mozInstall == 1.12 23:12:07 INFO - mozcrash == 0.17 23:12:07 INFO - mozdebug == 0.1 23:12:07 INFO - mozdevice == 0.48 23:12:07 INFO - mozfile == 1.2 23:12:07 INFO - mozhttpd == 0.7 23:12:07 INFO - mozinfo == 0.9 23:12:07 INFO - mozleak == 0.1 23:12:07 INFO - mozlog == 3.2 23:12:07 INFO - moznetwork == 0.27 23:12:07 INFO - mozprocess == 0.22 23:12:07 INFO - mozprofile == 0.28 23:12:07 INFO - mozrunner == 6.11 23:12:07 INFO - mozscreenshot == 0.1 23:12:07 INFO - mozsystemmonitor == 0.3 23:12:07 INFO - moztest == 0.7 23:12:07 INFO - mozversion == 1.4 23:12:07 INFO - psutil == 3.1.1 23:12:07 INFO - requests == 1.2.3 23:12:07 INFO - wsgiref == 0.1.2 23:12:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:12:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:12:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:12:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:12:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:12:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:12:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:12:07 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 0x27ff030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ac0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2abe3b0>, '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 0x2abf2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2abf740>, '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': '836cfdc75598d54cb747368e000001a9-1467783869.247480-1528355608', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:12:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 23:12:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 23:12:07 INFO - Using env: {'DISPLAY': ':0', 23:12:07 INFO - 'HOME': '/home/cltbld', 23:12:07 INFO - 'LANG': 'en_US.UTF-8', 23:12:07 INFO - 'LANGUAGE': 'en_US:en', 23:12:07 INFO - 'LOGNAME': 'cltbld', 23:12:07 INFO - 'MAIL': '/var/mail/cltbld', 23:12:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:12:07 INFO - 'MOZ_NO_REMOTE': '1', 23:12:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:12:07 INFO - 'NO_EM_RESTART': '1', 23:12:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:12:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:12:07 INFO - 'PWD': '/builds/slave/test', 23:12:07 INFO - 'SHELL': '/bin/bash', 23:12:07 INFO - 'SHLVL': '1', 23:12:07 INFO - 'TERM': 'linux', 23:12:07 INFO - 'TMOUT': '86400', 23:12:07 INFO - 'USER': 'cltbld', 23:12:07 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1467783869.247480-1528355608', 23:12:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:12:07 INFO - '_': '/tools/buildbot/bin/python'} 23:12:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:12:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 23:12:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 23:12:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 23:12:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 23:12:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 23:12:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 23:12:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 23:12:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 23:12:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 23:12:07 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 23:12:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 23:12:07 INFO - Cleaning up... 23:12:07 INFO - Return code: 0 23:12:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:12:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:12:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:12:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:12:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:12:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:12:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:12:07 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 0x27ff030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ac0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2abe3b0>, '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 0x2abf2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2abf740>, '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': '836cfdc75598d54cb747368e000001a9-1467783869.247480-1528355608', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:12:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 23:12:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 23:12:07 INFO - Using env: {'DISPLAY': ':0', 23:12:07 INFO - 'HOME': '/home/cltbld', 23:12:07 INFO - 'LANG': 'en_US.UTF-8', 23:12:07 INFO - 'LANGUAGE': 'en_US:en', 23:12:07 INFO - 'LOGNAME': 'cltbld', 23:12:07 INFO - 'MAIL': '/var/mail/cltbld', 23:12:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:12:07 INFO - 'MOZ_NO_REMOTE': '1', 23:12:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:12:07 INFO - 'NO_EM_RESTART': '1', 23:12:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:12:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:12:07 INFO - 'PWD': '/builds/slave/test', 23:12:07 INFO - 'SHELL': '/bin/bash', 23:12:07 INFO - 'SHLVL': '1', 23:12:07 INFO - 'TERM': 'linux', 23:12:07 INFO - 'TMOUT': '86400', 23:12:07 INFO - 'USER': 'cltbld', 23:12:07 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1467783869.247480-1528355608', 23:12:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:12:07 INFO - '_': '/tools/buildbot/bin/python'} 23:12:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:12:07 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 23:12:07 INFO - Cleaning up... 23:12:07 INFO - Return code: 0 23:12:07 INFO - Running post-action listener: _resource_record_post_action 23:12:07 INFO - Running post-action listener: _start_resource_monitoring 23:12:07 INFO - Starting resource monitoring. 23:12:07 INFO - ##### 23:12:07 INFO - ##### Finished create-virtualenv step (success) 23:12:07 INFO - ##### 23:12:07 INFO - ##### 23:12:07 INFO - ##### Running install step. 23:12:07 INFO - ##### 23:12:07 INFO - Running pre-action listener: _resource_record_pre_action 23:12:07 INFO - Running main action method: install 23:12:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:12:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:12:07 INFO - Reading from file tmpfile_stdout 23:12:07 INFO - Detecting whether we're running mozinstall >=1.0... 23:12:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:12:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:12:07 INFO - Reading from file tmpfile_stdout 23:12:07 INFO - Output received: 23:12:07 INFO - Usage: mozinstall [options] installer 23:12:07 INFO - Options: 23:12:07 INFO - -h, --help show this help message and exit 23:12:07 INFO - -d DEST, --destination=DEST 23:12:07 INFO - Directory to install application into. [default: 23:12:07 INFO - "/builds/slave/test"] 23:12:07 INFO - --app=APP Application being installed. [default: firefox] 23:12:07 INFO - mkdir: /builds/slave/test/build/application 23:12:07 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'] 23:12:07 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 23:12:25 INFO - Reading from file tmpfile_stdout 23:12:25 INFO - Output received: 23:12:25 INFO - /builds/slave/test/build/application/firefox/firefox 23:12:25 INFO - Running post-action listener: _resource_record_post_action 23:12:25 INFO - ##### 23:12:25 INFO - ##### Finished install step (success) 23:12:25 INFO - ##### 23:12:25 INFO - ##### 23:12:25 INFO - ##### Running run-tests step. 23:12:25 INFO - ##### 23:12:25 INFO - Running pre-action listener: _resource_record_pre_action 23:12:25 INFO - Running main action method: run_tests 23:12:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:12:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:12:25 INFO - Python 2.7.3 23:12:25 INFO - Return code: 0 23:12:25 INFO - grabbing minidump binary from tooltool 23:12:25 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')]} 23:12:25 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 0x2abe3b0>, '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 0x2abf2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2abf740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:12:25 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 23:12:25 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 23:12:25 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 23:12:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:12:25 INFO - Return code: 0 23:12:25 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:12:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:12:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:12:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:12:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:12:25 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/c9ohSk8ATaS__Z6xrYWVVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--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 23:12:25 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/c9ohSk8ATaS__Z6xrYWVVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-028 --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 23:12:25 INFO - Using env: {'DISPLAY': ':0', 23:12:25 INFO - 'HOME': '/home/cltbld', 23:12:25 INFO - 'LANG': 'en_US.UTF-8', 23:12:25 INFO - 'LANGUAGE': 'en_US:en', 23:12:25 INFO - 'LOGNAME': 'cltbld', 23:12:25 INFO - 'MAIL': '/var/mail/cltbld', 23:12:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:12:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:12:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:12:25 INFO - 'MOZ_NO_REMOTE': '1', 23:12:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:12:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:12:25 INFO - 'NO_EM_RESTART': '1', 23:12:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:12:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:12:25 INFO - 'PWD': '/builds/slave/test', 23:12:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:12:25 INFO - 'SHELL': '/bin/bash', 23:12:25 INFO - 'SHLVL': '1', 23:12:25 INFO - 'TERM': 'linux', 23:12:25 INFO - 'TMOUT': '86400', 23:12:25 INFO - 'USER': 'cltbld', 23:12:25 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1467783869.247480-1528355608', 23:12:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:12:25 INFO - '_': '/tools/buildbot/bin/python'} 23:12:25 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/c9ohSk8ATaS__Z6xrYWVVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--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 23:12:25 INFO - mozversion application_buildid: 20160705203035 23:12:25 INFO - mozversion application_changeset: d8fa10d0a52eb52ee1fc46f88c37662c71af37a6 23:12:25 INFO - mozversion application_display_name: Nightly 23:12:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:12:25 INFO - mozversion application_name: Firefox 23:12:25 INFO - mozversion application_remotingname: firefox 23:12:25 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 23:12:25 INFO - mozversion application_vendor: Mozilla 23:12:25 INFO - mozversion application_version: 50.0a1 23:12:25 INFO - mozversion platform_buildid: 20160705203035 23:12:25 INFO - mozversion platform_changeset: d8fa10d0a52eb52ee1fc46f88c37662c71af37a6 23:12:25 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 23:12:25 INFO - mozversion platform_version: 50.0a1 23:12:25 INFO - using testdate: 1467785545 23:12:25 INFO - actual date: 1467785545 23:12:25 INFO - starting webserver on 'localhost:51713' 23:12:25 INFO - SUITE-START | Running 2 tests 23:12:25 INFO - TEST-START | dromaeo_css 23:12:25 INFO - operating with platform_type : linux_ 23:12:25 INFO - Initialising browser for dromaeo_css test... 23:12:25 INFO - TEST-INFO | started process 6023 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpx4rUHH/profile http://localhost:51713/getInfo.html) 23:12:30 INFO - PROCESS | 6023 | __metrics Screen width/height:1600/1200 23:12:30 INFO - PROCESS | 6023 | colorDepth:24 23:12:30 INFO - PROCESS | 6023 | Browser inner width/height: 1024/697 23:12:30 INFO - PROCESS | 6023 | __metrics 23:12:31 ERROR - PROCESS | 6023 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2952: TypeError: this.tabs is undefined 23:12:31 INFO - TEST-INFO | 6023: exit 0 23:12:31 INFO - Browser initialized. 23:12:31 INFO - Running cycle 1/1 for dromaeo_css test... 23:12:31 INFO - TEST-INFO | started process 6143 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpx4rUHH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:12:43 INFO - PROCESS | 6143 | RSS: Main: 168591360 23:12:43 INFO - PROCESS | 6143 | 23:13:33 INFO - PROCESS | 6143 | 1467785613254 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 23:15:41 INFO - PROCESS | 6143 | Cycle 1(1): loaded http://localhost:51713/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51713/tests/dromaeo/cssquery-ext.html) 23:15:42 INFO - PROCESS | 6143 | RSS: Main: 172150784 23:15:42 INFO - PROCESS | 6143 | 23:18:44 INFO - PROCESS | 6143 | Cycle 1(1): loaded http://localhost:51713/tests/dromaeo/cssquery-ext.html (next: http://localhost:51713/tests/dromaeo/cssquery-jquery.html) 23:18:45 INFO - PROCESS | 6143 | RSS: Main: 169000960 23:18:45 INFO - PROCESS | 6143 | 23:21:47 INFO - PROCESS | 6143 | Cycle 1(1): loaded http://localhost:51713/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51713/tests/dromaeo/cssquery-mootools.html) 23:21:47 INFO - PROCESS | 6143 | RSS: Main: 172535808 23:21:47 INFO - PROCESS | 6143 | 23:24:49 INFO - PROCESS | 6143 | Cycle 1(1): loaded http://localhost:51713/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51713/tests/dromaeo/cssquery-prototype.html) 23:24:50 INFO - PROCESS | 6143 | RSS: Main: 168169472 23:24:50 INFO - PROCESS | 6143 | 23:27:52 INFO - PROCESS | 6143 | Cycle 1(1): loaded http://localhost:51713/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51713/tests/dromaeo/cssquery-yui.html) 23:27:53 INFO - PROCESS | 6143 | RSS: Main: 170483712 23:27:53 INFO - PROCESS | 6143 | 23:30:56 INFO - PROCESS | 6143 | Cycle 1(1): loaded http://localhost:51713/tests/dromaeo/cssquery-yui.html (next: http://localhost:51713/tests/dromaeo/cssquery-dojo.html) 23:30:56 INFO - PROCESS | 6143 | RSS: Main: 171110400 23:30:56 INFO - PROCESS | 6143 | 23:30:56 INFO - PROCESS | 6143 | __start_tp_report 23:30:56 INFO - PROCESS | 6143 | _x_x_mozilla_page_load 23:30:56 INFO - PROCESS | 6143 | _x_x_mozilla_page_load_details 23:30:56 INFO - PROCESS | 6143 | |i|pagename|runs| 23:30:56 INFO - PROCESS | 6143 | |0;dojo.html;3101.4572449821285;3176.1900715317593;3193.776435649504;3203.19920019995;3225.32268223673;5456.017916774974;5523.116301391773;5557.555395568355;5570.220169176314;5585.5810814189;5417.295751552293;5443.482869127436;5452.945470545294;5471.5896307776875;5566.55467562595;4903.852884413464;4930.975345123269;5024.120778863702;5030.195168772997;5132.589392848582;868.5805436252205;4976.253561965698;5005.5244751748705;5037.647364684473;5123.231515272721;4931.26031095335;4962.950370496303;4964.67729597575;4993.75031248438;5012.172991456406;4850.126977144113;4986.750662466862;4994.051130285234;5014.07239660664;5076.213186956028;4925.13810083234;4925.704457732511;4935.827246046371;4937.481564435719;4958.429780575244;5453.400125986138;5477.397486276506;5523.558115350762;5541.22878934684;5607.186957891083;5787.3923238059815;5844.532437404998;5935.821925342247;5947.970260148715;5953.910691339634;5849.7660093596205;5922.2597175353085;5934.347221805598;5939.049752039653;5988.550858685616;5489.917651235235;5523.917141242885;5524.06090964537;5530.751116199781;5530.944690553083;5871.3541510433815;5960.225170727777;5970;6000.309964354068;6031.939680603138;5848.707564621837;5853.443922827325;5855.238818953509;5855.619384739978;5882.176495290662;5892.734826932799;5908.734106965197;5912.556558258148;5915.940840591625;5958.582899197015;5710.2862142232225;5756.481916627524;5816.447437493432;5821.2141360916585;5867.765289388462;5710.8001219957105;5801.506871915934;5832.445917637902;5860.208871802337;5892.587518873637;4456.509783923766;4484.910301793946;4491.842785502492;4493.460784705856;4502.527234640315;3834.731568790158;3924.8617900809018;3968.8809335719975;3989.501312335958;4040.3939409088284;5567.331920169525;5585.441455854463;5591.30108736408;5620.57845661577;5637.68992705397;5858.121281807677;5874.471297583238;5883.941160588425;5892.175095486636;5896.6756828374855;5515.61390702655;5601.8599535011135;5626.718664066781;5634.32388113429;5634.802781902614;5076.898462030738;5083.2375143727995;5085.593152547787;5101.362329708786;5131.820386286462;6044.425779551024;6045.969770151209;6096.963516202256;6102.0541816018585;6107.603005804608;5766;5827.737751801094;5852.707364631837;5918.378570250148;5940.108983652487;6073.453389194994;6078.331383547717;6079.726412311368;6091.086337049478;6115.052166914135;5746.339170995389;5796.681182535001;5797.043487824461;5811.157382179645;5822.912656310244;5693.9715301424885;5899.292084949833;5912.881742365043;5959.344472108151;5964.433378829004;5825;5837.182794408871;5837.912431313449;5843.707814609337;5845.590808643354;5781.971090144522;5785.942140578541;5801.3908539602735;5805.651660900359;5807.854803629774;5502.064649009598;5554.666719996813;5628.240187574625;5655.915161272666;5687.914681279867;5704.515116215168;5740.253767010429;5754.8849023018465;5756.1941328214925;5759.280089988752;5660.094384898396;5662.66024038559;5697.4302569742695;5704.087346024616;5713.742881570256 23:30:56 INFO - PROCESS | 6143 | |1;ext.html;566.0179588414101;586.1032620091261;591.801746414951;613.2732711736593;615.3200713211902;31040.06879793607;41223.58776412235;41430.58569414305;41918;42038.579614203845;43759;44212;44379.112417751625;44397.33403998943;44406.77796611012;8891.95554022229;9083.409578377417;9111.13444222801;9113.589888455002;9125.406848554856;8972.416792908472;9012.098790120968;9032.819343613124;9048.230900373475;9050.592723327432;9062.229710474618;9070.410423322495;9114.680986165486;9119.544022798867;9122.22461090808;8662.090480499552;8675.349348798834;8694.21752042316;8719.564021798884;8719.738407847712;8760.167784060504;8803.075677053945;8805.42764720291;8841.734747957571;8848.292136629054;41331.58668413307;41655.375169372484;41958.37062444066;41991.58008419907;42174.57825421737;3349.346877358916;3444.345574340867;3512.4204506256438;3520.9823950880336;3618.384874571303;30879.382412351628;32135.6786432135;33131.83434082814;33145.17137071568;33644.49533257003;4398.670099742532;4435.334699795024;4436.378906953029;4436.511983681792;4561.863144105682;355972;356981;358028;361883;362572.18713906524;32952.67047329496;34214;59847.102293465636;60116.69941650264;60124.69937650284;35318.644728750725;35430.291394171974;35626.643733562334;35859.282814344086;35886.641133588855;13904.721905561832;13925.651858703613;14096.788548171786;14123.71752564943;14177.645558861112;12188.390580470941;12191.756164876653;12225.877741222474;12254.326012069421;12260.877391225973;8151.959240203761;8181.140980196994;8185.79535511617;8220.38347123968;8251.917480825236;2979.657339405996;2990.088023152959;2996.1011696490964;3017.969820301769;3030.5605687175234;974.8537719342155;1001.9549120289458;1026.5893642543042;1036.5180191211123;1048.799557771137;30762.384752304828;30954.845225773726;31596.526052109235;31607.52588711171;32125.51811722826;1046.576136664652;1049.1606714628267;1110.6667999600088;1132.5016992523263;1140.623594213924;16376.918115409348;16577.336906523844;16728.749068763977;16869.831301686827;17045.829541704425;530839;535005;536301;538055;539468;55966.160507592416;56520.15219771707;57054.429455705744;57151;57215.427845721846;1265.8923991460645;1323.8940884729197;1324.3248637751688;1324.543032653733;1332.6135420728074;29838.017913781958;31096.689033110284;31174.22064448407;31309.373812524078;31549.369012620078;48039.27941080956;48233;48300.5169948296;48509.27236091532;48613;196276;196488;197220;197394;197664;27415.725842741318;27481.86259068692;27881.302967425978;28037;28077.859610701817;47220.7638961803;47535.52464475311;47838.5216147848;48172.759136205495;48225;40928.828954445045;41723.37414938839;41763.58236417597;41855.7907210462;42218.57781422146;39650;40483.79758101191;40771.1845763089;40866;41135.7943210282;40461.79769101136;40515;41742.58257417508;41911.1617767649;44027;32708;36448.27103457969;36894.26211475702;36941.44587831131;37310;27457;28262.85868570644;28294.85852570724;28512.85743571269;28619.856900715364 23:30:56 INFO - PROCESS | 6143 | |2;jquery.html;380.0403979950626;385.15270286002556;385.62209035145565;391.8491380818385;412.8224863308776;15257.465988690397;19001;19822.504437389038;20729.481762955933;20750.688739668916;18302.633947321046;18709.719354209697;19502.80497195031;19533.21867125317;19656.21375144996;5530.778768849241;5922.3485416604135;6228.22147231596;6239.095331176999;6359.046143078529;5340.572754179656;5591.077472217079;5625.774969001235;6359.491240700733;6376.585521941082;5655.293088363955;5662.716864156796;5699.943000569982;5729.169270455803;5920.792772252972;6231.252249730039;6282.120503129519;6364.586301890362;6389.265234498046;6430.839229019265;5750.942490575083;5860.853478663025;5866.941330586682;5901.02633065548;5904.055351143839;11652.766944661143;11735.589254376056;11974.880251197465;13198.20810751358;13201.075924685276;2249.212775528552;2296.9425764355856;2319;2365.302235840414;2382.797462215696;9777.31558790885;10124.89875101247;10132.54403551842;12170.513179472811;14056.086354386933;1777.6089260362698;1800.4958611588777;1914.7032210007471;1944.2028768204968;1985.4540001499558;78063;78738.60630696866;79353;82347.17652823516;82385;10574.255247884166;10964;11045.28205666629;11217;11232.66302010941;11544.19190656646;12199;12217.083718720954;15135.924320378328;15444.45944391941;5942.762289508458;6070.969645151746;6955.756548520778;7928.8810667840025;8033.517988920684;7877.565782628674;7935.682572697143;7957.283844453911;7961.522308661383;8050.959745201237;4010.438538604598;4035.414864844581;4048.4939382577177;4141.1571850526225;4183.937240941327;2013.104168644939;2035.4199053269747;2048.9077991490417;2054.979450205509;2056.5372791122177;913.4427998920653;970.6893793985856;1011.4790882695418;1031.4327120083924;1087.2986923434341;18658.53353666142;19498.31755888537;19507.317243896396;19525;19628.70556941647;975.1954637424153;986.5166068626321;1009.5406590001531;1019.2050200843354;1025.3284098915221;10700;11072.224944253825;11093.168012399103;11101.666949991513;11107.222494425312;416173;420451;448421;465044;471229;100957;101610;102057;103305;104518.47740761247;943.3867985809142;962.5476026267643;971.6404930175739;981.097390400833;989.3766926835904;15316.923415382851;17276.568085797957;17325;17449.82550174482;17457.56356091108;41003.58996409998;41082.589174107874;41870.790646046575;43266.35100473558;43818.780906095264;58308.70845645745;60883.69558152181;62402;62506.687466562376;64013;8558.144185581392;8672.826543469222;8863.423877447945;8952.23905968;9037.77405564866;12200.450979705756;12833;12850;13052.869471305165;13112.672183195496;10967.890321096687;11088.722781930193;11316.94341528287;11373;11463.541458341573;10826.56693732242;10858.891411085788;10978.780424391307;11109.50007249692;11378;5945;11039.116870650168;11191.72020699489;11298.774024519627;11512.712182195512;8700.303975682056;8730.476171429735;8741.519216442903;8979.46123232608;9154.313426492907;8332.375071869512;10385.844212336971;10938.671839844817;11063.170262230204;11693.649190524298 23:30:56 INFO - PROCESS | 6143 | |3;mootools.html;1433.9211343376114;1482.1033274868703;1577.164103025397;1709.5469700529354;1718.7679663245458;7833.255840695125;8428.241458268754;8598.05421403645;9149.817003659922;9160.221381182599;8851.734447966555;8865.689700860472;8996.505192214425;8998.23515001224;9009.774755631113;2259.8418110732255;2295.231097582312;2299.666548350488;2300.7354154272307;2309.7574754650773;2264.7961683448484;2276.146445083094;2283.063943783049;2306.3542208181652;2320.640300753386;2160.362693005567;2178.5425060737184;2242.416971587391;2281;2288.7367952685486;2225.054351900444;2225.554889022194;2233.4974630708043;2235.362921567362;2247.1460844879007;2214.3467677035314;2225.343523660524;2236.7092278003756;2239.944001399962;2243.6298010828195;9097.090290970917;9138.588763505591;9149.039350868195;9154.542272886329;9155.267578593697;4987.526185012418;5077.2637967494875;5132.050570644443;5178.533931946143;5185;3208.374366998436;3269;3381.712554432876;3390.2371966307383;3407.829608519589;1143.74837535742;1175.9529618815236;1200.5977997370892;1204.3436327201696;1233.5189276182207;12392.31842248676;12432.937835310857;12475.688107797287;12487.188332758433;12538.68653283666;4284.892877678083;4495.775211239425;4497.797599108048;4560;4575.81696732127;10464.424456654957;10496.422696751599;10555.788884222273;10568.735781605521;10569.418681972411;5129.897402051938;5147.485251474823;5150.845474635767;5158.071547121554;5188.11801993662;4191.8532851350055;4701.224297990793;4778.761061946958;4780.4741478437345;4879.536444037811;3920.980395098063;3953.7627742335553;4016.779077150726;4072.2466343726505;4110.321796903538;1239.2254840724547;1240.7084335181225;1244.6390546741525;1249.5314257153568;1251.1429670675616;995.2038369304528;1002.8946960569181;1007.6674697349857;1009.2934945538153;1014.573878970834;6203.2556093269095;6253.687315634291;6308.779192728324;6336.017917222838;6367.044943258548;440.5682431217425;441.57388120463906;461.1169610196503;462.3434722693783;463.6360457041274;4279.914401711948;4422.933655995163;4427.911441771211;4429.645628349725;4532.546745325507;10932.398718070583;11317.547298108148;11403.201775875608;11417.657470275904;11422.885771142348;10478.842817357745;10917.290376125526;10988.340699558052;11179.776404471864;11317.377544234982;8304.667813287522;8370.246677798905;8380.748577542683;8422.115677853859;8459;6261.407270732595;6299.275583307978;6331.176946997045;6456.160699109086;6501.8699626008165;10241.948790256001;10313.381197128196;10352.430616316175;10475.633352832614;10479.214058945761;10605.098566621924;10704.946475267574;10732.83900741474;10740.785184296114;10742.946285268523;7163.928360716534;7854.685812567662;7950.920490795249;8203.42576019673;8497.1502849717;8239.794005149679;8391.454555453876;8431.072582016095;8436.24073833358;8455;7460.179380268058;7744.186860379805;7784.455088144002;7792.2986931176465;7813;7498.62506874665;7530.472866899484;7534.924650753423;7545.811354716176;7710.4217183710325;6855.5886646801355;6865.828354290983;6906.654667266516;6907.723691052302;6917.377436030782;5049.798008079782;5179.559737422362;5281.524662780368;5304.655197412156;5305.495977882095;4958.25626156065;4989.9251511228085;5011.7494125294315;5162.535371816554;5256.710880901587 23:30:56 INFO - PROCESS | 6143 | |4;prototype.html;307.970742779436;316.97305729013027;322.40033537620025;323.2323232323232;332.3668411675757;5105.463926287742;5593.272874526306;5750.971245143779;5779.566532510063;5803.361630220672;5553.389127196006;5553.805616803413;5564.610477266593;5592.86017849554;5595.664260144395;4341.153475072354;4362.8036738346855;4410.536893626171;4433.290673492242;4435.62297204738;4119.393436559744;4356.6514678825615;4423.911521769563;4424.491183513905;4430.623397011258;4268.807903644328;4304.354346847967;4307.547707490716;4313.352997050436;4318.2227199104145;4330.501992270898;4382.2331092059085;4383.934240986372;4387.5393083726385;4415.712978656409;3766.4538641897047;3846.903827404309;3849.287881741887;3863.594322596115;3870.9612903870884;5473.945260547383;5495.697736624484;5517.227588137664;5538.169274608801;5540.085885828834;4941.234108713155;4948.802047918115;5010.924836127461;5017.2724954881705;5021.5229553192385;5759.308882934033;5888.352281249059;5898.675572843492;5916.337648058391;5990.460858522711;4166.354215096665;4174.08170202555;4174.3947127666315;4183.91632167358;4191.8532851350365;5986.910196347058;6151.231096113031;6198.2252218472695;6204.565680402374;6234.501239900797;4170.582941705805;4182.309918863414;4196.8458673864325;4206.116715489781;4208.431861698631;4203.42371610646;4238.618524332825;4251.213525497793;4255.170241802881;4266.040140968319;4839.879003024953;4882.414110306786;4918.71279854862;4928.457869634337;4928.802847886044;5884.705764711747;5910.734016969247;5916.1421593868645;5926.555508336892;5962.850928726816;1452.7966084748143;1463.7338702022673;1464.1215270837413;1474.2849717886816;1481.8962672612813;927.3045216087934;952.9660318554307;955.861400096982;956.3687965942445;970.5341436110706;5081.466446023114;5115.514026167508;5137.948620513822;5150.227465880073;5167.560757335594;5376.596755243294;5405.621606487587;5432.375276843213;5486.037539728582;5519.806806761824;4966.850994470099;5006.3992320921725;5042.571381432546;5080.466551012164;5111.8722031948755;2846.1746093632614;2873.304750197394;2886.5958765772807;2895.044635270398;2917.897873574415;5564.27664403633;5650.66096034231;5658.547316214693;5704.144378343199;5710.628809127394;5377.865553361197;5385.623006389594;5475.863103422446;5488.259085023471;5565.9721701392045;5487.817066101651;5580.525655319262;5583.664980101207;5591.46881046308;5674.517665998436;5465.770201704744;5511.338639363302;5523.530499907552;5545.694986775766;5723.5707321950185;6090.695465226632;6106.3588323227195;6109.389061093855;6151.108089327112;6177.536684748752;6125.264968203844;6145.84635384119;6273.372662733873;6290.370962903673;6328.272248691459;4304.3543468479975;4324.200022995756;4361.738295702268;4362.1493808707;4369.38828563995;5958.19564358806;6243.96878015607;6246.968765156145;6248.531360148098;6253.312135664983;5939.10913362999;5965.194698715618;6007;6035.818925432244;6037.581168425504;5975.462208401264;5995.850103747267;6061.393860613904;6079.848003799941;6082.878342433038;5628.465295796893;5863;5909.881802364014;5929.555283353679;5932.7033648318275;6033.42682445167;6059.363766804422;6078;6083.361247068994;6108.328083910677;5521.917171242515;5842.474177324061;5866.325372582208;5890.528757699288;5906.881862362643 23:30:56 INFO - PROCESS | 6143 | |5;yui.html;571.2459553389525;582.2459914410838;687.2680595166148;782.4601025292549;803.5861531311376;14271.429142834288;14919.403223871032;15007.174605396713;15007.324670389831;15025.173615451145;14311.642208944782;14483.420663173487;14489.565313040599;14519.637009074779;14544.927275363634;775.6199462263493;796.6494742313392;797.3182928596054;798.480987358216;802.3541049455187;774.7133560582593;789.7591234673422;792.8176519400541;797.637075130817;800.9319207867338;820.4093053001859;822.1285437436306;831.3806214370303;832.5587438657491;832.8792325112855;823.320760372695;825.9132791056943;825.9710910118117;826.277007618334;826.8718348655968;604.1029071828375;604.4137186928716;604.4620287943734;605;606.3602898941615;13864;13866.584002479942;13910.51313204033;13925.094868833594;13941.233232172328;15295.388184472607;15356.769648455282;15399.538013859603;15474.22628868552;15524.844751552453;12353.567625133077;12472.875271247261;12797.232166070065;12846.357682115857;13458.932705336509;4005.7953637090504;4009.258287216845;4082.3672330788777;4083.734557253769;4176.979115104405;73766.63116684383;74056.62971685106;75013;75486.62256688737;75514;12025.158238923366;12141.210821296587;12215.877841221474;12343.259404435763;12423.130380873252;22868.4282892929;22948.196813111463;22974.540509190057;23039.539209215724;23321.533569328858;8566.443181193203;8818.691345802867;8883.511406872683;8954.552272386485;9146.86279705805;4751.121042607128;4797.712137271775;4814.698445471783;4848.369711937426;4941.48114447985;3532.7703699259464;3649.61679023704;3659.396199627032;3663.5420572428447;3669.3945498992903;573.5268403567073;589.1957478042527;591.1133300049925;595.2559300873908;597.1550256387163;615.2739767074805;624.4161708802285;693.0955103589763;764.2930289482207;765.6745882999703;9668.226541876633;9783.706488805346;10020.248481363928;10182.490875456346;10263.332883362558;701.7894631610496;713.3152173912998;720.4200618502156;733.8238822682517;738.3133685672269;4556;4682.321063445781;4724.456687480915;4744.3595114659765;4801.735904525215;109741.45129274462;116460.41769791266;118969;120207;120367.39816300862;62506;96119;97555;99003;100240.49879750554;58132.12801807976;75620;84194;85143.57428212943;86281.82309061351;8976.371653984159;8990.235829954265;8994.910050899669;9017;9053.502057386644;53503;54172.18741718798;54830.45169548254;55737.72131139319;55875.44124558865;50218.49781502138;64274.35725642871;67184.32815671976;67872;75105.6244718773;12980.350982450651;13152.935443610833;13202.933985330395;13263.469461221443;13532.797008045085;14953.252337383305;15060.246987650355;15367.923160384575;15392.18023602347;15529.84470155284;14228.497591452902;14350.210738409487;14588.124712517283;14823.777643335574;15331.846681533489;14122.293885305487;14584.562463126123;14608.123512589278;15201.543953681406;15203.163825989677;13542.255175965023;13547.25490098054;14040.326380794208;14584.635384115481;14760.926195368955;10974.286671366335;11041.503132358903;11330.206885518264;11366.772664546497;11487.5979340726;10428.53071611764;10706.464676766287;10839.945800271264;10965.122790176927;11228.719282017688 23:30:56 INFO - PROCESS | 6143 | __end_tp_report 23:30:56 INFO - PROCESS | 6143 | __start_cc_report 23:30:56 INFO - PROCESS | 6143 | _x_x_mozilla_cycle_collect,368 23:30:56 INFO - PROCESS | 6143 | __end_cc_report 23:30:56 INFO - PROCESS | 6143 | __startTimestamp1467786656246__endTimestamp 23:30:56 INFO - PROCESS | 6143 | 23:30:56 INFO - PROCESS | 6143 | ------- Summary: start ------- 23:30:56 INFO - PROCESS | 6143 | Number of tests: 6 23:30:56 INFO - PROCESS | 6143 | 23:30:56 INFO - PROCESS | 6143 | [#0] dojo.html Cycles:165 Average:5439.54 Median:5697.43 stddev:721.26 (12.7%) stddev-sans-first:699.76 23:30:56 INFO - PROCESS | 6143 | Values: 3101.5 3176.2 3193.8 3203.2 3225.3 5456.0 5523.1 5557.6 5570.2 5585.6 5417.3 5443.5 5452.9 5471.6 5566.6 4903.9 4931.0 5024.1 5030.2 5132.6 868.6 4976.3 5005.5 5037.6 5123.2 4931.3 4963.0 4964.7 4993.8 5012.2 4850.1 4986.8 4994.1 5014.1 5076.2 4925.1 4925.7 4935.8 4937.5 4958.4 5453.4 5477.4 5523.6 5541.2 5607.2 5787.4 5844.5 5935.8 5948.0 5953.9 5849.8 5922.3 5934.3 5939.0 5988.6 5489.9 5523.9 5524.1 5530.8 5530.9 5871.4 5960.2 5970.0 6000.3 6031.9 5848.7 5853.4 5855.2 5855.6 5882.2 5892.7 5908.7 5912.6 5915.9 5958.6 5710.3 5756.5 5816.4 5821.2 5867.8 5710.8 5801.5 5832.4 5860.2 5892.6 4456.5 4484.9 4491.8 4493.5 4502.5 3834.7 3924.9 3968.9 3989.5 4040.4 5567.3 5585.4 5591.3 5620.6 5637.7 5858.1 5874.5 5883.9 5892.2 5896.7 5515.6 5601.9 5626.7 5634.3 5634.8 5076.9 5083.2 5085.6 5101.4 5131.8 6044.4 6046.0 6097.0 6102.1 6107.6 5766.0 5827.7 5852.7 5918.4 5940.1 6073.5 6078.3 6079.7 6091.1 6115.1 5746.3 5796.7 5797.0 5811.2 5822.9 5694.0 5899.3 5912.9 5959.3 5964.4 5825.0 5837.2 5837.9 5843.7 5845.6 5782.0 5785.9 5801.4 5805.7 5807.9 5502.1 5554.7 5628.2 5655.9 5687.9 5704.5 5740.3 5754.9 5756.2 5759.3 5660.1 5662.7 5697.4 5704.1 5713.7 23:30:56 INFO - PROCESS | 6143 | 23:30:56 INFO - PROCESS | 6143 | [#1] ext.html Cycles:180 Average:52153.46 Median:40643.09 stddev:103869.65 (255.6%) stddev-sans-first:104088.81 23:30:56 INFO - PROCESS | 6143 | Values: 566.0 586.1 591.8 613.3 615.3 31040.1 41223.6 41430.6 41918.0 42038.6 43759.0 44212.0 44379.1 44397.3 44406.8 8892.0 9083.4 9111.1 9113.6 9125.4 8972.4 9012.1 9032.8 9048.2 9050.6 9062.2 9070.4 9114.7 9119.5 9122.2 8662.1 8675.3 8694.2 8719.6 8719.7 8760.2 8803.1 8805.4 8841.7 8848.3 41331.6 41655.4 41958.4 41991.6 42174.6 3349.3 3444.3 3512.4 3521.0 3618.4 30879.4 32135.7 33131.8 33145.2 33644.5 4398.7 4435.3 4436.4 4436.5 4561.9 355972.0 356981.0 358028.0 361883.0 362572.2 32952.7 34214.0 59847.1 60116.7 60124.7 35318.6 35430.3 35626.6 35859.3 35886.6 13904.7 13925.7 14096.8 14123.7 14177.6 12188.4 12191.8 12225.9 12254.3 12260.9 8152.0 8181.1 8185.8 8220.4 8251.9 2979.7 2990.1 2996.1 3018.0 3030.6 974.9 1002.0 1026.6 1036.5 1048.8 30762.4 30954.8 31596.5 31607.5 32125.5 1046.6 1049.2 1110.7 1132.5 1140.6 16376.9 16577.3 16728.7 16869.8 17045.8 530839.0 535005.0 536301.0 538055.0 539468.0 55966.2 56520.2 57054.4 57151.0 57215.4 1265.9 1323.9 1324.3 1324.5 1332.6 29838.0 31096.7 31174.2 31309.4 31549.4 48039.3 48233.0 48300.5 48509.3 48613.0 196276.0 196488.0 197220.0 197394.0 197664.0 27415.7 27481.9 27881.3 28037.0 28077.9 47220.8 47535.5 47838.5 48172.8 48225.0 40928.8 41723.4 41763.6 41855.8 42218.6 39650.0 40483.8 40771.2 40866.0 41135.8 40461.8 40515.0 41742.6 41911.2 44027.0 32708.0 36448.3 36894.3 36941.4 37310.0 27457.0 28262.9 28294.9 28512.9 28619.9 23:30:56 INFO - PROCESS | 6143 | 23:30:56 INFO - PROCESS | 6143 | [#2] jquery.html Cycles:180 Average:27672.38 Median:2342.15 stddev:74001.34 (3159.5%) stddev-sans-first:74180.56 23:30:56 INFO - PROCESS | 6143 | Values: 380.0 385.2 385.6 391.8 412.8 15257.5 19001.0 19822.5 20729.5 20750.7 18302.6 18709.7 19502.8 19533.2 19656.2 5530.8 5922.3 6228.2 6239.1 6359.0 5340.6 5591.1 5625.8 6359.5 6376.6 5655.3 5662.7 5699.9 5729.2 5920.8 6231.3 6282.1 6364.6 6389.3 6430.8 5750.9 5860.9 5866.9 5901.0 5904.1 11652.8 11735.6 11974.9 13198.2 13201.1 2249.2 2296.9 2319.0 2365.3 2382.8 9777.3 10124.9 10132.5 12170.5 14056.1 1777.6 1800.5 1914.7 1944.2 1985.5 78063.0 78738.6 79353.0 82347.2 82385.0 10574.3 10964.0 11045.3 11217.0 11232.7 11544.2 12199.0 12217.1 15135.9 15444.5 5942.8 6071.0 6955.8 7928.9 8033.5 7877.6 7935.7 7957.3 7961.5 8051.0 4010.4 4035.4 4048.5 4141.2 4183.9 2013.1 2035.4 2048.9 2055.0 2056.5 913.4 970.7 1011.5 1031.4 1087.3 18658.5 19498.3 19507.3 19525.0 19628.7 975.2 986.5 1009.5 1019.2 1025.3 10700.0 11072.2 11093.2 11101.7 11107.2 416173.0 420451.0 448421.0 465044.0 471229.0 100957.0 101610.0 102057.0 103305.0 104518.5 943.4 962.5 971.6 981.1 989.4 15316.9 17276.6 17325.0 17449.8 17457.6 41003.6 41082.6 41870.8 43266.4 43818.8 58308.7 60883.7 62402.0 62506.7 64013.0 8558.1 8672.8 8863.4 8952.2 9037.8 12200.5 12833.0 12850.0 13052.9 13112.7 10967.9 11088.7 11316.9 11373.0 11463.5 10826.6 10858.9 10978.8 11109.5 11378.0 5945.0 11039.1 11191.7 11298.8 11512.7 8700.3 8730.5 8741.5 8979.5 9154.3 8332.4 10385.8 10938.7 11063.2 11693.6 23:30:56 INFO - PROCESS | 6143 | 23:30:56 INFO - PROCESS | 6143 | [#3] mootools.html Cycles:180 Average:5857.12 Median:4428.78 stddev:3405.22 (76.9%) stddev-sans-first:3398.55 23:30:56 INFO - PROCESS | 6143 | Values: 1433.9 1482.1 1577.2 1709.5 1718.8 7833.3 8428.2 8598.1 9149.8 9160.2 8851.7 8865.7 8996.5 8998.2 9009.8 2259.8 2295.2 2299.7 2300.7 2309.8 2264.8 2276.1 2283.1 2306.4 2320.6 2160.4 2178.5 2242.4 2281.0 2288.7 2225.1 2225.6 2233.5 2235.4 2247.1 2214.3 2225.3 2236.7 2239.9 2243.6 9097.1 9138.6 9149.0 9154.5 9155.3 4987.5 5077.3 5132.1 5178.5 5185.0 3208.4 3269.0 3381.7 3390.2 3407.8 1143.7 1176.0 1200.6 1204.3 1233.5 12392.3 12432.9 12475.7 12487.2 12538.7 4284.9 4495.8 4497.8 4560.0 4575.8 10464.4 10496.4 10555.8 10568.7 10569.4 5129.9 5147.5 5150.8 5158.1 5188.1 4191.9 4701.2 4778.8 4780.5 4879.5 3921.0 3953.8 4016.8 4072.2 4110.3 1239.2 1240.7 1244.6 1249.5 1251.1 995.2 1002.9 1007.7 1009.3 1014.6 6203.3 6253.7 6308.8 6336.0 6367.0 440.6 441.6 461.1 462.3 463.6 4279.9 4422.9 4427.9 4429.6 4532.5 10932.4 11317.5 11403.2 11417.7 11422.9 10478.8 10917.3 10988.3 11179.8 11317.4 8304.7 8370.2 8380.7 8422.1 8459.0 6261.4 6299.3 6331.2 6456.2 6501.9 10241.9 10313.4 10352.4 10475.6 10479.2 10605.1 10704.9 10732.8 10740.8 10742.9 7163.9 7854.7 7950.9 8203.4 8497.2 8239.8 8391.5 8431.1 8436.2 8455.0 7460.2 7744.2 7784.5 7792.3 7813.0 7498.6 7530.5 7534.9 7545.8 7710.4 6855.6 6865.8 6906.7 6907.7 6917.4 5049.8 5179.6 5281.5 5304.7 5305.5 4958.3 4989.9 5011.7 5162.5 5256.7 23:30:56 INFO - PROCESS | 6143 | 23:30:56 INFO - PROCESS | 6143 | [#4] prototype.html Cycles:180 Average:4849.56 Median:5488.04 stddev:1439.66 (26.2%) stddev-sans-first:1402.76 23:30:56 INFO - PROCESS | 6143 | Values: 308.0 317.0 322.4 323.2 332.4 5105.5 5593.3 5751.0 5779.6 5803.4 5553.4 5553.8 5564.6 5592.9 5595.7 4341.2 4362.8 4410.5 4433.3 4435.6 4119.4 4356.7 4423.9 4424.5 4430.6 4268.8 4304.4 4307.5 4313.4 4318.2 4330.5 4382.2 4383.9 4387.5 4415.7 3766.5 3846.9 3849.3 3863.6 3871.0 5473.9 5495.7 5517.2 5538.2 5540.1 4941.2 4948.8 5010.9 5017.3 5021.5 5759.3 5888.4 5898.7 5916.3 5990.5 4166.4 4174.1 4174.4 4183.9 4191.9 5986.9 6151.2 6198.2 6204.6 6234.5 4170.6 4182.3 4196.8 4206.1 4208.4 4203.4 4238.6 4251.2 4255.2 4266.0 4839.9 4882.4 4918.7 4928.5 4928.8 5884.7 5910.7 5916.1 5926.6 5962.9 1452.8 1463.7 1464.1 1474.3 1481.9 927.3 953.0 955.9 956.4 970.5 5081.5 5115.5 5137.9 5150.2 5167.6 5376.6 5405.6 5432.4 5486.0 5519.8 4966.9 5006.4 5042.6 5080.5 5111.9 2846.2 2873.3 2886.6 2895.0 2917.9 5564.3 5650.7 5658.5 5704.1 5710.6 5377.9 5385.6 5475.9 5488.3 5566.0 5487.8 5580.5 5583.7 5591.5 5674.5 5465.8 5511.3 5523.5 5545.7 5723.6 6090.7 6106.4 6109.4 6151.1 6177.5 6125.3 6145.8 6273.4 6290.4 6328.3 4304.4 4324.2 4361.7 4362.1 4369.4 5958.2 6244.0 6247.0 6248.5 6253.3 5939.1 5965.2 6007.0 6035.8 6037.6 5975.5 5995.9 6061.4 6079.8 6082.9 5628.5 5863.0 5909.9 5929.6 5932.7 6033.4 6059.4 6078.0 6083.4 6108.3 5521.9 5842.5 5866.3 5890.5 5906.9 23:30:56 INFO - PROCESS | 6143 | 23:30:56 INFO - PROCESS | 6143 | [#5] yui.html Cycles:180 Average:20361.21 Median:4703.39 stddev:28803.26 (612.4%) stddev-sans-first:28845.73 23:30:56 INFO - PROCESS | 6143 | Values: 571.2 582.2 687.3 782.5 803.6 14271.4 14919.4 15007.2 15007.3 15025.2 14311.6 14483.4 14489.6 14519.6 14544.9 775.6 796.6 797.3 798.5 802.4 774.7 789.8 792.8 797.6 800.9 820.4 822.1 831.4 832.6 832.9 823.3 825.9 826.0 826.3 826.9 604.1 604.4 604.5 605.0 606.4 13864.0 13866.6 13910.5 13925.1 13941.2 15295.4 15356.8 15399.5 15474.2 15524.8 12353.6 12472.9 12797.2 12846.4 13458.9 4005.8 4009.3 4082.4 4083.7 4177.0 73766.6 74056.6 75013.0 75486.6 75514.0 12025.2 12141.2 12215.9 12343.3 12423.1 22868.4 22948.2 22974.5 23039.5 23321.5 8566.4 8818.7 8883.5 8954.6 9146.9 4751.1 4797.7 4814.7 4848.4 4941.5 3532.8 3649.6 3659.4 3663.5 3669.4 573.5 589.2 591.1 595.3 597.2 615.3 624.4 693.1 764.3 765.7 9668.2 9783.7 10020.2 10182.5 10263.3 701.8 713.3 720.4 733.8 738.3 4556.0 4682.3 4724.5 4744.4 4801.7 109741.5 116460.4 118969.0 120207.0 120367.4 62506.0 96119.0 97555.0 99003.0 100240.5 58132.1 75620.0 84194.0 85143.6 86281.8 8976.4 8990.2 8994.9 9017.0 9053.5 53503.0 54172.2 54830.5 55737.7 55875.4 50218.5 64274.4 67184.3 67872.0 75105.6 12980.4 13152.9 13202.9 13263.5 13532.8 14953.3 15060.2 15367.9 15392.2 15529.8 14228.5 14350.2 14588.1 14823.8 15331.8 14122.3 14584.6 14608.1 15201.5 15203.2 13542.3 13547.3 14040.3 14584.6 14760.9 10974.3 11041.5 11330.2 11366.8 11487.6 10428.5 10706.5 10839.9 10965.1 11228.7 23:30:56 INFO - PROCESS | 6143 | -------- Summary: end -------- 23:30:56 INFO - PROCESS | 6143 | 23:30:57 INFO - TEST-INFO | 6143: exit 0 23:30:57 INFO - TEST-OK | dromaeo_css | took 1111652ms 23:30:57 INFO - TEST-START | kraken 23:30:57 INFO - operating with platform_type : linux_ 23:30:57 INFO - Initialising browser for kraken test... 23:30:57 INFO - TEST-INFO | started process 6391 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsLc2BK/profile http://localhost:51713/getInfo.html) 23:31:01 INFO - PROCESS | 6391 | __metrics Screen width/height:1600/1200 23:31:01 INFO - PROCESS | 6391 | colorDepth:24 23:31:01 INFO - PROCESS | 6391 | Browser inner width/height: 1024/697 23:31:01 INFO - PROCESS | 6391 | __metrics 23:31:02 ERROR - PROCESS | 6391 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2952: TypeError: this.tabs is undefined 23:31:03 INFO - TEST-INFO | 6391: exit 0 23:31:03 INFO - Browser initialized. 23:31:03 INFO - Running cycle 1/1 for kraken test... 23:31:03 INFO - TEST-INFO | started process 6512 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsLc2BK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:31:15 INFO - PROCESS | 6512 | RSS: Main: 168800256 23:31:15 INFO - PROCESS | 6512 | 23:31:17 INFO - PROCESS | 6512 | Cycle 1(1): loaded http://localhost:51713/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51713/tests/kraken/driver.html?testName=audio-beat-detection) 23:31:18 INFO - PROCESS | 6512 | RSS: Main: 174084096 23:31:18 INFO - PROCESS | 6512 | 23:31:21 INFO - PROCESS | 6512 | Cycle 1(1): loaded http://localhost:51713/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51713/tests/kraken/driver.html?testName=audio-dft) 23:31:21 INFO - PROCESS | 6512 | RSS: Main: 173285376 23:31:21 INFO - PROCESS | 6512 | 23:31:24 INFO - PROCESS | 6512 | Cycle 1(1): loaded http://localhost:51713/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51713/tests/kraken/driver.html?testName=audio-fft) 23:31:25 INFO - PROCESS | 6512 | RSS: Main: 167968768 23:31:25 INFO - PROCESS | 6512 | 23:31:27 INFO - PROCESS | 6512 | Cycle 1(1): loaded http://localhost:51713/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51713/tests/kraken/driver.html?testName=audio-oscillator) 23:31:27 INFO - PROCESS | 6512 | RSS: Main: 168673280 23:31:27 INFO - PROCESS | 6512 | 23:31:30 INFO - PROCESS | 6512 | Cycle 1(1): loaded http://localhost:51713/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51713/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:31:30 INFO - PROCESS | 6512 | RSS: Main: 168882176 23:31:30 INFO - PROCESS | 6512 | 23:31:33 INFO - PROCESS | 6512 | Cycle 1(1): loaded http://localhost:51713/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51713/tests/kraken/driver.html?testName=imaging-darkroom) 23:31:34 INFO - PROCESS | 6512 | RSS: Main: 169086976 23:31:34 INFO - PROCESS | 6512 | 23:31:37 INFO - PROCESS | 6512 | Cycle 1(1): loaded http://localhost:51713/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51713/tests/kraken/driver.html?testName=imaging-desaturate) 23:31:38 INFO - PROCESS | 6512 | RSS: Main: 169914368 23:31:38 INFO - PROCESS | 6512 | 23:31:41 INFO - PROCESS | 6512 | Cycle 1(1): loaded http://localhost:51713/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51713/tests/kraken/driver.html?testName=json-parse-financial) 23:31:42 INFO - PROCESS | 6512 | RSS: Main: 169705472 23:31:42 INFO - PROCESS | 6512 | 23:31:43 INFO - PROCESS | 6512 | Cycle 1(1): loaded http://localhost:51713/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51713/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:31:44 INFO - PROCESS | 6512 | RSS: Main: 169340928 23:31:44 INFO - PROCESS | 6512 | 23:31:45 INFO - PROCESS | 6512 | Cycle 1(1): loaded http://localhost:51713/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51713/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:31:46 INFO - PROCESS | 6512 | RSS: Main: 170057728 23:31:46 INFO - PROCESS | 6512 | 23:31:48 INFO - PROCESS | 6512 | Cycle 1(1): loaded http://localhost:51713/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51713/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:31:49 INFO - PROCESS | 6512 | RSS: Main: 170106880 23:31:49 INFO - PROCESS | 6512 | 23:31:51 INFO - PROCESS | 6512 | Cycle 1(1): loaded http://localhost:51713/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51713/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:31:52 INFO - PROCESS | 6512 | RSS: Main: 170770432 23:31:52 INFO - PROCESS | 6512 | 23:31:55 INFO - PROCESS | 6512 | Cycle 1(1): loaded http://localhost:51713/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51713/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:31:55 INFO - PROCESS | 6512 | RSS: Main: 170196992 23:31:55 INFO - PROCESS | 6512 | 23:31:57 INFO - PROCESS | 6512 | Cycle 1(1): loaded http://localhost:51713/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51713/tests/kraken/driver.html?testName=ai-astar) 23:31:57 INFO - PROCESS | 6512 | RSS: Main: 171413504 23:31:57 INFO - PROCESS | 6512 | 23:31:57 INFO - PROCESS | 6512 | __start_tp_report 23:31:57 INFO - PROCESS | 6512 | _x_x_mozilla_page_load 23:31:57 INFO - PROCESS | 6512 | _x_x_mozilla_page_load_details 23:31:57 INFO - PROCESS | 6512 | |i|pagename|runs| 23:31:57 INFO - PROCESS | 6512 | |0;ai-astar;103;111;106;111;111;113;111;112;110;111 23:31:57 INFO - PROCESS | 6512 | |1;audio-beat-detection;150;117;145;168;118;156;146;118;178;117 23:31:57 INFO - PROCESS | 6512 | |2;audio-dft;163;162;161;161;162;164;168;165;162;164 23:31:57 INFO - PROCESS | 6512 | |3;audio-fft;78;76;75;149;77;78;77;75;178;76 23:31:57 INFO - PROCESS | 6512 | |4;audio-oscillator;85;83;151;85;84;83;131;85;84;164 23:31:57 INFO - PROCESS | 6512 | |5;imaging-gaussian-blur;118;118;117;117;118;118;118;117;117;118 23:31:57 INFO - PROCESS | 6512 | |6;imaging-darkroom;148;148;147;147;148;147;146;147;147;147 23:31:57 INFO - PROCESS | 6512 | |7;imaging-desaturate;95;97;95;96;96;96;96;96;95;96 23:31:57 INFO - PROCESS | 6512 | |8;json-parse-financial;54;54;55;53;55;55;54;54;55;55 23:31:57 INFO - PROCESS | 6512 | |9;json-stringify-tinderbox;62;62;62;62;62;61;61;62;62;62 23:31:57 INFO - PROCESS | 6512 | |10;stanford-crypto-aes;76;77;77;74;77;76;78;85;76;75 23:31:57 INFO - PROCESS | 6512 | |11;stanford-crypto-ccm;119;118;130;139;132;130;126;132;163;146 23:31:57 INFO - PROCESS | 6512 | |12;stanford-crypto-pbkdf2;161;171;157;165;159;161;157;159;162;160 23:31:57 INFO - PROCESS | 6512 | |13;stanford-crypto-sha256-iterative;64;66;64;63;63;65;68;64;64;69 23:31:57 INFO - PROCESS | 6512 | __end_tp_report 23:31:57 INFO - PROCESS | 6512 | __start_cc_report 23:31:57 INFO - PROCESS | 6512 | _x_x_mozilla_cycle_collect,924 23:31:57 INFO - PROCESS | 6512 | __end_cc_report 23:31:57 INFO - PROCESS | 6512 | __startTimestamp1467786717795__endTimestamp 23:31:57 INFO - PROCESS | 6512 | 23:31:57 INFO - PROCESS | 6512 | ------- Summary: start ------- 23:31:57 INFO - PROCESS | 6512 | Number of tests: 14 23:31:57 INFO - PROCESS | 6512 | 23:31:57 INFO - PROCESS | 6512 | [#0] ai-astar Cycles:10 Average:109.90 Median:111.00 stddev:3.03 (2.7%) stddev-sans-first:1.94 23:31:57 INFO - PROCESS | 6512 | Values: 103.0 111.0 106.0 111.0 111.0 113.0 111.0 112.0 110.0 111.0 23:31:57 INFO - PROCESS | 6512 | 23:31:57 INFO - PROCESS | 6512 | [#1] audio-beat-detection Cycles:10 Average:141.30 Median:148.00 stddev:22.74 (15.4%) stddev-sans-first:23.90 23:31:57 INFO - PROCESS | 6512 | Values: 150.0 117.0 145.0 168.0 118.0 156.0 146.0 118.0 178.0 117.0 23:31:57 INFO - PROCESS | 6512 | 23:31:57 INFO - PROCESS | 6512 | [#2] audio-dft Cycles:10 Average:163.20 Median:163.50 stddev:2.15 (1.3%) stddev-sans-first:2.28 23:31:57 INFO - PROCESS | 6512 | Values: 163.0 162.0 161.0 161.0 162.0 164.0 168.0 165.0 162.0 164.0 23:31:57 INFO - PROCESS | 6512 | 23:31:57 INFO - PROCESS | 6512 | [#3] audio-fft Cycles:10 Average:93.90 Median:76.50 stddev:37.33 (48.8%) stddev-sans-first:39.15 23:31:57 INFO - PROCESS | 6512 | Values: 78.0 76.0 75.0 149.0 77.0 78.0 77.0 75.0 178.0 76.0 23:31:57 INFO - PROCESS | 6512 | 23:31:57 INFO - PROCESS | 6512 | [#4] audio-oscillator Cycles:10 Average:103.50 Median:84.00 stddev:32.15 (38.3%) stddev-sans-first:33.39 23:31:57 INFO - PROCESS | 6512 | Values: 85.0 83.0 151.0 85.0 84.0 83.0 131.0 85.0 84.0 164.0 23:31:57 INFO - PROCESS | 6512 | 23:31:57 INFO - PROCESS | 6512 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 23:31:57 INFO - PROCESS | 6512 | Values: 118.0 118.0 117.0 117.0 118.0 118.0 118.0 117.0 117.0 118.0 23:31:57 INFO - PROCESS | 6512 | 23:31:57 INFO - PROCESS | 6512 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.00 stddev:0.63 (0.4%) stddev-sans-first:0.60 23:31:57 INFO - PROCESS | 6512 | Values: 148.0 148.0 147.0 147.0 148.0 147.0 146.0 147.0 147.0 147.0 23:31:57 INFO - PROCESS | 6512 | 23:31:57 INFO - PROCESS | 6512 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.60 23:31:57 INFO - PROCESS | 6512 | Values: 95.0 97.0 95.0 96.0 96.0 96.0 96.0 96.0 95.0 96.0 23:31:57 INFO - PROCESS | 6512 | 23:31:57 INFO - PROCESS | 6512 | [#8] json-parse-financial Cycles:10 Average:54.40 Median:55.00 stddev:0.70 (1.3%) stddev-sans-first:0.73 23:31:57 INFO - PROCESS | 6512 | Values: 54.0 54.0 55.0 53.0 55.0 55.0 54.0 54.0 55.0 55.0 23:31:57 INFO - PROCESS | 6512 | 23:31:57 INFO - PROCESS | 6512 | [#9] json-stringify-tinderbox Cycles:10 Average:61.80 Median:62.00 stddev:0.42 (0.7%) stddev-sans-first:0.44 23:31:57 INFO - PROCESS | 6512 | Values: 62.0 62.0 62.0 62.0 62.0 61.0 61.0 62.0 62.0 62.0 23:31:57 INFO - PROCESS | 6512 | 23:31:57 INFO - PROCESS | 6512 | [#10] stanford-crypto-aes Cycles:10 Average:77.10 Median:77.00 stddev:3.00 (3.9%) stddev-sans-first:3.15 23:31:57 INFO - PROCESS | 6512 | Values: 76.0 77.0 77.0 74.0 77.0 76.0 78.0 85.0 76.0 75.0 23:31:57 INFO - PROCESS | 6512 | 23:31:57 INFO - PROCESS | 6512 | [#11] stanford-crypto-ccm Cycles:10 Average:133.50 Median:132.00 stddev:13.30 (10.1%) stddev-sans-first:13.03 23:31:57 INFO - PROCESS | 6512 | Values: 119.0 118.0 130.0 139.0 132.0 130.0 126.0 132.0 163.0 146.0 23:31:57 INFO - PROCESS | 6512 | 23:31:57 INFO - PROCESS | 6512 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.20 Median:161.00 stddev:4.18 (2.6%) stddev-sans-first:4.44 23:31:57 INFO - PROCESS | 6512 | Values: 161.0 171.0 157.0 165.0 159.0 161.0 157.0 159.0 162.0 160.0 23:31:57 INFO - PROCESS | 6512 | 23:31:57 INFO - PROCESS | 6512 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.00 Median:64.50 stddev:2.05 (3.2%) stddev-sans-first:2.15 23:31:57 INFO - PROCESS | 6512 | Values: 64.0 66.0 64.0 63.0 63.0 65.0 68.0 64.0 64.0 69.0 23:31:57 INFO - PROCESS | 6512 | -------- Summary: end -------- 23:31:57 INFO - PROCESS | 6512 | 23:31:58 INFO - TEST-INFO | 6512: exit 0 23:31:58 INFO - TEST-OK | kraken | took 61716ms 23:31:58 INFO - SUITE-END | took 1173s 23:31:58 INFO - Completed test suite (00:19:33) 23:31:58 INFO - javascript benchmark 23:31:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7145.7825427248745, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3101.4572449821285, 3176.1900715317593, 3193.776435649504, 3203.19920019995, 3225.32268223673, 5456.017916774974, 5523.116301391773, 5557.555395568355, 5570.220169176314, 5585.5810814189, 5417.295751552293, 5443.482869127436, 5452.945470545294, 5471.5896307776875, 5566.55467562595, 4903.852884413464, 4930.975345123269, 5024.120778863702, 5030.195168772997, 5132.589392848582, 868.5805436252205, 4976.253561965698, 5005.5244751748705, 5037.647364684473, 5123.231515272721, 4931.26031095335, 4962.950370496303, 4964.67729597575, 4993.75031248438, 5012.172991456406, 4850.126977144113, 4986.750662466862, 4994.051130285234, 5014.07239660664, 5076.213186956028, 4925.13810083234, 4925.704457732511, 4935.827246046371, 4937.481564435719, 4958.429780575244, 5453.400125986138, 5477.397486276506, 5523.558115350762, 5541.22878934684, 5607.186957891083, 5787.3923238059815, 5844.532437404998, 5935.821925342247, 5947.970260148715, 5953.910691339634, 5849.7660093596205, 5922.2597175353085, 5934.347221805598, 5939.049752039653, 5988.550858685616, 5489.917651235235, 5523.917141242885, 5524.06090964537, 5530.751116199781, 5530.944690553083, 5871.3541510433815, 5960.225170727777, 5970.0, 6000.309964354068, 6031.939680603138, 5848.707564621837, 5853.443922827325, 5855.238818953509, 5855.619384739978, 5882.176495290662, 5892.734826932799, 5908.734106965197, 5912.556558258148, 5915.940840591625, 5958.582899197015, 5710.2862142232225, 5756.481916627524, 5816.447437493432, 5821.2141360916585, 5867.765289388462, 5710.8001219957105, 5801.506871915934, 5832.445917637902, 5860.208871802337, 5892.587518873637, 4456.509783923766, 4484.910301793946, 4491.842785502492, 4493.460784705856, 4502.527234640315, 3834.731568790158, 3924.8617900809018, 3968.8809335719975, 3989.501312335958, 4040.3939409088284, 5567.331920169525, 5585.441455854463, 5591.30108736408, 5620.57845661577, 5637.68992705397, 5858.121281807677, 5874.471297583238, 5883.941160588425, 5892.175095486636, 5896.6756828374855, 5515.61390702655, 5601.8599535011135, 5626.718664066781, 5634.32388113429, 5634.802781902614, 5076.898462030738, 5083.2375143727995, 5085.593152547787, 5101.362329708786, 5131.820386286462, 6044.425779551024, 6045.969770151209, 6096.963516202256, 6102.0541816018585, 6107.603005804608, 5766.0, 5827.737751801094, 5852.707364631837, 5918.378570250148, 5940.108983652487, 6073.453389194994, 6078.331383547717, 6079.726412311368, 6091.086337049478, 6115.052166914135, 5746.339170995389, 5796.681182535001, 5797.043487824461, 5811.157382179645, 5822.912656310244, 5693.9715301424885, 5899.292084949833, 5912.881742365043, 5959.344472108151, 5964.433378829004, 5825.0, 5837.182794408871, 5837.912431313449, 5843.707814609337, 5845.590808643354, 5781.971090144522, 5785.942140578541, 5801.3908539602735, 5805.651660900359, 5807.854803629774, 5502.064649009598, 5554.666719996813, 5628.240187574625, 5655.915161272666, 5687.914681279867, 5704.515116215168, 5740.253767010429, 5754.8849023018465, 5756.1941328214925, 5759.280089988752, 5660.094384898396, 5662.66024038559, 5697.4302569742695, 5704.087346024616, 5713.742881570256], "value": 5392.192823528459, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [566.0179588414101, 586.1032620091261, 591.801746414951, 613.2732711736593, 615.3200713211902, 31040.06879793607, 41223.58776412235, 41430.58569414305, 41918.0, 42038.579614203845, 43759.0, 44212.0, 44379.112417751625, 44397.33403998943, 44406.77796611012, 8891.95554022229, 9083.409578377417, 9111.13444222801, 9113.589888455002, 9125.406848554856, 8972.416792908472, 9012.098790120968, 9032.819343613124, 9048.230900373475, 9050.592723327432, 9062.229710474618, 9070.410423322495, 9114.680986165486, 9119.544022798867, 9122.22461090808, 8662.090480499552, 8675.349348798834, 8694.21752042316, 8719.564021798884, 8719.738407847712, 8760.167784060504, 8803.075677053945, 8805.42764720291, 8841.734747957571, 8848.292136629054, 41331.58668413307, 41655.375169372484, 41958.37062444066, 41991.58008419907, 42174.57825421737, 3349.346877358916, 3444.345574340867, 3512.4204506256438, 3520.9823950880336, 3618.384874571303, 30879.382412351628, 32135.6786432135, 33131.83434082814, 33145.17137071568, 33644.49533257003, 4398.670099742532, 4435.334699795024, 4436.378906953029, 4436.511983681792, 4561.863144105682, 355972.0, 356981.0, 358028.0, 361883.0, 362572.18713906524, 32952.67047329496, 34214.0, 59847.102293465636, 60116.69941650264, 60124.69937650284, 35318.644728750725, 35430.291394171974, 35626.643733562334, 35859.282814344086, 35886.641133588855, 13904.721905561832, 13925.651858703613, 14096.788548171786, 14123.71752564943, 14177.645558861112, 12188.390580470941, 12191.756164876653, 12225.877741222474, 12254.326012069421, 12260.877391225973, 8151.959240203761, 8181.140980196994, 8185.79535511617, 8220.38347123968, 8251.917480825236, 2979.657339405996, 2990.088023152959, 2996.1011696490964, 3017.969820301769, 3030.5605687175234, 974.8537719342155, 1001.9549120289458, 1026.5893642543042, 1036.5180191211123, 1048.799557771137, 30762.384752304828, 30954.845225773726, 31596.526052109235, 31607.52588711171, 32125.51811722826, 1046.576136664652, 1049.1606714628267, 1110.6667999600088, 1132.5016992523263, 1140.623594213924, 16376.918115409348, 16577.336906523844, 16728.749068763977, 16869.831301686827, 17045.829541704425, 530839.0, 535005.0, 536301.0, 538055.0, 539468.0, 55966.160507592416, 56520.15219771707, 57054.429455705744, 57151.0, 57215.427845721846, 1265.8923991460645, 1323.8940884729197, 1324.3248637751688, 1324.543032653733, 1332.6135420728074, 29838.017913781958, 31096.689033110284, 31174.22064448407, 31309.373812524078, 31549.369012620078, 48039.27941080956, 48233.0, 48300.5169948296, 48509.27236091532, 48613.0, 196276.0, 196488.0, 197220.0, 197394.0, 197664.0, 27415.725842741318, 27481.86259068692, 27881.302967425978, 28037.0, 28077.859610701817, 47220.7638961803, 47535.52464475311, 47838.5216147848, 48172.759136205495, 48225.0, 40928.828954445045, 41723.37414938839, 41763.58236417597, 41855.7907210462, 42218.57781422146, 39650.0, 40483.79758101191, 40771.1845763089, 40866.0, 41135.7943210282, 40461.79769101136, 40515.0, 41742.58257417508, 41911.1617767649, 44027.0, 32708.0, 36448.27103457969, 36894.26211475702, 36941.44587831131, 37310.0, 27457.0, 28262.85868570644, 28294.85852570724, 28512.85743571269, 28619.856900715364], "value": 18182.23774888005, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [380.0403979950626, 385.15270286002556, 385.62209035145565, 391.8491380818385, 412.8224863308776, 15257.465988690397, 19001.0, 19822.504437389038, 20729.481762955933, 20750.688739668916, 18302.633947321046, 18709.719354209697, 19502.80497195031, 19533.21867125317, 19656.21375144996, 5530.778768849241, 5922.3485416604135, 6228.22147231596, 6239.095331176999, 6359.046143078529, 5340.572754179656, 5591.077472217079, 5625.774969001235, 6359.491240700733, 6376.585521941082, 5655.293088363955, 5662.716864156796, 5699.943000569982, 5729.169270455803, 5920.792772252972, 6231.252249730039, 6282.120503129519, 6364.586301890362, 6389.265234498046, 6430.839229019265, 5750.942490575083, 5860.853478663025, 5866.941330586682, 5901.02633065548, 5904.055351143839, 11652.766944661143, 11735.589254376056, 11974.880251197465, 13198.20810751358, 13201.075924685276, 2249.212775528552, 2296.9425764355856, 2319.0, 2365.302235840414, 2382.797462215696, 9777.31558790885, 10124.89875101247, 10132.54403551842, 12170.513179472811, 14056.086354386933, 1777.6089260362698, 1800.4958611588777, 1914.7032210007471, 1944.2028768204968, 1985.4540001499558, 78063.0, 78738.60630696866, 79353.0, 82347.17652823516, 82385.0, 10574.255247884166, 10964.0, 11045.28205666629, 11217.0, 11232.66302010941, 11544.19190656646, 12199.0, 12217.083718720954, 15135.924320378328, 15444.45944391941, 5942.762289508458, 6070.969645151746, 6955.756548520778, 7928.8810667840025, 8033.517988920684, 7877.565782628674, 7935.682572697143, 7957.283844453911, 7961.522308661383, 8050.959745201237, 4010.438538604598, 4035.414864844581, 4048.4939382577177, 4141.1571850526225, 4183.937240941327, 2013.104168644939, 2035.4199053269747, 2048.9077991490417, 2054.979450205509, 2056.5372791122177, 913.4427998920653, 970.6893793985856, 1011.4790882695418, 1031.4327120083924, 1087.2986923434341, 18658.53353666142, 19498.31755888537, 19507.317243896396, 19525.0, 19628.70556941647, 975.1954637424153, 986.5166068626321, 1009.5406590001531, 1019.2050200843354, 1025.3284098915221, 10700.0, 11072.224944253825, 11093.168012399103, 11101.666949991513, 11107.222494425312, 416173.0, 420451.0, 448421.0, 465044.0, 471229.0, 100957.0, 101610.0, 102057.0, 103305.0, 104518.47740761247, 943.3867985809142, 962.5476026267643, 971.6404930175739, 981.097390400833, 989.3766926835904, 15316.923415382851, 17276.568085797957, 17325.0, 17449.82550174482, 17457.56356091108, 41003.58996409998, 41082.589174107874, 41870.790646046575, 43266.35100473558, 43818.780906095264, 58308.70845645745, 60883.69558152181, 62402.0, 62506.687466562376, 64013.0, 8558.144185581392, 8672.826543469222, 8863.423877447945, 8952.23905968, 9037.77405564866, 12200.450979705756, 12833.0, 12850.0, 13052.869471305165, 13112.672183195496, 10967.890321096687, 11088.722781930193, 11316.94341528287, 11373.0, 11463.541458341573, 10826.56693732242, 10858.891411085788, 10978.780424391307, 11109.50007249692, 11378.0, 5945.0, 11039.116870650168, 11191.72020699489, 11298.774024519627, 11512.712182195512, 8700.303975682056, 8730.476171429735, 8741.519216442903, 8979.46123232608, 9154.313426492907, 8332.375071869512, 10385.844212336971, 10938.671839844817, 11063.170262230204, 11693.649190524298], "value": 8969.805785144921, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1433.9211343376114, 1482.1033274868703, 1577.164103025397, 1709.5469700529354, 1718.7679663245458, 7833.255840695125, 8428.241458268754, 8598.05421403645, 9149.817003659922, 9160.221381182599, 8851.734447966555, 8865.689700860472, 8996.505192214425, 8998.23515001224, 9009.774755631113, 2259.8418110732255, 2295.231097582312, 2299.666548350488, 2300.7354154272307, 2309.7574754650773, 2264.7961683448484, 2276.146445083094, 2283.063943783049, 2306.3542208181652, 2320.640300753386, 2160.362693005567, 2178.5425060737184, 2242.416971587391, 2281.0, 2288.7367952685486, 2225.054351900444, 2225.554889022194, 2233.4974630708043, 2235.362921567362, 2247.1460844879007, 2214.3467677035314, 2225.343523660524, 2236.7092278003756, 2239.944001399962, 2243.6298010828195, 9097.090290970917, 9138.588763505591, 9149.039350868195, 9154.542272886329, 9155.267578593697, 4987.526185012418, 5077.2637967494875, 5132.050570644443, 5178.533931946143, 5185.0, 3208.374366998436, 3269.0, 3381.712554432876, 3390.2371966307383, 3407.829608519589, 1143.74837535742, 1175.9529618815236, 1200.5977997370892, 1204.3436327201696, 1233.5189276182207, 12392.31842248676, 12432.937835310857, 12475.688107797287, 12487.188332758433, 12538.68653283666, 4284.892877678083, 4495.775211239425, 4497.797599108048, 4560.0, 4575.81696732127, 10464.424456654957, 10496.422696751599, 10555.788884222273, 10568.735781605521, 10569.418681972411, 5129.897402051938, 5147.485251474823, 5150.845474635767, 5158.071547121554, 5188.11801993662, 4191.8532851350055, 4701.224297990793, 4778.761061946958, 4780.4741478437345, 4879.536444037811, 3920.980395098063, 3953.7627742335553, 4016.779077150726, 4072.2466343726505, 4110.321796903538, 1239.2254840724547, 1240.7084335181225, 1244.6390546741525, 1249.5314257153568, 1251.1429670675616, 995.2038369304528, 1002.8946960569181, 1007.6674697349857, 1009.2934945538153, 1014.573878970834, 6203.2556093269095, 6253.687315634291, 6308.779192728324, 6336.017917222838, 6367.044943258548, 440.5682431217425, 441.57388120463906, 461.1169610196503, 462.3434722693783, 463.6360457041274, 4279.914401711948, 4422.933655995163, 4427.911441771211, 4429.645628349725, 4532.546745325507, 10932.398718070583, 11317.547298108148, 11403.201775875608, 11417.657470275904, 11422.885771142348, 10478.842817357745, 10917.290376125526, 10988.340699558052, 11179.776404471864, 11317.377544234982, 8304.667813287522, 8370.246677798905, 8380.748577542683, 8422.115677853859, 8459.0, 6261.407270732595, 6299.275583307978, 6331.176946997045, 6456.160699109086, 6501.8699626008165, 10241.948790256001, 10313.381197128196, 10352.430616316175, 10475.633352832614, 10479.214058945761, 10605.098566621924, 10704.946475267574, 10732.83900741474, 10740.785184296114, 10742.946285268523, 7163.928360716534, 7854.685812567662, 7950.920490795249, 8203.42576019673, 8497.1502849717, 8239.794005149679, 8391.454555453876, 8431.072582016095, 8436.24073833358, 8455.0, 7460.179380268058, 7744.186860379805, 7784.455088144002, 7792.2986931176465, 7813.0, 7498.62506874665, 7530.472866899484, 7534.924650753423, 7545.811354716176, 7710.4217183710325, 6855.5886646801355, 6865.828354290983, 6906.654667266516, 6907.723691052302, 6917.377436030782, 5049.798008079782, 5179.559737422362, 5281.524662780368, 5304.655197412156, 5305.495977882095, 4958.25626156065, 4989.9251511228085, 5011.7494125294315, 5162.535371816554, 5256.710880901587], "value": 4581.228204127289, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [307.970742779436, 316.97305729013027, 322.40033537620025, 323.2323232323232, 332.3668411675757, 5105.463926287742, 5593.272874526306, 5750.971245143779, 5779.566532510063, 5803.361630220672, 5553.389127196006, 5553.805616803413, 5564.610477266593, 5592.86017849554, 5595.664260144395, 4341.153475072354, 4362.8036738346855, 4410.536893626171, 4433.290673492242, 4435.62297204738, 4119.393436559744, 4356.6514678825615, 4423.911521769563, 4424.491183513905, 4430.623397011258, 4268.807903644328, 4304.354346847967, 4307.547707490716, 4313.352997050436, 4318.2227199104145, 4330.501992270898, 4382.2331092059085, 4383.934240986372, 4387.5393083726385, 4415.712978656409, 3766.4538641897047, 3846.903827404309, 3849.287881741887, 3863.594322596115, 3870.9612903870884, 5473.945260547383, 5495.697736624484, 5517.227588137664, 5538.169274608801, 5540.085885828834, 4941.234108713155, 4948.802047918115, 5010.924836127461, 5017.2724954881705, 5021.5229553192385, 5759.308882934033, 5888.352281249059, 5898.675572843492, 5916.337648058391, 5990.460858522711, 4166.354215096665, 4174.08170202555, 4174.3947127666315, 4183.91632167358, 4191.8532851350365, 5986.910196347058, 6151.231096113031, 6198.2252218472695, 6204.565680402374, 6234.501239900797, 4170.582941705805, 4182.309918863414, 4196.8458673864325, 4206.116715489781, 4208.431861698631, 4203.42371610646, 4238.618524332825, 4251.213525497793, 4255.170241802881, 4266.040140968319, 4839.879003024953, 4882.414110306786, 4918.71279854862, 4928.457869634337, 4928.802847886044, 5884.705764711747, 5910.734016969247, 5916.1421593868645, 5926.555508336892, 5962.850928726816, 1452.7966084748143, 1463.7338702022673, 1464.1215270837413, 1474.2849717886816, 1481.8962672612813, 927.3045216087934, 952.9660318554307, 955.861400096982, 956.3687965942445, 970.5341436110706, 5081.466446023114, 5115.514026167508, 5137.948620513822, 5150.227465880073, 5167.560757335594, 5376.596755243294, 5405.621606487587, 5432.375276843213, 5486.037539728582, 5519.806806761824, 4966.850994470099, 5006.3992320921725, 5042.571381432546, 5080.466551012164, 5111.8722031948755, 2846.1746093632614, 2873.304750197394, 2886.5958765772807, 2895.044635270398, 2917.897873574415, 5564.27664403633, 5650.66096034231, 5658.547316214693, 5704.144378343199, 5710.628809127394, 5377.865553361197, 5385.623006389594, 5475.863103422446, 5488.259085023471, 5565.9721701392045, 5487.817066101651, 5580.525655319262, 5583.664980101207, 5591.46881046308, 5674.517665998436, 5465.770201704744, 5511.338639363302, 5523.530499907552, 5545.694986775766, 5723.5707321950185, 6090.695465226632, 6106.3588323227195, 6109.389061093855, 6151.108089327112, 6177.536684748752, 6125.264968203844, 6145.84635384119, 6273.372662733873, 6290.370962903673, 6328.272248691459, 4304.3543468479975, 4324.200022995756, 4361.738295702268, 4362.1493808707, 4369.38828563995, 5958.19564358806, 6243.96878015607, 6246.968765156145, 6248.531360148098, 6253.312135664983, 5939.10913362999, 5965.194698715618, 6007.0, 6035.818925432244, 6037.581168425504, 5975.462208401264, 5995.850103747267, 6061.393860613904, 6079.848003799941, 6082.878342433038, 5628.465295796893, 5863.0, 5909.881802364014, 5929.555283353679, 5932.7033648318275, 6033.42682445167, 6059.363766804422, 6078.0, 6083.361247068994, 6108.328083910677, 5521.917171242515, 5842.474177324061, 5866.325372582208, 5890.528757699288, 5906.881862362643], "value": 4380.797949705787, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [571.2459553389525, 582.2459914410838, 687.2680595166148, 782.4601025292549, 803.5861531311376, 14271.429142834288, 14919.403223871032, 15007.174605396713, 15007.324670389831, 15025.173615451145, 14311.642208944782, 14483.420663173487, 14489.565313040599, 14519.637009074779, 14544.927275363634, 775.6199462263493, 796.6494742313392, 797.3182928596054, 798.480987358216, 802.3541049455187, 774.7133560582593, 789.7591234673422, 792.8176519400541, 797.637075130817, 800.9319207867338, 820.4093053001859, 822.1285437436306, 831.3806214370303, 832.5587438657491, 832.8792325112855, 823.320760372695, 825.9132791056943, 825.9710910118117, 826.277007618334, 826.8718348655968, 604.1029071828375, 604.4137186928716, 604.4620287943734, 605.0, 606.3602898941615, 13864.0, 13866.584002479942, 13910.51313204033, 13925.094868833594, 13941.233232172328, 15295.388184472607, 15356.769648455282, 15399.538013859603, 15474.22628868552, 15524.844751552453, 12353.567625133077, 12472.875271247261, 12797.232166070065, 12846.357682115857, 13458.932705336509, 4005.7953637090504, 4009.258287216845, 4082.3672330788777, 4083.734557253769, 4176.979115104405, 73766.63116684383, 74056.62971685106, 75013.0, 75486.62256688737, 75514.0, 12025.158238923366, 12141.210821296587, 12215.877841221474, 12343.259404435763, 12423.130380873252, 22868.4282892929, 22948.196813111463, 22974.540509190057, 23039.539209215724, 23321.533569328858, 8566.443181193203, 8818.691345802867, 8883.511406872683, 8954.552272386485, 9146.86279705805, 4751.121042607128, 4797.712137271775, 4814.698445471783, 4848.369711937426, 4941.48114447985, 3532.7703699259464, 3649.61679023704, 3659.396199627032, 3663.5420572428447, 3669.3945498992903, 573.5268403567073, 589.1957478042527, 591.1133300049925, 595.2559300873908, 597.1550256387163, 615.2739767074805, 624.4161708802285, 693.0955103589763, 764.2930289482207, 765.6745882999703, 9668.226541876633, 9783.706488805346, 10020.248481363928, 10182.490875456346, 10263.332883362558, 701.7894631610496, 713.3152173912998, 720.4200618502156, 733.8238822682517, 738.3133685672269, 4556.0, 4682.321063445781, 4724.456687480915, 4744.3595114659765, 4801.735904525215, 109741.45129274462, 116460.41769791266, 118969.0, 120207.0, 120367.39816300862, 62506.0, 96119.0, 97555.0, 99003.0, 100240.49879750554, 58132.12801807976, 75620.0, 84194.0, 85143.57428212943, 86281.82309061351, 8976.371653984159, 8990.235829954265, 8994.910050899669, 9017.0, 9053.502057386644, 53503.0, 54172.18741718798, 54830.45169548254, 55737.72131139319, 55875.44124558865, 50218.49781502138, 64274.35725642871, 67184.32815671976, 67872.0, 75105.6244718773, 12980.350982450651, 13152.935443610833, 13202.933985330395, 13263.469461221443, 13532.797008045085, 14953.252337383305, 15060.246987650355, 15367.923160384575, 15392.18023602347, 15529.84470155284, 14228.497591452902, 14350.210738409487, 14588.124712517283, 14823.777643335574, 15331.846681533489, 14122.293885305487, 14584.562463126123, 14608.123512589278, 15201.543953681406, 15203.163825989677, 13542.255175965023, 13547.25490098054, 14040.326380794208, 14584.635384115481, 14760.926195368955, 10974.286671366335, 11041.503132358903, 11330.206885518264, 11366.772664546497, 11487.5979340726, 10428.53071611764, 10706.464676766287, 10839.945800271264, 10965.122790176927, 11228.719282017688], "value": 7542.722873899167, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1525.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 111.0, 106.0, 111.0, 111.0, 113.0, 111.0, 112.0, 110.0, 111.0], "value": 109.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 117.0, 145.0, 168.0, 118.0, 156.0, 146.0, 118.0, 178.0, 117.0], "value": 141.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 161.0, 161.0, 162.0, 164.0, 168.0, 165.0, 162.0, 164.0], "value": 163.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 76.0, 75.0, 149.0, 77.0, 78.0, 77.0, 75.0, 178.0, 76.0], "value": 93.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 151.0, 85.0, 84.0, 83.0, 131.0, 85.0, 84.0, 164.0], "value": 103.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 117.0, 118.0, 118.0, 118.0, 117.0, 117.0, 118.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 147.0, 147.0, 148.0, 147.0, 146.0, 147.0, 147.0, 147.0], "value": 147.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 97.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 55.0, 53.0, 55.0, 55.0, 54.0, 54.0, 55.0, 55.0], "value": 54.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 62.0, 62.0, 61.0, 61.0, 62.0, 62.0, 62.0], "value": 61.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 77.0, 74.0, 77.0, 76.0, 78.0, 85.0, 76.0, 75.0], "value": 77.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 118.0, 130.0, 139.0, 132.0, 130.0, 126.0, 132.0, 163.0, 146.0], "value": 133.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 171.0, 157.0, 165.0, 159.0, 161.0, 157.0, 159.0, 162.0, 160.0], "value": 161.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 64.0, 63.0, 63.0, 65.0, 68.0, 64.0, 64.0, 69.0], "value": 65.0, "unit": "score"}]}]} 23:31:59 INFO - Return code: 0 23:31:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 23:31:59 ERROR - # TBPL SUCCESS # 23:31:59 INFO - Running post-action listener: _resource_record_post_action 23:31:59 INFO - ##### 23:31:59 INFO - ##### Finished run-tests step (success) 23:31:59 INFO - ##### 23:31:59 INFO - Running post-run listener: _resource_record_post_run 23:31:59 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 0; Write bytes: 563650560; Read time: 0; Write time: 558152 23:31:59 INFO - TinderboxPrint: CPU usage
13.3% 23:31:59 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 23:31:59 INFO - TinderboxPrint: I/O write bytes / time
563,650,560 / 558,152 23:31:59 INFO - TinderboxPrint: CPU idle
8,233.0 (86.6%) 23:31:59 INFO - TinderboxPrint: CPU user
1,214.6 (12.8%) 23:31:59 INFO - TinderboxPrint: Swap in / out
0 / 0 23:31:59 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 263585792; Read time: 0; Write time: 279896 23:31:59 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 295489536; Read time: 0; Write time: 277364 23:31:59 INFO - Running post-run listener: _upload_blobber_files 23:31:59 INFO - Blob upload gear active. 23:31:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:31:59 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 23:31:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 23:31:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 23:32:00 INFO - (blobuploader) - INFO - Open directory for files ... 23:32:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 23:32:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:32:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:32:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 23:32:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:32:00 INFO - (blobuploader) - INFO - Done attempting. 23:32:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:32:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:32:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:32:04 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:32:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:32:04 INFO - (blobuploader) - INFO - Done attempting. 23:32:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 23:32:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:32:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:32:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 23:32:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:32:05 INFO - (blobuploader) - INFO - Done attempting. 23:32:05 INFO - (blobuploader) - INFO - Iteration through files over. 23:32:05 INFO - Return code: 0 23:32:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:32:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:32:05 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fa50377bbcd33ee95299a36709686061f97aff54d838bfc0c7d3f3351c554ebb41df83719e74812460565490c654333fa0697799645955cfaf0d65bb70f739ec", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b515098eb2171e8476bf8f350cd78fa0871475726246df6f505e05ad84ae9135509fbe14719b2bcfcd5cf21894aceffecb889296d533f8797a2ac71ec4729d1d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/03869fabdbb642d12a16c3bb8338714fc51761fe0e74ca2c18a24804e8a35f72be4b78a6e80df827981e13412a203f40790b8575153dd0ddd81c75b3a2cbbcff"} 23:32:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:32:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:32:05 INFO - Contents: 23:32:05 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fa50377bbcd33ee95299a36709686061f97aff54d838bfc0c7d3f3351c554ebb41df83719e74812460565490c654333fa0697799645955cfaf0d65bb70f739ec", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b515098eb2171e8476bf8f350cd78fa0871475726246df6f505e05ad84ae9135509fbe14719b2bcfcd5cf21894aceffecb889296d533f8797a2ac71ec4729d1d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/03869fabdbb642d12a16c3bb8338714fc51761fe0e74ca2c18a24804e8a35f72be4b78a6e80df827981e13412a203f40790b8575153dd0ddd81c75b3a2cbbcff"} 23:32:05 INFO - Running post-run listener: copy_logs_to_upload_dir 23:32:05 INFO - Copying logs to upload dir... 23:32:05 INFO - mkdir: /builds/slave/test/build/upload/logs 23:32:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1230.699869 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-07-05 23:32:04.795359) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-05 23:32:04.798434) ========= 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=836cfdc75598d54cb747368e000001a9-1467783869.247480-1528355608 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/fa50377bbcd33ee95299a36709686061f97aff54d838bfc0c7d3f3351c554ebb41df83719e74812460565490c654333fa0697799645955cfaf0d65bb70f739ec", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b515098eb2171e8476bf8f350cd78fa0871475726246df6f505e05ad84ae9135509fbe14719b2bcfcd5cf21894aceffecb889296d533f8797a2ac71ec4729d1d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/03869fabdbb642d12a16c3bb8338714fc51761fe0e74ca2c18a24804e8a35f72be4b78a6e80df827981e13412a203f40790b8575153dd0ddd81c75b3a2cbbcff"} build_url:https://queue.taskcluster.net/v1/task/c9ohSk8ATaS__Z6xrYWVVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011241 build_url: 'https://queue.taskcluster.net/v1/task/c9ohSk8ATaS__Z6xrYWVVQ/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/fa50377bbcd33ee95299a36709686061f97aff54d838bfc0c7d3f3351c554ebb41df83719e74812460565490c654333fa0697799645955cfaf0d65bb70f739ec", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b515098eb2171e8476bf8f350cd78fa0871475726246df6f505e05ad84ae9135509fbe14719b2bcfcd5cf21894aceffecb889296d533f8797a2ac71ec4729d1d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/03869fabdbb642d12a16c3bb8338714fc51761fe0e74ca2c18a24804e8a35f72be4b78a6e80df827981e13412a203f40790b8575153dd0ddd81c75b3a2cbbcff"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-05 23:32:04.823377) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 23:32:04.823698) ========= 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=836cfdc75598d54cb747368e000001a9-1467783869.247480-1528355608 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004468 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 23:32:04.907537) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-05 23:32:04.907812) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-05 23:32:04.908082) ========= ========= Total master_lag: 0.18 =========