builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-019 starttime: 1467796200.77 results: success (0) buildid: 20160705233018 builduid: 3d4944e08425468fa8c255a888492577 revision: cec1ab33c0d6bdc2638e0e76566a5009f033d949 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-06 02:10:00.769157) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-06 02:10:00.769731) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-06 02:10:00.770040) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-06 02:10:00.820094) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 02:10:00.820386) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1467794203.396150-714700313 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-06 02:10:01-- 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% 46.6M=0s 2016-07-06 02:10:01 (46.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.091961 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 02:10:00.947267) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 02:10:00.947733) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1467794203.396150-714700313 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020917 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 02:10:01.016977) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-06 02:10:01.017337) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev cec1ab33c0d6bdc2638e0e76566a5009f033d949 --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 cec1ab33c0d6bdc2638e0e76566a5009f033d949 --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=78329bfc0fd5309db0a6e0ac000001b4-1467794203.396150-714700313 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-06 02:10:01,487 truncating revision to first 12 chars 2016-07-06 02:10:01,487 Setting DEBUG logging. 2016-07-06 02:10:01,487 attempt 1/10 2016-07-06 02:10:01,487 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/cec1ab33c0d6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-06 02:10:02,309 unpacking tar archive at: fx-team-cec1ab33c0d6/testing/mozharness/ program finished with exit code 0 elapsedTime=1.154899 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-06 02:10:02.191296) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-06 02:10:02.191643) ========= script_repo_revision: cec1ab33c0d6bdc2638e0e76566a5009f033d949 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-06 02:10:02.192068) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-06 02:10:02.192344) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-06 02:10:02.206115) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-07-06 02:10:02.206483) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=78329bfc0fd5309db0a6e0ac000001b4-1467794203.396150-714700313 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:10:02 INFO - MultiFileLogger online at 20160706 02:10:02 in /builds/slave/test 02:10:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 02:10:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:10:02 INFO - {'append_to_log': False, 02:10:02 INFO - 'base_work_dir': '/builds/slave/test', 02:10:02 INFO - 'blob_upload_branch': 'Fx-Team', 02:10:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:10:02 INFO - 'branch': 'Fx-Team', 02:10:02 INFO - 'buildbot_json_path': 'buildprops.json', 02:10:02 INFO - 'config_files': ('talos/linux_config.py',), 02:10:02 INFO - 'default_actions': ('clobber', 02:10:02 INFO - 'read-buildbot-config', 02:10:02 INFO - 'download-and-extract', 02:10:02 INFO - 'populate-webroot', 02:10:02 INFO - 'create-virtualenv', 02:10:02 INFO - 'install', 02:10:02 INFO - 'run-tests'), 02:10:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:10:02 INFO - 'download_minidump_stackwalk': True, 02:10:02 INFO - 'download_symbols': 'ondemand', 02:10:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:10:02 INFO - 'tooltool.py': '/tools/tooltool.py', 02:10:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:10:02 INFO - '/tools/misc-python/virtualenv.py')}, 02:10:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:10:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:10:02 INFO - 'installer_path': 'installer.exe', 02:10:02 INFO - 'log_level': 'info', 02:10:02 INFO - 'log_name': 'talos', 02:10:02 INFO - 'log_to_console': True, 02:10:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:10:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:10:02 INFO - 'opt_config_files': (), 02:10:02 INFO - 'pip_index': False, 02:10:02 INFO - 'sps_profile': False, 02:10:02 INFO - 'sps_profile_interval': 0, 02:10:02 INFO - 'suite': 'dromaeojs', 02:10:02 INFO - 'system_bits': '32', 02:10:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:10:02 INFO - 'title': 'talos-linux64-ix-019', 02:10:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:10:02 INFO - 'use_talos_json': True, 02:10:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:10:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:10:02 INFO - 'work_dir': 'build'} 02:10:02 INFO - ##### 02:10:02 INFO - ##### Running clobber step. 02:10:02 INFO - ##### 02:10:02 INFO - Running pre-action listener: _resource_record_pre_action 02:10:02 INFO - Running main action method: clobber 02:10:02 INFO - rmtree: /builds/slave/test/build 02:10:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:10:03 INFO - Running post-action listener: _resource_record_post_action 02:10:03 INFO - ##### 02:10:03 INFO - ##### Finished clobber step (success) 02:10:03 INFO - ##### 02:10:03 INFO - ##### 02:10:03 INFO - ##### Running read-buildbot-config step. 02:10:03 INFO - ##### 02:10:03 INFO - Running pre-action listener: _resource_record_pre_action 02:10:03 INFO - Running main action method: read_buildbot_config 02:10:03 INFO - Using buildbot properties: 02:10:03 INFO - { 02:10:03 INFO - "project": "", 02:10:03 INFO - "product": "firefox", 02:10:03 INFO - "script_repo_revision": "production", 02:10:03 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 02:10:03 INFO - "repository": "", 02:10:03 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 02:10:03 INFO - "buildid": "20160705233018", 02:10:03 INFO - "pgo_build": "True", 02:10:03 INFO - "basedir": "/builds/slave/test", 02:10:03 INFO - "buildnumber": 250, 02:10:03 INFO - "slavename": "talos-linux64-ix-019", 02:10:03 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 02:10:03 INFO - "platform": "ubuntu64_hw", 02:10:03 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 02:10:03 INFO - "branch": "fx-team", 02:10:03 INFO - "repo_path": "integration/fx-team", 02:10:03 INFO - "revision": "cec1ab33c0d6bdc2638e0e76566a5009f033d949", 02:10:03 INFO - "stage_platform": "linux64-pgo", 02:10:03 INFO - "builduid": "3d4944e08425468fa8c255a888492577", 02:10:03 INFO - "slavebuilddir": "test" 02:10:03 INFO - } 02:10:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/THuULqs_TwOzg5sEogSrkA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 02:10:03 INFO - Running post-action listener: _resource_record_post_action 02:10:03 INFO - ##### 02:10:03 INFO - ##### Finished read-buildbot-config step (success) 02:10:03 INFO - ##### 02:10:03 INFO - ##### 02:10:03 INFO - ##### Running download-and-extract step. 02:10:03 INFO - ##### 02:10:03 INFO - Running pre-action listener: _resource_record_pre_action 02:10:03 INFO - Running main action method: download_and_extract 02:10:03 INFO - mkdir: /builds/slave/test/build/tests 02:10: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')]} 02:10:03 INFO - https://queue.taskcluster.net/v1/task/THuULqs_TwOzg5sEogSrkA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 02:10:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/THuULqs_TwOzg5sEogSrkA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:10:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/THuULqs_TwOzg5sEogSrkA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:10:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/THuULqs_TwOzg5sEogSrkA/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 02:10:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/THuULqs_TwOzg5sEogSrkA/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 02:10:03 INFO - Downloaded 1361 bytes. 02:10:03 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:10:03 INFO - Using the following test package requirements: 02:10:03 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 02:10:03 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:10:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:10:03 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:10:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:10:03 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:10:03 INFO - u'jsshell-linux-x86_64.zip'], 02:10:03 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:10:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:10:03 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 02:10:03 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:10:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:10:03 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:10:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:10:03 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:10:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:10:03 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:10:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:10:03 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:10: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')]} 02:10:03 INFO - https://queue.taskcluster.net/v1/task/THuULqs_TwOzg5sEogSrkA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:10:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/THuULqs_TwOzg5sEogSrkA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:10:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/THuULqs_TwOzg5sEogSrkA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:10:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/THuULqs_TwOzg5sEogSrkA/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 02:10:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/THuULqs_TwOzg5sEogSrkA/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 02:10:05 INFO - Downloaded 24300779 bytes. 02:10:05 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'] 02:10:05 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 02:10:06 INFO - Return code: 0 02:10:06 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 02:10:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:10:06 INFO - https://queue.taskcluster.net/v1/task/THuULqs_TwOzg5sEogSrkA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:10:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/THuULqs_TwOzg5sEogSrkA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:10:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/THuULqs_TwOzg5sEogSrkA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:10:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/THuULqs_TwOzg5sEogSrkA/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 02:10:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/THuULqs_TwOzg5sEogSrkA/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 02:10:10 INFO - Downloaded 24300779 bytes. 02:10:10 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'] 02:10:10 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 02:10:11 INFO - Return code: 0 02:10:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 02:10:11 INFO - https://queue.taskcluster.net/v1/task/THuULqs_TwOzg5sEogSrkA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:10:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/THuULqs_TwOzg5sEogSrkA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:10:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/THuULqs_TwOzg5sEogSrkA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:10:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/THuULqs_TwOzg5sEogSrkA/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 02:10:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/THuULqs_TwOzg5sEogSrkA/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 02:10:12 INFO - Downloaded 14403333 bytes. 02:10:12 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'] 02:10:12 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 02:10:13 INFO - Return code: 0 02:10:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 02:10:13 INFO - https://queue.taskcluster.net/v1/task/THuULqs_TwOzg5sEogSrkA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:10:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/THuULqs_TwOzg5sEogSrkA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:10:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/THuULqs_TwOzg5sEogSrkA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:10:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/THuULqs_TwOzg5sEogSrkA/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 02:10:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/THuULqs_TwOzg5sEogSrkA/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 02:10:17 INFO - Downloaded 60358760 bytes. 02:10:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/THuULqs_TwOzg5sEogSrkA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:10:17 INFO - mkdir: /builds/slave/test/properties 02:10:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:10:17 INFO - Writing to file /builds/slave/test/properties/build_url 02:10:17 INFO - Contents: 02:10:17 INFO - build_url:https://queue.taskcluster.net/v1/task/THuULqs_TwOzg5sEogSrkA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:10:17 INFO - Running post-action listener: _resource_record_post_action 02:10:17 INFO - Running post-action listener: set_extra_try_arguments 02:10:17 INFO - ##### 02:10:17 INFO - ##### Finished download-and-extract step (success) 02:10:17 INFO - ##### 02:10:17 INFO - ##### 02:10:17 INFO - ##### Running populate-webroot step. 02:10:17 INFO - ##### 02:10:17 INFO - Running pre-action listener: _resource_record_pre_action 02:10:17 INFO - Running main action method: populate_webroot 02:10:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:10:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:10:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:10:17 INFO - '--tppagecycles', 02:10:17 INFO - '7'], 02:10:17 INFO - 'tests': ['tsvgm']}}, 02:10:17 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:10:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:10:17 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:10:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:10:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:10:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:10:17 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:10:17 INFO - 'talos_options': ['--disable-e10s'], 02:10:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:10:17 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:10:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:10:17 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:10:17 INFO - 'talos_options': ['--disable-e10s'], 02:10:17 INFO - 'tests': ['damp', 'tps']}, 02:10:17 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:10:17 INFO - 'tests': ['damp', 'tps']}, 02:10:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:10:17 INFO - 'tests': ['dromaeo_dom']}, 02:10:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:10:17 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:10:17 INFO - 'tests': ['basic_compositor_video']}, 02:10:17 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:10:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:10:17 INFO - 'tests': ['a11yr', 02:10:17 INFO - 'ts_paint', 02:10:17 INFO - 'tpaint', 02:10:17 INFO - 'sessionrestore', 02:10:17 INFO - 'sessionrestore_no_auto_restore', 02:10:17 INFO - 'tabpaint']}, 02:10:17 INFO - 'other-e10s': {'tests': ['a11yr', 02:10:17 INFO - 'ts_paint', 02:10:17 INFO - 'tpaint', 02:10:17 INFO - 'sessionrestore', 02:10:17 INFO - 'sessionrestore_no_auto_restore', 02:10:17 INFO - 'tabpaint']}, 02:10:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:10:17 INFO - 'ts_paint', 02:10:17 INFO - 'tpaint', 02:10:17 INFO - 'sessionrestore', 02:10:17 INFO - 'sessionrestore_no_auto_restore', 02:10:17 INFO - 'tabpaint']}, 02:10:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:10:17 INFO - 'ts_paint', 02:10:17 INFO - 'tpaint', 02:10:17 INFO - 'sessionrestore', 02:10:17 INFO - 'sessionrestore_no_auto_restore', 02:10:17 INFO - 'tabpaint']}, 02:10:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:10:17 INFO - 'tests': ['a11yr', 02:10:17 INFO - 'ts_paint', 02:10:17 INFO - 'tpaint', 02:10:17 INFO - 'sessionrestore', 02:10:17 INFO - 'sessionrestore_no_auto_restore', 02:10:17 INFO - 'tabpaint']}, 02:10:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:10:17 INFO - 'tests': ['a11yr', 02:10:17 INFO - 'ts_paint', 02:10:17 INFO - 'tpaint', 02:10:17 INFO - 'sessionrestore', 02:10:17 INFO - 'sessionrestore_no_auto_restore', 02:10:17 INFO - 'tabpaint']}, 02:10:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:10:17 INFO - 'tests': ['tsvgx', 02:10:17 INFO - 'tsvgr_opacity', 02:10:17 INFO - 'tart', 02:10:17 INFO - 'tscrollx', 02:10:17 INFO - 'cart']}, 02:10:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:10:17 INFO - 'tsvgr_opacity', 02:10:17 INFO - 'tart', 02:10:17 INFO - 'tscrollx', 02:10:17 INFO - 'cart']}, 02:10:17 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:10:17 INFO - 'talos_options': ['--disable-e10s'], 02:10:17 INFO - 'tests': ['tp5o']}, 02:10:17 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:10:17 INFO - 'tests': ['tp5o']}, 02:10:17 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:10:17 INFO - 'talos_options': ['--disable-e10s', 02:10:17 INFO - '--xperf_path', 02:10:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:10:17 INFO - 'tests': ['tp5n']}, 02:10:17 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:10:17 INFO - 'talos_options': ['--xperf_path', 02:10:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:10:17 INFO - 'tests': ['tp5n']}}, 02:10:17 INFO - 'talos.zip': {'path': '', 02:10:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:10:17 INFO - Running post-action listener: _resource_record_post_action 02:10:17 INFO - ##### 02:10:17 INFO - ##### Finished populate-webroot step (success) 02:10:17 INFO - ##### 02:10:17 INFO - ##### 02:10:17 INFO - ##### Running create-virtualenv step. 02:10:17 INFO - ##### 02:10:17 INFO - Running pre-action listener: _resource_record_pre_action 02:10:17 INFO - Running main action method: create_virtualenv 02:10:17 INFO - Creating virtualenv /builds/slave/test/build/venv 02:10:17 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 02:10:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:10:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:10:18 INFO - Using real prefix '/usr' 02:10:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:10:18 INFO - Installing distribute.............................................................................................................................................................................................done. 02:10:20 INFO - Installing pip.................done. 02:10:20 INFO - Return code: 0 02:10:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:10:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:10:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:10:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:10:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:10:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:20 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 0x2661030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2922180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29203b0>, '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 0x29212b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2921740>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1467794203.396150-714700313', '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 02:10:20 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 02:10:20 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 02:10:20 INFO - Using env: {'DISPLAY': ':0', 02:10:20 INFO - 'HOME': '/home/cltbld', 02:10:20 INFO - 'LANG': 'en_US.UTF-8', 02:10:20 INFO - 'LANGUAGE': 'en_US:en', 02:10:20 INFO - 'LOGNAME': 'cltbld', 02:10:20 INFO - 'MAIL': '/var/mail/cltbld', 02:10:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:10:20 INFO - 'MOZ_NO_REMOTE': '1', 02:10:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:10:20 INFO - 'NO_EM_RESTART': '1', 02:10:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:10:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:10:20 INFO - 'PWD': '/builds/slave/test', 02:10:20 INFO - 'SHELL': '/bin/bash', 02:10:20 INFO - 'SHLVL': '1', 02:10:20 INFO - 'TERM': 'linux', 02:10:20 INFO - 'TMOUT': '86400', 02:10:20 INFO - 'USER': 'cltbld', 02:10:20 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1467794203.396150-714700313', 02:10:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:10:20 INFO - '_': '/tools/buildbot/bin/python'} 02:10:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:10:20 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 02:10:20 INFO - Cleaning up... 02:10:20 INFO - Return code: 0 02:10:20 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:10:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:10:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:10:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:10:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:10:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:20 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 0x2661030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2922180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29203b0>, '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 0x29212b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2921740>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1467794203.396150-714700313', '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 02:10:20 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 02:10:20 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 02:10:20 INFO - Using env: {'DISPLAY': ':0', 02:10:20 INFO - 'HOME': '/home/cltbld', 02:10:20 INFO - 'LANG': 'en_US.UTF-8', 02:10:20 INFO - 'LANGUAGE': 'en_US:en', 02:10:20 INFO - 'LOGNAME': 'cltbld', 02:10:20 INFO - 'MAIL': '/var/mail/cltbld', 02:10:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:10:20 INFO - 'MOZ_NO_REMOTE': '1', 02:10:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:10:20 INFO - 'NO_EM_RESTART': '1', 02:10:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:10:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:10:20 INFO - 'PWD': '/builds/slave/test', 02:10:20 INFO - 'SHELL': '/bin/bash', 02:10:20 INFO - 'SHLVL': '1', 02:10:20 INFO - 'TERM': 'linux', 02:10:20 INFO - 'TMOUT': '86400', 02:10:20 INFO - 'USER': 'cltbld', 02:10:20 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1467794203.396150-714700313', 02:10:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:10:20 INFO - '_': '/tools/buildbot/bin/python'} 02:10:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:10:20 INFO - Downloading/unpacking psutil>=3.1.1 02:10:20 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 02:10:20 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 02:10:20 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 02:10:20 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 02:10:20 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 02:10:20 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 02:10:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:10:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:10:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:10:22 INFO - Installing collected packages: psutil 02:10:22 INFO - Running setup.py install for psutil 02:10:23 INFO - building 'psutil._psutil_linux' extension 02:10:23 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 02:10:23 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 02:10:23 INFO - building 'psutil._psutil_posix' extension 02:10:23 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 02:10:23 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 02:10:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:10:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:10:23 INFO - Successfully installed psutil 02:10:23 INFO - Cleaning up... 02:10:23 INFO - Return code: 0 02:10:23 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:10:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:10:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:10:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:10:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:10:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:23 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 0x2661030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2922180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29203b0>, '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 0x29212b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2921740>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1467794203.396150-714700313', '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 02:10:23 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 02:10:23 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 02:10:23 INFO - Using env: {'DISPLAY': ':0', 02:10:23 INFO - 'HOME': '/home/cltbld', 02:10:23 INFO - 'LANG': 'en_US.UTF-8', 02:10:23 INFO - 'LANGUAGE': 'en_US:en', 02:10:23 INFO - 'LOGNAME': 'cltbld', 02:10:23 INFO - 'MAIL': '/var/mail/cltbld', 02:10:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:10:23 INFO - 'MOZ_NO_REMOTE': '1', 02:10:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:10:23 INFO - 'NO_EM_RESTART': '1', 02:10:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:10:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:10:23 INFO - 'PWD': '/builds/slave/test', 02:10:23 INFO - 'SHELL': '/bin/bash', 02:10:23 INFO - 'SHLVL': '1', 02:10:23 INFO - 'TERM': 'linux', 02:10:23 INFO - 'TMOUT': '86400', 02:10:23 INFO - 'USER': 'cltbld', 02:10:23 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1467794203.396150-714700313', 02:10:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:10:23 INFO - '_': '/tools/buildbot/bin/python'} 02:10:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:10:23 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:10:23 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 02:10:23 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 02:10:23 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 02:10:23 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 02:10:23 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 02:10:23 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 02:10:26 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:10:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:10:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:10:26 INFO - Installing collected packages: mozsystemmonitor 02:10:26 INFO - Running setup.py install for mozsystemmonitor 02:10:26 INFO - Successfully installed mozsystemmonitor 02:10:26 INFO - Cleaning up... 02:10:26 INFO - Return code: 0 02:10:26 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:10:26 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')]} 02:10:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:10:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:26 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')]} 02:10:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:10:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:26 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 0x2661030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2922180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29203b0>, '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 0x29212b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2921740>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1467794203.396150-714700313', '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 02:10:26 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 02:10:26 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 02:10:26 INFO - Using env: {'DISPLAY': ':0', 02:10:26 INFO - 'HOME': '/home/cltbld', 02:10:26 INFO - 'LANG': 'en_US.UTF-8', 02:10:26 INFO - 'LANGUAGE': 'en_US:en', 02:10:26 INFO - 'LOGNAME': 'cltbld', 02:10:26 INFO - 'MAIL': '/var/mail/cltbld', 02:10:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:10:26 INFO - 'MOZ_NO_REMOTE': '1', 02:10:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:10:26 INFO - 'NO_EM_RESTART': '1', 02:10:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:10:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:10:26 INFO - 'PWD': '/builds/slave/test', 02:10:26 INFO - 'SHELL': '/bin/bash', 02:10:26 INFO - 'SHLVL': '1', 02:10:26 INFO - 'TERM': 'linux', 02:10:26 INFO - 'TMOUT': '86400', 02:10:26 INFO - 'USER': 'cltbld', 02:10:26 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1467794203.396150-714700313', 02:10:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:10:26 INFO - '_': '/tools/buildbot/bin/python'} 02:10:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:10:27 INFO - Downloading/unpacking jsonschema==2.5.1 02:10:27 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 02:10:27 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 02:10:27 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 02:10:27 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 02:10:27 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 02:10:27 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 02:10:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:10:28 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:10:28 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 02:10:28 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 02:10:28 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 02:10:28 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 02:10:28 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 02:10:28 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 02:10:29 INFO - Downloading functools32-3.2.3-2.tar.gz 02:10:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:10:29 INFO - warning: no files found matching '*.txt' 02:10:29 INFO - no previously-included directories found matching 'build' 02:10:29 INFO - no previously-included directories found matching 'dist' 02:10:29 INFO - no previously-included directories found matching '.git*' 02:10:29 INFO - Installing collected packages: jsonschema, functools32 02:10:29 INFO - Running setup.py install for functools32 02:10:29 INFO - warning: no files found matching '*.txt' 02:10:29 INFO - no previously-included directories found matching 'build' 02:10:29 INFO - no previously-included directories found matching 'dist' 02:10:29 INFO - no previously-included directories found matching '.git*' 02:10:29 INFO - Successfully installed jsonschema functools32 02:10:29 INFO - Cleaning up... 02:10:29 INFO - Return code: 0 02:10:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:10:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:10:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:10:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:10:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:10:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:29 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 0x2661030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2922180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29203b0>, '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 0x29212b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2921740>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1467794203.396150-714700313', '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 02:10:29 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 02:10:29 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 02:10:29 INFO - Using env: {'DISPLAY': ':0', 02:10:29 INFO - 'HOME': '/home/cltbld', 02:10:29 INFO - 'LANG': 'en_US.UTF-8', 02:10:29 INFO - 'LANGUAGE': 'en_US:en', 02:10:29 INFO - 'LOGNAME': 'cltbld', 02:10:29 INFO - 'MAIL': '/var/mail/cltbld', 02:10:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:10:29 INFO - 'MOZ_NO_REMOTE': '1', 02:10:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:10:29 INFO - 'NO_EM_RESTART': '1', 02:10:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:10:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:10:29 INFO - 'PWD': '/builds/slave/test', 02:10:29 INFO - 'SHELL': '/bin/bash', 02:10:29 INFO - 'SHLVL': '1', 02:10:29 INFO - 'TERM': 'linux', 02:10:29 INFO - 'TMOUT': '86400', 02:10:29 INFO - 'USER': 'cltbld', 02:10:29 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1467794203.396150-714700313', 02:10:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:10:29 INFO - '_': '/tools/buildbot/bin/python'} 02:10:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:10:29 INFO - Downloading/unpacking blobuploader==1.2.4 02:10:29 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 02:10:29 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 02:10:29 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 02:10:29 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 02:10:29 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 02:10:29 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 02:10:31 INFO - Downloading blobuploader-1.2.4.tar.gz 02:10:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:10:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:10:31 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 02:10:31 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 02:10:31 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 02:10:31 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 02:10:31 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 02:10:31 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 02:10:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:10:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:10:31 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 02:10:31 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 02:10:31 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 02:10:31 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 02:10:31 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 02:10:31 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 02:10:32 INFO - Downloading docopt-0.6.1.tar.gz 02:10:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:10:32 INFO - Installing collected packages: blobuploader, requests, docopt 02:10:32 INFO - Running setup.py install for blobuploader 02:10:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:10:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:10:32 INFO - Running setup.py install for requests 02:10:32 INFO - Running setup.py install for docopt 02:10:32 INFO - Successfully installed blobuploader requests docopt 02:10:32 INFO - Cleaning up... 02:10:32 INFO - Return code: 0 02:10:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:10:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:10:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:10:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:10:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:10:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:32 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 0x2661030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2922180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29203b0>, '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 0x29212b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2921740>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1467794203.396150-714700313', '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 02:10:32 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 02:10:32 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 02:10:32 INFO - Using env: {'DISPLAY': ':0', 02:10:32 INFO - 'HOME': '/home/cltbld', 02:10:32 INFO - 'LANG': 'en_US.UTF-8', 02:10:32 INFO - 'LANGUAGE': 'en_US:en', 02:10:32 INFO - 'LOGNAME': 'cltbld', 02:10:32 INFO - 'MAIL': '/var/mail/cltbld', 02:10:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:10:32 INFO - 'MOZ_NO_REMOTE': '1', 02:10:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:10:32 INFO - 'NO_EM_RESTART': '1', 02:10:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:10:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:10:32 INFO - 'PWD': '/builds/slave/test', 02:10:32 INFO - 'SHELL': '/bin/bash', 02:10:32 INFO - 'SHLVL': '1', 02:10:32 INFO - 'TERM': 'linux', 02:10:32 INFO - 'TMOUT': '86400', 02:10:32 INFO - 'USER': 'cltbld', 02:10:32 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1467794203.396150-714700313', 02:10:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:10:32 INFO - '_': '/tools/buildbot/bin/python'} 02:10:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:10:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:10:33 INFO - Running setup.py (path:/tmp/pip-RPI2OX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:10:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:10:33 INFO - Running setup.py (path:/tmp/pip-Hbq7vY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:10:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:10:33 INFO - Running setup.py (path:/tmp/pip-8l1rdT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:10:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:10:33 INFO - Running setup.py (path:/tmp/pip-mPFAC5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:10:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:10:33 INFO - Running setup.py (path:/tmp/pip-At8Cmg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:10:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:10:33 INFO - Running setup.py (path:/tmp/pip-KPZzMm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:10:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:10:33 INFO - Running setup.py (path:/tmp/pip-_kWqYF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:10:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:10:33 INFO - Running setup.py (path:/tmp/pip-2PxpRZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:10:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:10:33 INFO - Running setup.py (path:/tmp/pip-VYxVkN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:10:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:10:33 INFO - Running setup.py (path:/tmp/pip-cd9lap-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:10:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:10:33 INFO - Running setup.py (path:/tmp/pip-7lTq9x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:10:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:10:33 INFO - Running setup.py (path:/tmp/pip-s7quT4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:10:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:10:33 INFO - Running setup.py (path:/tmp/pip-J60bnf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:10:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:10:34 INFO - Running setup.py (path:/tmp/pip-9l9jeB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:10:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:10:34 INFO - Running setup.py (path:/tmp/pip-ZpQnb1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:10:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:10:34 INFO - Running setup.py (path:/tmp/pip-szj1p5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:10:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:10:34 INFO - Running setup.py (path:/tmp/pip-MmU1zR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:10:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:10:34 INFO - Running setup.py install for manifestparser 02:10:34 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:10:34 INFO - Running setup.py install for mozcrash 02:10:34 INFO - Running setup.py install for mozdebug 02:10:34 INFO - Running setup.py install for mozdevice 02:10:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:10:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:10:34 INFO - Running setup.py install for mozfile 02:10:34 INFO - Running setup.py install for mozhttpd 02:10:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:10:34 INFO - Running setup.py install for mozinfo 02:10:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:10:35 INFO - Running setup.py install for mozInstall 02:10:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:10:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:10:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:10:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:10:35 INFO - Running setup.py install for mozleak 02:10:35 INFO - Running setup.py install for mozlog 02:10:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:10:35 INFO - Running setup.py install for moznetwork 02:10:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:10:35 INFO - Running setup.py install for mozprocess 02:10:35 INFO - Running setup.py install for mozprofile 02:10:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:10:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:10:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:10:35 INFO - Running setup.py install for mozrunner 02:10:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:10:35 INFO - Running setup.py install for mozscreenshot 02:10:35 INFO - Running setup.py install for moztest 02:10:35 INFO - Running setup.py install for mozversion 02:10:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:10:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:10:36 INFO - Cleaning up... 02:10:36 INFO - Return code: 0 02:10:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:10:36 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')]} 02:10:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:10:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:36 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')]} 02:10:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:10:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:36 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 0x2661030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2922180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29203b0>, '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 0x29212b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2921740>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1467794203.396150-714700313', '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 02:10:36 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 02:10:36 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 02:10:36 INFO - Using env: {'DISPLAY': ':0', 02:10:36 INFO - 'HOME': '/home/cltbld', 02:10:36 INFO - 'LANG': 'en_US.UTF-8', 02:10:36 INFO - 'LANGUAGE': 'en_US:en', 02:10:36 INFO - 'LOGNAME': 'cltbld', 02:10:36 INFO - 'MAIL': '/var/mail/cltbld', 02:10:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:10:36 INFO - 'MOZ_NO_REMOTE': '1', 02:10:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:10:36 INFO - 'NO_EM_RESTART': '1', 02:10:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:10:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:10:36 INFO - 'PWD': '/builds/slave/test', 02:10:36 INFO - 'SHELL': '/bin/bash', 02:10:36 INFO - 'SHLVL': '1', 02:10:36 INFO - 'TERM': 'linux', 02:10:36 INFO - 'TMOUT': '86400', 02:10:36 INFO - 'USER': 'cltbld', 02:10:36 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1467794203.396150-714700313', 02:10:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:10:36 INFO - '_': '/tools/buildbot/bin/python'} 02:10:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:10:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:10:36 INFO - Running setup.py (path:/tmp/pip-_p0Wad-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:10:36 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)) 02:10:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:10:36 INFO - Running setup.py (path:/tmp/pip-M0WRRp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:10:36 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)) 02:10:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:10:36 INFO - Running setup.py (path:/tmp/pip-UYBmYe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:10:36 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)) 02:10:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:10:36 INFO - Running setup.py (path:/tmp/pip-frOm1y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:10:36 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)) 02:10:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:10:36 INFO - Running setup.py (path:/tmp/pip-eIO1ch-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:10:36 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)) 02:10:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:10:36 INFO - Running setup.py (path:/tmp/pip-EMDjWH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:10:36 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)) 02:10:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:10:36 INFO - Running setup.py (path:/tmp/pip-e1kIT0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:10:36 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)) 02:10:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:10:36 INFO - Running setup.py (path:/tmp/pip-CFAw9f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:10:36 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)) 02:10:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:10:36 INFO - Running setup.py (path:/tmp/pip-Hi4reK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:10:36 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)) 02:10:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:10:36 INFO - Running setup.py (path:/tmp/pip-825I9d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:10:37 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)) 02:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:10:37 INFO - Running setup.py (path:/tmp/pip-Al6LFK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:10:37 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)) 02:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:10:37 INFO - Running setup.py (path:/tmp/pip-hck2Cf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:10:37 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)) 02:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:10:37 INFO - Running setup.py (path:/tmp/pip-1yLdfc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:10:37 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)) 02:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:10:37 INFO - Running setup.py (path:/tmp/pip-uJXCre-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:10:37 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)) 02:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:10:37 INFO - Running setup.py (path:/tmp/pip-bURaZ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:10:37 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)) 02:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:10:37 INFO - Running setup.py (path:/tmp/pip-p0vCUk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:10:37 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)) 02:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:10:37 INFO - Running setup.py (path:/tmp/pip-FM0MWD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:10:37 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)) 02:10:37 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)) 02:10:37 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)) 02:10:37 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)) 02:10:37 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)) 02:10:37 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)) 02:10:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:10:37 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 02:10:37 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 02:10:37 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 02:10:37 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 02:10:37 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 02:10:37 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 02:10:39 INFO - Downloading blessings-1.6.tar.gz 02:10:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:10:39 INFO - Installing collected packages: blessings 02:10:39 INFO - Running setup.py install for blessings 02:10:39 INFO - Successfully installed blessings 02:10:39 INFO - Cleaning up... 02:10:39 INFO - Return code: 0 02:10:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:10:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:10:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:10:39 INFO - Reading from file tmpfile_stdout 02:10:39 INFO - Current package versions: 02:10:39 INFO - argparse == 1.2.1 02:10:39 INFO - blessings == 1.6 02:10:39 INFO - blobuploader == 1.2.4 02:10:39 INFO - docopt == 0.6.1 02:10:39 INFO - functools32 == 3.2.3-2 02:10:39 INFO - jsonschema == 2.5.1 02:10:39 INFO - manifestparser == 1.1 02:10:39 INFO - mozInstall == 1.12 02:10:39 INFO - mozcrash == 0.17 02:10:39 INFO - mozdebug == 0.1 02:10:39 INFO - mozdevice == 0.48 02:10:39 INFO - mozfile == 1.2 02:10:39 INFO - mozhttpd == 0.7 02:10:39 INFO - mozinfo == 0.9 02:10:39 INFO - mozleak == 0.1 02:10:39 INFO - mozlog == 3.2 02:10:39 INFO - moznetwork == 0.27 02:10:39 INFO - mozprocess == 0.22 02:10:39 INFO - mozprofile == 0.28 02:10:39 INFO - mozrunner == 6.11 02:10:39 INFO - mozscreenshot == 0.1 02:10:39 INFO - mozsystemmonitor == 0.3 02:10:39 INFO - moztest == 0.7 02:10:39 INFO - mozversion == 1.4 02:10:39 INFO - psutil == 3.1.1 02:10:39 INFO - requests == 1.2.3 02:10:39 INFO - wsgiref == 0.1.2 02:10:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:10:39 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')]} 02:10:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:10:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:39 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')]} 02:10:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:10:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:39 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 0x2661030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2922180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29203b0>, '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 0x29212b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2921740>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1467794203.396150-714700313', '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 02:10:39 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 02:10:39 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 02:10:39 INFO - Using env: {'DISPLAY': ':0', 02:10:39 INFO - 'HOME': '/home/cltbld', 02:10:39 INFO - 'LANG': 'en_US.UTF-8', 02:10:39 INFO - 'LANGUAGE': 'en_US:en', 02:10:39 INFO - 'LOGNAME': 'cltbld', 02:10:39 INFO - 'MAIL': '/var/mail/cltbld', 02:10:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:10:39 INFO - 'MOZ_NO_REMOTE': '1', 02:10:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:10:39 INFO - 'NO_EM_RESTART': '1', 02:10:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:10:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:10:39 INFO - 'PWD': '/builds/slave/test', 02:10:39 INFO - 'SHELL': '/bin/bash', 02:10:39 INFO - 'SHLVL': '1', 02:10:39 INFO - 'TERM': 'linux', 02:10:39 INFO - 'TMOUT': '86400', 02:10:39 INFO - 'USER': 'cltbld', 02:10:39 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1467794203.396150-714700313', 02:10:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:10:39 INFO - '_': '/tools/buildbot/bin/python'} 02:10:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:10:40 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)) 02:10:40 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)) 02:10:40 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)) 02:10:40 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)) 02:10:40 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)) 02:10:40 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)) 02:10:40 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)) 02:10:40 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)) 02:10:40 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)) 02:10:40 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)) 02:10:40 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)) 02:10:40 INFO - Cleaning up... 02:10:40 INFO - Return code: 0 02:10:40 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:10: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')]} 02:10:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:10:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10: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')]} 02:10:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:10:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2661030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2922180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29203b0>, '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 0x29212b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2921740>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1467794203.396150-714700313', '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 02:10:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:10:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:10:40 INFO - Using env: {'DISPLAY': ':0', 02:10:40 INFO - 'HOME': '/home/cltbld', 02:10:40 INFO - 'LANG': 'en_US.UTF-8', 02:10:40 INFO - 'LANGUAGE': 'en_US:en', 02:10:40 INFO - 'LOGNAME': 'cltbld', 02:10:40 INFO - 'MAIL': '/var/mail/cltbld', 02:10:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:10:40 INFO - 'MOZ_NO_REMOTE': '1', 02:10:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:10:40 INFO - 'NO_EM_RESTART': '1', 02:10:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:10:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:10:40 INFO - 'PWD': '/builds/slave/test', 02:10:40 INFO - 'SHELL': '/bin/bash', 02:10:40 INFO - 'SHLVL': '1', 02:10:40 INFO - 'TERM': 'linux', 02:10:40 INFO - 'TMOUT': '86400', 02:10:40 INFO - 'USER': 'cltbld', 02:10:40 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1467794203.396150-714700313', 02:10:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:10:40 INFO - '_': '/tools/buildbot/bin/python'} 02:10:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:10:40 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:10:40 INFO - Cleaning up... 02:10:40 INFO - Return code: 0 02:10:40 INFO - Running post-action listener: _resource_record_post_action 02:10:40 INFO - Running post-action listener: _start_resource_monitoring 02:10:40 INFO - Starting resource monitoring. 02:10:40 INFO - ##### 02:10:40 INFO - ##### Finished create-virtualenv step (success) 02:10:40 INFO - ##### 02:10:40 INFO - ##### 02:10:40 INFO - ##### Running install step. 02:10:40 INFO - ##### 02:10:40 INFO - Running pre-action listener: _resource_record_pre_action 02:10:40 INFO - Running main action method: install 02:10:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:10:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:10:40 INFO - Reading from file tmpfile_stdout 02:10:40 INFO - Detecting whether we're running mozinstall >=1.0... 02:10:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:10:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:10:40 INFO - Reading from file tmpfile_stdout 02:10:40 INFO - Output received: 02:10:40 INFO - Usage: mozinstall [options] installer 02:10:40 INFO - Options: 02:10:40 INFO - -h, --help show this help message and exit 02:10:40 INFO - -d DEST, --destination=DEST 02:10:40 INFO - Directory to install application into. [default: 02:10:40 INFO - "/builds/slave/test"] 02:10:40 INFO - --app=APP Application being installed. [default: firefox] 02:10:40 INFO - mkdir: /builds/slave/test/build/application 02:10:40 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'] 02:10:40 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 02:10:57 INFO - Reading from file tmpfile_stdout 02:10:57 INFO - Output received: 02:10:57 INFO - /builds/slave/test/build/application/firefox/firefox 02:10:57 INFO - Running post-action listener: _resource_record_post_action 02:10:57 INFO - ##### 02:10:57 INFO - ##### Finished install step (success) 02:10:57 INFO - ##### 02:10:57 INFO - ##### 02:10:57 INFO - ##### Running run-tests step. 02:10:57 INFO - ##### 02:10:57 INFO - Running pre-action listener: _resource_record_pre_action 02:10:57 INFO - Running main action method: run_tests 02:10:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:10:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:10:57 INFO - Python 2.7.3 02:10:57 INFO - Return code: 0 02:10:57 INFO - grabbing minidump binary from tooltool 02:10:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 02:10:57 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 0x29203b0>, '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 0x29212b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2921740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:10:57 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 02:10:57 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 02:10:57 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 02:10:57 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:10:57 INFO - Return code: 0 02:10:57 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:10:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:10:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:10:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:10:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:10:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/THuULqs_TwOzg5sEogSrkA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 02:10:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/THuULqs_TwOzg5sEogSrkA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-019 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 02:10:57 INFO - Using env: {'DISPLAY': ':0', 02:10:57 INFO - 'HOME': '/home/cltbld', 02:10:57 INFO - 'LANG': 'en_US.UTF-8', 02:10:57 INFO - 'LANGUAGE': 'en_US:en', 02:10:57 INFO - 'LOGNAME': 'cltbld', 02:10:57 INFO - 'MAIL': '/var/mail/cltbld', 02:10:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:10:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:10:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:10:57 INFO - 'MOZ_NO_REMOTE': '1', 02:10:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:10:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:10:57 INFO - 'NO_EM_RESTART': '1', 02:10:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:10:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:10:57 INFO - 'PWD': '/builds/slave/test', 02:10:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:10:57 INFO - 'SHELL': '/bin/bash', 02:10:57 INFO - 'SHLVL': '1', 02:10:57 INFO - 'TERM': 'linux', 02:10:57 INFO - 'TMOUT': '86400', 02:10:57 INFO - 'USER': 'cltbld', 02:10:57 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1467794203.396150-714700313', 02:10:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:10:57 INFO - '_': '/tools/buildbot/bin/python'} 02:10:57 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/THuULqs_TwOzg5sEogSrkA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 02:10:58 INFO - mozversion application_buildid: 20160705233018 02:10:58 INFO - mozversion application_changeset: cec1ab33c0d6bdc2638e0e76566a5009f033d949 02:10:58 INFO - mozversion application_display_name: Nightly 02:10:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:10:58 INFO - mozversion application_name: Firefox 02:10:58 INFO - mozversion application_remotingname: firefox 02:10:58 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:10:58 INFO - mozversion application_vendor: Mozilla 02:10:58 INFO - mozversion application_version: 50.0a1 02:10:58 INFO - mozversion platform_buildid: 20160705233018 02:10:58 INFO - mozversion platform_changeset: cec1ab33c0d6bdc2638e0e76566a5009f033d949 02:10:58 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:10:58 INFO - mozversion platform_version: 50.0a1 02:10:58 INFO - using testdate: 1467796258 02:10:58 INFO - actual date: 1467796258 02:10:58 INFO - starting webserver on 'localhost:39282' 02:10:58 INFO - SUITE-START | Running 2 tests 02:10:58 INFO - TEST-START | dromaeo_css 02:10:58 INFO - operating with platform_type : linux_ 02:10:58 INFO - Initialising browser for dromaeo_css test... 02:10:58 INFO - TEST-INFO | started process 19776 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHeax0T/profile http://localhost:39282/getInfo.html) 02:11:02 INFO - PROCESS | 19776 | __metrics Screen width/height:1600/1200 02:11:02 INFO - PROCESS | 19776 | colorDepth:24 02:11:02 INFO - PROCESS | 19776 | Browser inner width/height: 1024/697 02:11:02 INFO - PROCESS | 19776 | __metrics 02:11:03 INFO - PROCESS | 19776 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:11:04 INFO - TEST-INFO | 19776: exit 0 02:11:04 INFO - Browser initialized. 02:11:04 INFO - Running cycle 1/1 for dromaeo_css test... 02:11:04 INFO - TEST-INFO | started process 19861 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHeax0T/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:11:16 INFO - PROCESS | 19861 | RSS: Main: 157638656 02:11:16 INFO - PROCESS | 19861 | 02:12:07 INFO - PROCESS | 19861 | 1467796327714 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] 02:14:15 INFO - PROCESS | 19861 | Cycle 1(1): loaded http://localhost:39282/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39282/tests/dromaeo/cssquery-ext.html) 02:14:16 INFO - PROCESS | 19861 | RSS: Main: 255504384 02:14:16 INFO - PROCESS | 19861 | 02:17:19 INFO - PROCESS | 19861 | Cycle 1(1): loaded http://localhost:39282/tests/dromaeo/cssquery-ext.html (next: http://localhost:39282/tests/dromaeo/cssquery-jquery.html) 02:17:19 INFO - PROCESS | 19861 | RSS: Main: 241459200 02:17:19 INFO - PROCESS | 19861 | 02:20:21 INFO - PROCESS | 19861 | Cycle 1(1): loaded http://localhost:39282/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39282/tests/dromaeo/cssquery-mootools.html) 02:20:22 INFO - PROCESS | 19861 | RSS: Main: 235257856 02:20:22 INFO - PROCESS | 19861 | 02:23:24 INFO - PROCESS | 19861 | Cycle 1(1): loaded http://localhost:39282/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39282/tests/dromaeo/cssquery-prototype.html) 02:23:24 INFO - PROCESS | 19861 | RSS: Main: 236871680 02:23:24 INFO - PROCESS | 19861 | 02:26:27 INFO - PROCESS | 19861 | Cycle 1(1): loaded http://localhost:39282/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39282/tests/dromaeo/cssquery-yui.html) 02:26:28 INFO - PROCESS | 19861 | RSS: Main: 220463104 02:26:28 INFO - PROCESS | 19861 | 02:29:30 INFO - PROCESS | 19861 | Cycle 1(1): loaded http://localhost:39282/tests/dromaeo/cssquery-yui.html (next: http://localhost:39282/tests/dromaeo/cssquery-dojo.html) 02:29:31 INFO - PROCESS | 19861 | RSS: Main: 276201472 02:29:31 INFO - PROCESS | 19861 | 02:29:31 INFO - PROCESS | 19861 | __start_tp_report 02:29:31 INFO - PROCESS | 19861 | _x_x_mozilla_page_load 02:29:31 INFO - PROCESS | 19861 | _x_x_mozilla_page_load_details 02:29:31 INFO - PROCESS | 19861 | |i|pagename|runs| 02:29:31 INFO - PROCESS | 19861 | |0;dojo.html;3001.1896787867277;3021.924451888704;3049;3051.023672424822;3066.6166729158854;5078.5175408336145;5143.099957507436;5170.121079416499;5205.219217117429;5297.576193904483;5157.664751791131;5159.613029022829;5216.008958297921;5230.137027390486;5236.738163091849;4756.643251756115;4828.97585512072;4839.951600483985;4845.830395936143;4979.975100124512;4846;4847.44254410742;4877.02459508098;4898.995705880304;4921.434035085975;4659.301104834268;4710.0344429392235;4719.834805781798;4733.266343716729;4773.236282194832;4723.055388922195;4729.834455794065;4787.329773831666;4791.904161916777;4832.323474713543;4736.881577960544;4751.7624118794265;4776.283557466373;4781.282807578857;4818.566329030369;5058.215976523645;5133.974330128325;5212.270282160463;5278.366596008504;5281.973590132063;5565.2486914266865;5589.804356847531;5594.86012849682;5611.7474713637985;5612.045952188097;5429;5497.39528651848;5660.066089095294;5679.574031947579;5698.544116470673;5139.691618502902;5210.244514545446;5242.580593552545;5253.238280449314;5256.526912577886;5692.6299790513485;5705.2012718219485;5755.1367294906095;5758.856028599234;5768.480836724715;5396.622236443412;5448.046591846411;5485.451454854483;5489.6980666062955;5500.779968801203;5554.944450555524;5585.078462053797;5590.133529302964;5640.774369025193;5642.746076426571;5570.944290557123;5571.0807716726285;5573.470520300565;5574.58190635704;5600.383957764642;5409.323834520685;5442.428545002796;5476.507114359727;5578.44215578447;5591.9720401397735;4263.040815816416;4263.531011588722;4267.893302667459;4303.2469317869245;4304.4834619845815;3809.5238095238096;3822.980885095557;3825.6748176404762;3860.0542866997766;3861.9034524137123;5100.846974590768;5137.897242055138;5195.090859099642;5211.895762084813;5248.029114613809;5563.193336966198;5574.665520068809;5583.776648934078;5584.078627026576;5630.014747419185;5218.08683480397;5233.607479439057;5243.764030618631;5256.737163141827;5290.92063619046;4672.602828759594;4785.688930219525;4819.903601927942;4827.927581086286;4828.299896514985;5746.367899531048;5746.454086861741;5751.367349591542;5752.482276595127;5763.88472230553;5409.6213265071065;5568.749406276808;5585.664860108406;5597.916031259616;5637.5489960802215;5669.461401166883;5734.397888221677;5744.827655170351;5755.453231942959;5772.826815195551;5426.8371948841595;5433.891322173614;5444.237806706985;5480.3971563127225;5484.314460692413;5361.169018802092;5467.043267428105;5526.55787536988;5554.527865131347;5584.553235741212;5430.728463576885;5464.098423760035;5467.753951072132;5471.069918113851;5523.28197334344;5425.348958125051;5434.64674796137;5438.918416223839;5439.238506608999;5454.4101966425105;5217.50433708797;5290.25936368901;5297.311349524537;5412.512873841373;5452.6183167177915;5461;5465.9726701366235;5496.725163741717;5500.339959204921;5524.779008839601;5364.651297665795;5393.892122157614;5404.027275090364;5415.566754659697;5418.214358918013 02:29:31 INFO - PROCESS | 19861 | |1;ext.html;598.5421152818095;616.7995401494516;618.1469571990652;626.4862812493751;642.6915080761236;32437;34810.303793924104;43353.13293734124;44480.77759611206;44525;45214.32178517317;45506.77246613762;45560.54439455613;45656;45665.77167114168;8892.644294228223;9070.773230669252;9076.59155338008;9077.863832042493;9078.273738100968;8712.782180445476;8791.78020549485;8807.295416366707;8809.339299552526;8822.867656985118;8836.646534138627;8865.335099867503;8922.286217102615;8925.107489251055;8941.418807777474;8837.38138330317;8866.645334186625;8879.822403551958;8882.333824963154;8884.422512536728;8929.508877011762;9007.684731034447;9012.233960113399;9015.594298256528;9023.413478123966;42615.36076958848;42892.785536072435;43036.56963430388;43052.784736076435;43076.56923430757;3550;3596.82015899204;3628.546431696038;3700.204456041937;3738.9626103738888;32915.50626740601;33026.83486582552;33161.83419082913;33180.66819331824;35001;4251.532331443539;4271.722338048048;4278.614924656796;4293.842735144944;4339.652827773771;335442;336594;336655;337061;337077;57751;57960;57967;57992.420075798706;58009.70995144997;35550.82224588861;36411.4538281926;36493.635063649555;38021.80989095092;38133.23733525314;17340.826591734174;17481.737773933146;17534.473965781046;17623;17627.118644067745;11853.288802671867;11867.287962722265;11961;11963.581274655346;11965.581204657796;19464.70802937957;19501.634885557876;19542.671498188178;19668.606627867364;19717.309894153637;6877.355001849028;7161.785146445615;7182.640867956581;7226.530275532074;7365.668544915492;996.7059717383389;1124.1624989382963;1124.612008856943;1129.711923459529;1200.0939290835538;31372.372552549277;32184.195395114843;32544.93188351456;32627.18432039218;32637.184070397954;1081.621432498635;1095.3537412926253;1105.8728246251785;1107.4960892793758;1164.557468162093;17069.7439538407;17071.40250091241;17075.316987320617;17181;17206.31174753021;540093;543644;544925;547060;547812;58796.706016469645;59448;59493;59506.40493595095;59543.70228148918;1219.7377563823643;1296.4101333893245;1302.1666133674646;1333.1934179821262;1359.714459963399;29651.26369185425;32898;32962.34075318528;33053;33098.12963367848;50565.74717126391;51389.65967212119;51467.48532514777;51486.74256628693;51510;378864;381558;381570;381729;382215;24631.014759409423;25153.371165721004;25225.87387063053;28279.575806363333;28684.42631147407;37093.443598345504;39786.83304087871;43324.35013474863;46394;46800.659967000836;37126.25747485089;39958.31442689835;40156;40815.1836963265;41115.588844111175;39654.80172599119;39722.60277397189;40520.78437646875;40639.39040914329;41126.383104254055;41474.37788433115;42407.575924240366;42811;44090;44181;35387.82306088453;36842.21051263319;37258.6274137266;38013.809930951276;38160.23679526449;28183.57724634173;28240.85879570589;28453.146405607866;28543.857280713462;28616.14151575456 02:29:31 INFO - PROCESS | 19861 | |2;jquery.html;375.58122693197095;384.09353924737616;390.4943098687199;394.4044492815848;416.39414651681807;14821.333040013198;17185.398511052117;19697.507562310948;20072.397828065146;20087.899560502177;17740.556486087822;18180.81819181811;18391.08044597768;18420.355287564937;18465.35371262006;4268.40242366069;5658.603897727161;5862.355140934494;5864.970675146618;5866.266716660418;4894.5594896459315;6597;6600.735970561172;6684.331566843325;6711.395974362306;6326.841828954267;6554.016897465371;6572.07990881277;6597.703103360361;6640.7343706251695;6289.937100628981;6529.183852018497;6543.247526534438;6548.639824809634;6576.901346479806;5784.334801497839;5788.88422231553;5802.042662960606;5802.245708057968;5802.506786923074;23741.643875341884;23812.761872381227;23815.404614884592;23893.805309734445;24354;2373.133806160756;2401.183597576815;2401.6277476991095;2449.3631655769627;2465.0879174705296;14063.789043164361;14816.925915370462;14999.550013499613;15178.165200913945;15338.386464541405;1953.2479995201807;1966.8426525877896;1966.8918209498615;2006.2075480185244;2011.6077364913847;82222.17777822205;82635;84320.57839710762;84345.15654843434;84552.57723711403;10507.579696812041;10667.253292269466;10817.78364432707;10866.293690910066;10938.671839844817;14525.854741452662;14607.488737894122;14625;14631.634209144857;14645.560633181021;8127.796805079802;8132.390070744717;8244.54654993981;8246.134155913544;8267.214614611603;7925.167857375008;7955.363570914313;8052.637631306488;8092.069412017693;8201.097879233279;6464.41820236181;6530.869382612321;6675.6662166891465;6682.565633233824;6782.491313151533;1879.9696327965764;1898.430470858737;1901.2395041983318;1911.7897031326543;1935.4870959195825;892.1479986612769;994.6717583197527;995.8804943406838;1026.343140390151;1081.124289325633;19851.404457866287;19867.701984470244;19871.503212419804;19886.105125269107;19933.501662458555;1031.200819364998;1036.9325993810528;1040.1262939131166;1049.821530339844;1076.5693722510903;10893.891061089445;11282.323060616389;11352.205345625727;11371.886281137247;11385.373804440835;461249;467664;468265;468654;470590;52746;87234.56382718173;89214.55392723125;89451.55274223587;89858;995.2485873165858;1014.7260239735231;1048.6749107776461;1050.0497050169608;1056.9101626361692;17550.648987019933;17608.29566817313;17986.37047703324;18038.278468861623;18104.678905493307;40272.395914060726;44234.33648495211;45140.32289515594;45548.54451455443;46617.53382466132;54154.45845541652;59625.70187149037;60892.6955365238;61429;61984.52061917473;5351.357837059578;5441.993231252231;8382.958085209535;8825.426347287406;8891.19979201875;12241.755164896475;13746.106503077268;13828.516001939885;13933.721325573635;14297.142171469744;11610.477528511406;11666.125040622157;11916.16586838913;12063.939680301542;12496.31270280107;11832.940835295769;11843.70390740204;11869.5845645402;11947.342896140795;12310.692232693897;11758.176927614984;11848.763024739284;12100.273983561014;12122.393880305774;12625.558105466265;8513.489190648581;8716.956415218137;8779.868301975348;8858.955705221433;9051.185393314634;5487.890242195213;8498.74503764888;9944.602215911282;11284.492197851281;12296.631101066982 02:29:31 INFO - PROCESS | 19861 | |3;mootools.html;1355.9389827457762;1472.9999999999998;1505.5182341650673;1630.217495602111;1767.6553072150937;8346.958265208681;8739.650413983441;8743.562821858914;8967.327450441211;8985.595648195831;8718.258947989429;8780.868286975685;8894.644214231423;8901;8919.331050171231;1883.7362769212252;1930.1121484117323;2194.714687090676;2237.597232498146;2260.4348912771807;2265.275111964172;2276.1805749930013;2277.3281881844896;2281.9885900570475;2285.0859656137513;2240.204727321802;2241.4844585745286;2276.8178545716305;2277.658351247318;2279.4985103277336;1873.1383563560846;1925.922963081475;1926.5376309685576;2097.9895100524554;2176.9020394082227;2234.7765223477686;2261.8869056547105;2266.410733209361;2266.7279926408773;2268.4442311633757;8804;8816.382853200279;8829.602667879897;8837.955810220908;8845.778855528599;4910.803567857281;5033.219850923113;5035.144025515671;5036.697798132123;5040.395152581677;3175.872965081394;3234.75739319552;3306.50402439636;3307.851146698404;3315.370079684852;1002.1832206751474;1039.2725092435326;1053.3100818963592;1057.6351158850262;1093.4095588382343;12611;12637.684057898627;12665.873341266562;12670.873291267062;12677.302748348837;4361.542038086019;4438.755868427267;4474.686771925999;4546.181687296253;4609.423822022247;10676.572937082585;10774.353538787698;10777.946110269399;10779.892201078046;10781.892181078245;5187.792488300502;5205.765740541685;5214.634975551675;5216.321878155892;5221.13851214553;4165.10450253197;4505.346724724896;4584.541545845455;4632.5135860734135;4669.603083737852;3807.5240594925635;3903.648671619511;3914.1388894443176;3944.9605503944595;3992.1017771001293;1113.8050841102774;1171.5255321594768;1234.4198226833373;1245.8131280308025;1255.2468518888777;862.2972277593741;941.6045260990263;947.5972711597543;954.613381580461;969.8739163908647;5824.155497452845;5851.707414629252;5976.551758618121;5978.3124940631515;6194.101855231056;973.6202880876464;987.1146110928092;1006.4967516241879;1016.1972042086669;1030.5208078243652;3907.492026036597;3992.720509564361;4096.959030409717;4126.649234815014;4196;10467.94766026165;10783;10900.836487452694;10943.671689849158;10954.123670106372;10745.462726863781;10774.838377424345;10777.946110269555;10786.406747628957;10831.620893268699;7985.8402831944195;8130.634121464548;8202.425830191829;8208.630611622491;8209.507429554127;5988.461038506381;5990.820275391745;6049.395060494091;6259.809066826574;6290.370962903673;10381.169506439315;10561.10230630405;10562.102221310966;10582;10583.047525722413;10156.339837910513;10494.737631559272;10836.620718274822;10845.728856778644;10861.511231994422;8723.956380218313;8823.823523529365;8886.111388861062;8892.866607000771;8900.109989001307;8137.511749295061;8465.407421480684;8546.700865469678;8623.180797824196;8775.07861674515;6107.9083813741945;7294.562326260441;7340.559566426032;7387.482876198615;7484.775456736306;6973.093497845248;7052.717891284291;7119.537230080028;7223.8555228896175;7274.709011639687;7010.824729381602;7021.543599666005;7056.294370563108;7074.893876591958;7090.680919358538;4869.220924652039;5084.21194714805;5098.97450512745;5181.3782346118705;5230.869228269172;5044.4451110377095;5056.494350565061;5069.822556210515;5075.238714192753;5121.129408000724 02:29:31 INFO - PROCESS | 19861 | |4;prototype.html;312.5046800820699;312.596750192252;325.87616705651857;330.5471504039465;332.77703938361293;5323.920141197885;5353.678779273237;5390.703511306877;5418.399168399171;5429.972850135749;5077.6953382797055;5116.820911268106;5256.817216126369;5299.28459657946;5347.25138480613;4127.793610319487;4153.916921661565;4155.293600087993;4156.812943417538;4200.180964711874;4196.237580216317;4196.412502249687;4208.263553878074;4208.705390622642;4212.1996820604145;3959.4456776051375;3983.58172391899;4135.503739551243;4147.336426171813;4154.376843473488;4141.295979683461;4151.3150330195485;4158.459400277975;4162.979185104085;4165;3666.88160111166;3683.336999340118;3692;3693.8153092345274;3696.5933747287777;5089.745512724386;5135.666181698178;5146.356705411824;5190.896182076337;5251.238570407308;4750.239961606161;4751.40607424072;4755.096531659008;4755.833545825914;4770.856874293777;5512;5515.531179849718;5521.171824226358;5521.420250873681;5554.750036248379;3894.065424298148;3998.580503921095;4003.4795476587856;4033.032072302626;4055.3308704063793;5619.4099619540175;5625.493705566519;5641.548676105902;5663.2637757091725;5666.291713535808;4064.878053658336;4094.754314741125;4102.733322334038;4125.731827431207;4131;4088.6320231178743;4167.166566686675;4175.436316097288;4176.895577610584;4177.3316269396755;4716.551927566876;4727.3854398927915;4792.257200133985;4795.20879054959;4807.759612019385;5499.862503437366;5504.935649131576;5546.27898373217;5587.994161050969;5593.74828132735;1375.9656008599666;1378.3521744779937;1394.6861956059806;1415.9008869379045;1459.569427019032;968.1238479176357;1006.7533454303742;1008.1884083313004;1015.1979935850595;1016.6797458800454;5123.949590333973;5262.631615786935;5286.233496143038;5317.494837990384;5340.572754179656;5669.477082698159;5678.432156784289;5695.914561281584;5698;5701.657900525982;5156.690598564098;5249.658772179796;5300.595342234311;5346.727640752664;5358.5981051421295;3052.3437460946;3055.8624861881267;3066.325408410191;3068.6624471308137;3073.3699591583672;5908.202392676933;5930.347661757203;5936.317323507766;5956.76172953077;5971.880562388728;5621.7189140542805;5915.704214789243;5916;5919.585629005928;5941.55438342126;5917.171595976567;5937.821865344046;5943.9598070337515;5951;5955.106733989936;5547.2511210986;5739.799107031234;5841.737121829443;5855;5855.590108692521;5658.924804287172;5664.207011018379;5678.829635110953;5706.343770466284;5707.286589176353;5931.220633809926;5936.614120082181;5977.521798256216;5981.132735753378;5991.281046274475;3970.7617542947514;4117.56765539626;4164.58404142593;4194.727342722713;4215.156968606352;5613.775448981995;5690.544756419559;5699.487046165865;5725.942740572541;5747.48272655463;5421.2681288025615;5476.2607048048;5581.7767289309595;5619.325680918152;5630;5537.889242215214;5543.584231182758;5564.777408903598;5571.526420254324;5588.692621905834;5339.252504649275;5523.226748255167;5529.640573362719;5533.391326954113;5556.583256255716;5600.579956503197;5609.9158512621525;5617.213590097472;5626.465485778845;5643.009205121292;5490.6431081979545;5500.1749737539685;5505.834824955257;5532.640378375393;5551.916721249266 02:29:31 INFO - PROCESS | 19861 | |5;yui.html;774.3843644302782;776.9805754856128;807.4670717326562;810.6068556749972;851.1743608699559;14953.401863925443;16145.273462694178;16167.43413980511;16291.755623665655;16825.91587042063;15901.681966360666;15954;16042.278097485612;16069.116198609101;16075.91962040188;670.3497607320891;809.878518222267;821.1788211788212;822.1696086952192;823.17271142502;787.8700014497601;805.3798575097171;807.9919200808005;810.5744484145841;811.0308181722844;862.0991064337751;862.9827403451927;866.1728049712541;866.5883705240024;872.3457406944791;692.3595674001529;840.7603832907653;864.8356812205661;865.4461144867258;865.9350548708841;626.8934281172166;628.0955424189153;628.8365025093509;628.8522197283635;630.2877748144613;14527.128372297697;14555.927220363936;14561.199134047623;14565.126092434488;14578.927105364406;14257.71484570313;14477.348519316656;14548.927255363655;14553.927230363886;14733;12859.16415432994;12888.677783055498;12959.935200323938;12972.091953563255;13394.598162055154;4646.907061858744;4708.458527269374;4713.2458806590785;4789.736564488987;4844.951550484485;58175.41824581785;58240;58479.12281315784;58935.41064589342;59404.70297648527;10436.360735511185;10902.127829773599;10962.451877406098;11915.880841191478;11951.22317049389;19527;20044.799552004584;20643.27748528794;20797.168113275602;20845.270415535382;7763.978243360161;7799.103103143211;8004.07953085391;8094.595270236582;8313.6674533018;4865.9026819463415;4891;4894.363732714795;5105.438401775802;5117.437081920985;3462.774919630266;3585.8207089645935;3594.3530164570107;3596.1549035976523;3598.4962105305276;633.654658211276;644.7421031587403;649.9707513161919;649.9902501462482;650.8405440667067;722.8120688620996;730.4010711216857;746.4028776978396;747.637395863006;774;9391.248700104112;9453.90546094544;9498.810023799486;9778.804423911482;10192.082712555906;636.462189449914;646.253577118429;725.4631572636212;759.3886921028515;760.015779565453;4600.53994600544;4985.675931064469;4990.3762029746285;5001.574866136347;5038.34501514808;100083.49958250162;102960.48519757354;103948.48025759823;110784;117217;92794;99461.50269248753;100270;100873;101426.49286753667;90324.5483772577;91115;91371.62942555867;92190.53904730434;93408.92841965251;9768;10059.949700251746;10286.125679317342;10424.436334549879;10427.94786026065;51562.74218628883;52733.47266527286;52987;53815.192772109236;55225.171622424896;75344;79689.60155199187;81404;81602;82123.17876821394;13002.804957925828;14391.856081439051;14451.92774036123;14486.927565362106;14748.63128421798;15330.616734581725;15503.651529748717;15612.141332226382;15634.374625014872;16260.349586016428;14046.578602641937;14253.786193207317;14766;14931.402743890558;14992.625184370478;14403.42386304536;14416.711665766836;14970.17664028489;15019.549413517612;15079.773803392738;13698.65753356174;13800.171989680652;14169.645758856112;14299.07056041354;14354.138751674933;10274.794504110025;10412;10615.522301496298;11081.5567377304;11101.11191104726;11188.944055279997;11217.66347009591;11440.781137419497;11556.47995840206;11654.941725291319 02:29:31 INFO - PROCESS | 19861 | __end_tp_report 02:29:31 INFO - PROCESS | 19861 | __start_cc_report 02:29:31 INFO - PROCESS | 19861 | _x_x_mozilla_cycle_collect,855 02:29:31 INFO - PROCESS | 19861 | __end_cc_report 02:29:31 INFO - PROCESS | 19861 | __startTimestamp1467797371126__endTimestamp 02:29:31 INFO - PROCESS | 19861 | 02:29:31 INFO - PROCESS | 19861 | ------- Summary: start ------- 02:29:31 INFO - PROCESS | 19861 | Number of tests: 6 02:29:31 INFO - PROCESS | 19861 | 02:29:31 INFO - PROCESS | 19861 | [#0] dojo.html Cycles:165 Average:5180.09 Median:5404.03 stddev:573.87 (10.6%) stddev-sans-first:549.59 02:29:31 INFO - PROCESS | 19861 | Values: 3001.2 3021.9 3049.0 3051.0 3066.6 5078.5 5143.1 5170.1 5205.2 5297.6 5157.7 5159.6 5216.0 5230.1 5236.7 4756.6 4829.0 4840.0 4845.8 4980.0 4846.0 4847.4 4877.0 4899.0 4921.4 4659.3 4710.0 4719.8 4733.3 4773.2 4723.1 4729.8 4787.3 4791.9 4832.3 4736.9 4751.8 4776.3 4781.3 4818.6 5058.2 5134.0 5212.3 5278.4 5282.0 5565.2 5589.8 5594.9 5611.7 5612.0 5429.0 5497.4 5660.1 5679.6 5698.5 5139.7 5210.2 5242.6 5253.2 5256.5 5692.6 5705.2 5755.1 5758.9 5768.5 5396.6 5448.0 5485.5 5489.7 5500.8 5554.9 5585.1 5590.1 5640.8 5642.7 5570.9 5571.1 5573.5 5574.6 5600.4 5409.3 5442.4 5476.5 5578.4 5592.0 4263.0 4263.5 4267.9 4303.2 4304.5 3809.5 3823.0 3825.7 3860.1 3861.9 5100.8 5137.9 5195.1 5211.9 5248.0 5563.2 5574.7 5583.8 5584.1 5630.0 5218.1 5233.6 5243.8 5256.7 5290.9 4672.6 4785.7 4819.9 4827.9 4828.3 5746.4 5746.5 5751.4 5752.5 5763.9 5409.6 5568.7 5585.7 5597.9 5637.5 5669.5 5734.4 5744.8 5755.5 5772.8 5426.8 5433.9 5444.2 5480.4 5484.3 5361.2 5467.0 5526.6 5554.5 5584.6 5430.7 5464.1 5467.8 5471.1 5523.3 5425.3 5434.6 5438.9 5439.2 5454.4 5217.5 5290.3 5297.3 5412.5 5452.6 5461.0 5466.0 5496.7 5500.3 5524.8 5364.7 5393.9 5404.0 5415.6 5418.2 02:29:31 INFO - PROCESS | 19861 | 02:29:31 INFO - PROCESS | 19861 | [#1] ext.html Cycles:180 Average:57837.57 Median:39872.57 stddev:114077.14 (286.1%) stddev-sans-first:114316.20 02:29:31 INFO - PROCESS | 19861 | Values: 598.5 616.8 618.1 626.5 642.7 32437.0 34810.3 43353.1 44480.8 44525.0 45214.3 45506.8 45560.5 45656.0 45665.8 8892.6 9070.8 9076.6 9077.9 9078.3 8712.8 8791.8 8807.3 8809.3 8822.9 8836.6 8865.3 8922.3 8925.1 8941.4 8837.4 8866.6 8879.8 8882.3 8884.4 8929.5 9007.7 9012.2 9015.6 9023.4 42615.4 42892.8 43036.6 43052.8 43076.6 3550.0 3596.8 3628.5 3700.2 3739.0 32915.5 33026.8 33161.8 33180.7 35001.0 4251.5 4271.7 4278.6 4293.8 4339.7 335442.0 336594.0 336655.0 337061.0 337077.0 57751.0 57960.0 57967.0 57992.4 58009.7 35550.8 36411.5 36493.6 38021.8 38133.2 17340.8 17481.7 17534.5 17623.0 17627.1 11853.3 11867.3 11961.0 11963.6 11965.6 19464.7 19501.6 19542.7 19668.6 19717.3 6877.4 7161.8 7182.6 7226.5 7365.7 996.7 1124.2 1124.6 1129.7 1200.1 31372.4 32184.2 32544.9 32627.2 32637.2 1081.6 1095.4 1105.9 1107.5 1164.6 17069.7 17071.4 17075.3 17181.0 17206.3 540093.0 543644.0 544925.0 547060.0 547812.0 58796.7 59448.0 59493.0 59506.4 59543.7 1219.7 1296.4 1302.2 1333.2 1359.7 29651.3 32898.0 32962.3 33053.0 33098.1 50565.7 51389.7 51467.5 51486.7 51510.0 378864.0 381558.0 381570.0 381729.0 382215.0 24631.0 25153.4 25225.9 28279.6 28684.4 37093.4 39786.8 43324.4 46394.0 46800.7 37126.3 39958.3 40156.0 40815.2 41115.6 39654.8 39722.6 40520.8 40639.4 41126.4 41474.4 42407.6 42811.0 44090.0 44181.0 35387.8 36842.2 37258.6 38013.8 38160.2 28183.6 28240.9 28453.1 28543.9 28616.1 02:29:31 INFO - PROCESS | 19861 | 02:29:31 INFO - PROCESS | 19861 | [#2] jquery.html Cycles:180 Average:28470.02 Median:13401.68 stddev:77037.94 (574.8%) stddev-sans-first:77225.17 02:29:31 INFO - PROCESS | 19861 | Values: 375.6 384.1 390.5 394.4 416.4 14821.3 17185.4 19697.5 20072.4 20087.9 17740.6 18180.8 18391.1 18420.4 18465.4 4268.4 5658.6 5862.4 5865.0 5866.3 4894.6 6597.0 6600.7 6684.3 6711.4 6326.8 6554.0 6572.1 6597.7 6640.7 6289.9 6529.2 6543.2 6548.6 6576.9 5784.3 5788.9 5802.0 5802.2 5802.5 23741.6 23812.8 23815.4 23893.8 24354.0 2373.1 2401.2 2401.6 2449.4 2465.1 14063.8 14816.9 14999.6 15178.2 15338.4 1953.2 1966.8 1966.9 2006.2 2011.6 82222.2 82635.0 84320.6 84345.2 84552.6 10507.6 10667.3 10817.8 10866.3 10938.7 14525.9 14607.5 14625.0 14631.6 14645.6 8127.8 8132.4 8244.5 8246.1 8267.2 7925.2 7955.4 8052.6 8092.1 8201.1 6464.4 6530.9 6675.7 6682.6 6782.5 1880.0 1898.4 1901.2 1911.8 1935.5 892.1 994.7 995.9 1026.3 1081.1 19851.4 19867.7 19871.5 19886.1 19933.5 1031.2 1036.9 1040.1 1049.8 1076.6 10893.9 11282.3 11352.2 11371.9 11385.4 461249.0 467664.0 468265.0 468654.0 470590.0 52746.0 87234.6 89214.6 89451.6 89858.0 995.2 1014.7 1048.7 1050.0 1056.9 17550.6 17608.3 17986.4 18038.3 18104.7 40272.4 44234.3 45140.3 45548.5 46617.5 54154.5 59625.7 60892.7 61429.0 61984.5 5351.4 5442.0 8383.0 8825.4 8891.2 12241.8 13746.1 13828.5 13933.7 14297.1 11610.5 11666.1 11916.2 12063.9 12496.3 11832.9 11843.7 11869.6 11947.3 12310.7 11758.2 11848.8 12100.3 12122.4 12625.6 8513.5 8717.0 8779.9 8859.0 9051.2 5487.9 8498.7 9944.6 11284.5 12296.6 02:29:31 INFO - PROCESS | 19861 | 02:29:31 INFO - PROCESS | 19861 | [#3] mootools.html Cycles:180 Average:5798.80 Median:4456.72 stddev:3404.28 (76.4%) stddev-sans-first:3397.46 02:29:31 INFO - PROCESS | 19861 | Values: 1355.9 1473.0 1505.5 1630.2 1767.7 8347.0 8739.7 8743.6 8967.3 8985.6 8718.3 8780.9 8894.6 8901.0 8919.3 1883.7 1930.1 2194.7 2237.6 2260.4 2265.3 2276.2 2277.3 2282.0 2285.1 2240.2 2241.5 2276.8 2277.7 2279.5 1873.1 1925.9 1926.5 2098.0 2176.9 2234.8 2261.9 2266.4 2266.7 2268.4 8804.0 8816.4 8829.6 8838.0 8845.8 4910.8 5033.2 5035.1 5036.7 5040.4 3175.9 3234.8 3306.5 3307.9 3315.4 1002.2 1039.3 1053.3 1057.6 1093.4 12611.0 12637.7 12665.9 12670.9 12677.3 4361.5 4438.8 4474.7 4546.2 4609.4 10676.6 10774.4 10777.9 10779.9 10781.9 5187.8 5205.8 5214.6 5216.3 5221.1 4165.1 4505.3 4584.5 4632.5 4669.6 3807.5 3903.6 3914.1 3945.0 3992.1 1113.8 1171.5 1234.4 1245.8 1255.2 862.3 941.6 947.6 954.6 969.9 5824.2 5851.7 5976.6 5978.3 6194.1 973.6 987.1 1006.5 1016.2 1030.5 3907.5 3992.7 4097.0 4126.6 4196.0 10467.9 10783.0 10900.8 10943.7 10954.1 10745.5 10774.8 10777.9 10786.4 10831.6 7985.8 8130.6 8202.4 8208.6 8209.5 5988.5 5990.8 6049.4 6259.8 6290.4 10381.2 10561.1 10562.1 10582.0 10583.0 10156.3 10494.7 10836.6 10845.7 10861.5 8724.0 8823.8 8886.1 8892.9 8900.1 8137.5 8465.4 8546.7 8623.2 8775.1 6107.9 7294.6 7340.6 7387.5 7484.8 6973.1 7052.7 7119.5 7223.9 7274.7 7010.8 7021.5 7056.3 7074.9 7090.7 4869.2 5084.2 5099.0 5181.4 5230.9 5044.4 5056.5 5069.8 5075.2 5121.1 02:29:31 INFO - PROCESS | 19861 | 02:29:31 INFO - PROCESS | 19861 | [#4] prototype.html Cycles:180 Average:4702.83 Median:5331.59 stddev:1376.10 (25.8%) stddev-sans-first:1339.92 02:29:31 INFO - PROCESS | 19861 | Values: 312.5 312.6 325.9 330.5 332.8 5323.9 5353.7 5390.7 5418.4 5430.0 5077.7 5116.8 5256.8 5299.3 5347.3 4127.8 4153.9 4155.3 4156.8 4200.2 4196.2 4196.4 4208.3 4208.7 4212.2 3959.4 3983.6 4135.5 4147.3 4154.4 4141.3 4151.3 4158.5 4163.0 4165.0 3666.9 3683.3 3692.0 3693.8 3696.6 5089.7 5135.7 5146.4 5190.9 5251.2 4750.2 4751.4 4755.1 4755.8 4770.9 5512.0 5515.5 5521.2 5521.4 5554.8 3894.1 3998.6 4003.5 4033.0 4055.3 5619.4 5625.5 5641.5 5663.3 5666.3 4064.9 4094.8 4102.7 4125.7 4131.0 4088.6 4167.2 4175.4 4176.9 4177.3 4716.6 4727.4 4792.3 4795.2 4807.8 5499.9 5504.9 5546.3 5588.0 5593.7 1376.0 1378.4 1394.7 1415.9 1459.6 968.1 1006.8 1008.2 1015.2 1016.7 5123.9 5262.6 5286.2 5317.5 5340.6 5669.5 5678.4 5695.9 5698.0 5701.7 5156.7 5249.7 5300.6 5346.7 5358.6 3052.3 3055.9 3066.3 3068.7 3073.4 5908.2 5930.3 5936.3 5956.8 5971.9 5621.7 5915.7 5916.0 5919.6 5941.6 5917.2 5937.8 5944.0 5951.0 5955.1 5547.3 5739.8 5841.7 5855.0 5855.6 5658.9 5664.2 5678.8 5706.3 5707.3 5931.2 5936.6 5977.5 5981.1 5991.3 3970.8 4117.6 4164.6 4194.7 4215.2 5613.8 5690.5 5699.5 5725.9 5747.5 5421.3 5476.3 5581.8 5619.3 5630.0 5537.9 5543.6 5564.8 5571.5 5588.7 5339.3 5523.2 5529.6 5533.4 5556.6 5600.6 5609.9 5617.2 5626.5 5643.0 5490.6 5500.2 5505.8 5532.6 5551.9 02:29:31 INFO - PROCESS | 19861 | 02:29:31 INFO - PROCESS | 19861 | [#5] yui.html Cycles:180 Average:20657.58 Median:4710.85 stddev:29115.15 (618.0%) stddev-sans-first:29158.55 02:29:31 INFO - PROCESS | 19861 | Values: 774.4 777.0 807.5 810.6 851.2 14953.4 16145.3 16167.4 16291.8 16825.9 15901.7 15954.0 16042.3 16069.1 16075.9 670.3 809.9 821.2 822.2 823.2 787.9 805.4 808.0 810.6 811.0 862.1 863.0 866.2 866.6 872.3 692.4 840.8 864.8 865.4 865.9 626.9 628.1 628.8 628.9 630.3 14527.1 14555.9 14561.2 14565.1 14578.9 14257.7 14477.3 14548.9 14553.9 14733.0 12859.2 12888.7 12959.9 12972.1 13394.6 4646.9 4708.5 4713.2 4789.7 4845.0 58175.4 58240.0 58479.1 58935.4 59404.7 10436.4 10902.1 10962.5 11915.9 11951.2 19527.0 20044.8 20643.3 20797.2 20845.3 7764.0 7799.1 8004.1 8094.6 8313.7 4865.9 4891.0 4894.4 5105.4 5117.4 3462.8 3585.8 3594.4 3596.2 3598.5 633.7 644.7 650.0 650.0 650.8 722.8 730.4 746.4 747.6 774.0 9391.2 9453.9 9498.8 9778.8 10192.1 636.5 646.3 725.5 759.4 760.0 4600.5 4985.7 4990.4 5001.6 5038.3 100083.5 102960.5 103948.5 110784.0 117217.0 92794.0 99461.5 100270.0 100873.0 101426.5 90324.5 91115.0 91371.6 92190.5 93408.9 9768.0 10059.9 10286.1 10424.4 10427.9 51562.7 52733.5 52987.0 53815.2 55225.2 75344.0 79689.6 81404.0 81602.0 82123.2 13002.8 14391.9 14451.9 14486.9 14748.6 15330.6 15503.7 15612.1 15634.4 16260.3 14046.6 14253.8 14766.0 14931.4 14992.6 14403.4 14416.7 14970.2 15019.5 15079.8 13698.7 13800.2 14169.6 14299.1 14354.1 10274.8 10412.0 10615.5 11081.6 11101.1 11188.9 11217.7 11440.8 11556.5 11654.9 02:29:31 INFO - PROCESS | 19861 | -------- Summary: end -------- 02:29:31 INFO - PROCESS | 19861 | 02:29:31 INFO - TEST-INFO | 19861: exit 0 02:29:31 INFO - TEST-OK | dromaeo_css | took 1113740ms 02:29:31 INFO - TEST-START | kraken 02:29:31 INFO - operating with platform_type : linux_ 02:29:31 INFO - Initialising browser for kraken test... 02:29:31 INFO - TEST-INFO | started process 20054 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCKvtTc/profile http://localhost:39282/getInfo.html) 02:29:35 INFO - PROCESS | 20054 | __metrics Screen width/height:1600/1200 02:29:35 INFO - PROCESS | 20054 | colorDepth:24 02:29:35 INFO - PROCESS | 20054 | Browser inner width/height: 1024/697 02:29:35 INFO - PROCESS | 20054 | __metrics 02:29:37 INFO - PROCESS | 20054 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:29:37 INFO - TEST-INFO | 20054: exit 0 02:29:37 INFO - Browser initialized. 02:29:37 INFO - Running cycle 1/1 for kraken test... 02:29:38 INFO - TEST-INFO | started process 20137 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCKvtTc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:29:49 INFO - PROCESS | 20137 | RSS: Main: 157396992 02:29:49 INFO - PROCESS | 20137 | 02:29:52 INFO - PROCESS | 20137 | Cycle 1(1): loaded http://localhost:39282/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39282/tests/kraken/driver.html?testName=audio-beat-detection) 02:29:53 INFO - PROCESS | 20137 | RSS: Main: 215793664 02:29:53 INFO - PROCESS | 20137 | 02:29:55 INFO - PROCESS | 20137 | Cycle 1(1): loaded http://localhost:39282/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39282/tests/kraken/driver.html?testName=audio-dft) 02:29:56 INFO - PROCESS | 20137 | RSS: Main: 203362304 02:29:56 INFO - PROCESS | 20137 | 02:29:59 INFO - PROCESS | 20137 | Cycle 1(1): loaded http://localhost:39282/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39282/tests/kraken/driver.html?testName=audio-fft) 02:30:00 INFO - PROCESS | 20137 | RSS: Main: 269918208 02:30:00 INFO - PROCESS | 20137 | 02:30:02 INFO - PROCESS | 20137 | Cycle 1(1): loaded http://localhost:39282/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39282/tests/kraken/driver.html?testName=audio-oscillator) 02:30:02 INFO - PROCESS | 20137 | RSS: Main: 181174272 02:30:02 INFO - PROCESS | 20137 | 02:30:05 INFO - PROCESS | 20137 | Cycle 1(1): loaded http://localhost:39282/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39282/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:30:05 INFO - PROCESS | 20137 | RSS: Main: 185290752 02:30:05 INFO - PROCESS | 20137 | 02:30:08 INFO - PROCESS | 20137 | Cycle 1(1): loaded http://localhost:39282/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39282/tests/kraken/driver.html?testName=imaging-darkroom) 02:30:09 INFO - PROCESS | 20137 | RSS: Main: 219815936 02:30:09 INFO - PROCESS | 20137 | 02:30:12 INFO - PROCESS | 20137 | Cycle 1(1): loaded http://localhost:39282/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39282/tests/kraken/driver.html?testName=imaging-desaturate) 02:30:13 INFO - PROCESS | 20137 | RSS: Main: 222179328 02:30:13 INFO - PROCESS | 20137 | 02:30:16 INFO - PROCESS | 20137 | Cycle 1(1): loaded http://localhost:39282/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39282/tests/kraken/driver.html?testName=json-parse-financial) 02:30:16 INFO - PROCESS | 20137 | RSS: Main: 221376512 02:30:16 INFO - PROCESS | 20137 | 02:30:18 INFO - PROCESS | 20137 | Cycle 1(1): loaded http://localhost:39282/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39282/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:30:18 INFO - PROCESS | 20137 | RSS: Main: 208293888 02:30:18 INFO - PROCESS | 20137 | 02:30:20 INFO - PROCESS | 20137 | Cycle 1(1): loaded http://localhost:39282/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39282/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:30:21 INFO - PROCESS | 20137 | RSS: Main: 212393984 02:30:21 INFO - PROCESS | 20137 | 02:30:23 INFO - PROCESS | 20137 | Cycle 1(1): loaded http://localhost:39282/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39282/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:30:23 INFO - PROCESS | 20137 | RSS: Main: 209805312 02:30:23 INFO - PROCESS | 20137 | 02:30:26 INFO - PROCESS | 20137 | Cycle 1(1): loaded http://localhost:39282/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39282/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:30:26 INFO - PROCESS | 20137 | RSS: Main: 224546816 02:30:26 INFO - PROCESS | 20137 | 02:30:29 INFO - PROCESS | 20137 | Cycle 1(1): loaded http://localhost:39282/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39282/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:30:30 INFO - PROCESS | 20137 | RSS: Main: 224485376 02:30:30 INFO - PROCESS | 20137 | 02:30:31 INFO - PROCESS | 20137 | Cycle 1(1): loaded http://localhost:39282/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39282/tests/kraken/driver.html?testName=ai-astar) 02:30:32 INFO - PROCESS | 20137 | RSS: Main: 267071488 02:30:32 INFO - PROCESS | 20137 | 02:30:32 INFO - PROCESS | 20137 | __start_tp_report 02:30:32 INFO - PROCESS | 20137 | _x_x_mozilla_page_load 02:30:32 INFO - PROCESS | 20137 | _x_x_mozilla_page_load_details 02:30:32 INFO - PROCESS | 20137 | |i|pagename|runs| 02:30:32 INFO - PROCESS | 20137 | |0;ai-astar;102;112;111;110;110;110;113;111;109;111 02:30:32 INFO - PROCESS | 20137 | |1;audio-beat-detection;144;116;118;186;119;123;154;117;157;117 02:30:32 INFO - PROCESS | 20137 | |2;audio-dft;161;160;160;159;160;161;162;160;161;161 02:30:32 INFO - PROCESS | 20137 | |3;audio-fft;75;74;75;113;74;76;73;74;111;76 02:30:32 INFO - PROCESS | 20137 | |4;audio-oscillator;84;84;122;84;85;84;122;84;83;136 02:30:32 INFO - PROCESS | 20137 | |5;imaging-gaussian-blur;116;117;116;117;116;117;116;117;117;119 02:30:32 INFO - PROCESS | 20137 | |6;imaging-darkroom;147;146;145;145;145;146;146;146;145;146 02:30:32 INFO - PROCESS | 20137 | |7;imaging-desaturate;95;96;95;95;95;95;97;95;96;95 02:30:32 INFO - PROCESS | 20137 | |8;json-parse-financial;55;54;53;54;53;54;56;54;53;52 02:30:32 INFO - PROCESS | 20137 | |9;json-stringify-tinderbox;65;63;63;64;63;64;63;63;63;64 02:30:32 INFO - PROCESS | 20137 | |10;stanford-crypto-aes;76;75;75;75;74;74;74;74;74;80 02:30:32 INFO - PROCESS | 20137 | |11;stanford-crypto-ccm;121;119;121;119;121;120;121;128;177;122 02:30:32 INFO - PROCESS | 20137 | |12;stanford-crypto-pbkdf2;163;162;163;161;161;162;161;161;166;162 02:30:32 INFO - PROCESS | 20137 | |13;stanford-crypto-sha256-iterative;66;63;63;64;63;68;63;63;64;61 02:30:32 INFO - PROCESS | 20137 | __end_tp_report 02:30:32 INFO - PROCESS | 20137 | __start_cc_report 02:30:32 INFO - PROCESS | 20137 | _x_x_mozilla_cycle_collect,1688 02:30:32 INFO - PROCESS | 20137 | __end_cc_report 02:30:32 INFO - PROCESS | 20137 | __startTimestamp1467797432121__endTimestamp 02:30:32 INFO - PROCESS | 20137 | 02:30:32 INFO - PROCESS | 20137 | ------- Summary: start ------- 02:30:32 INFO - PROCESS | 20137 | Number of tests: 14 02:30:32 INFO - PROCESS | 20137 | 02:30:32 INFO - PROCESS | 20137 | [#0] ai-astar Cycles:10 Average:109.90 Median:111.00 stddev:3.00 (2.7%) stddev-sans-first:1.20 02:30:32 INFO - PROCESS | 20137 | Values: 102.0 112.0 111.0 110.0 110.0 110.0 113.0 111.0 109.0 111.0 02:30:32 INFO - PROCESS | 20137 | 02:30:32 INFO - PROCESS | 20137 | [#1] audio-beat-detection Cycles:10 Average:135.10 Median:133.50 stddev:24.09 (18.0%) stddev-sans-first:25.34 02:30:32 INFO - PROCESS | 20137 | Values: 144.0 116.0 118.0 186.0 119.0 123.0 154.0 117.0 157.0 117.0 02:30:32 INFO - PROCESS | 20137 | 02:30:32 INFO - PROCESS | 20137 | [#2] audio-dft Cycles:10 Average:160.50 Median:161.00 stddev:0.85 (0.5%) stddev-sans-first:0.88 02:30:32 INFO - PROCESS | 20137 | Values: 161.0 160.0 160.0 159.0 160.0 161.0 162.0 160.0 161.0 161.0 02:30:32 INFO - PROCESS | 20137 | 02:30:32 INFO - PROCESS | 20137 | [#3] audio-fft Cycles:10 Average:82.10 Median:74.50 stddev:15.79 (21.2%) stddev-sans-first:16.54 02:30:32 INFO - PROCESS | 20137 | Values: 75.0 74.0 75.0 113.0 74.0 76.0 73.0 74.0 111.0 76.0 02:30:32 INFO - PROCESS | 20137 | 02:30:32 INFO - PROCESS | 20137 | [#4] audio-oscillator Cycles:10 Average:96.80 Median:84.00 stddev:20.96 (25.0%) stddev-sans-first:21.72 02:30:32 INFO - PROCESS | 20137 | Values: 84.0 84.0 122.0 84.0 85.0 84.0 122.0 84.0 83.0 136.0 02:30:32 INFO - PROCESS | 20137 | 02:30:32 INFO - PROCESS | 20137 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.92 (0.8%) stddev-sans-first:0.93 02:30:32 INFO - PROCESS | 20137 | Values: 116.0 117.0 116.0 117.0 116.0 117.0 116.0 117.0 117.0 119.0 02:30:32 INFO - PROCESS | 20137 | 02:30:32 INFO - PROCESS | 20137 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.53 02:30:32 INFO - PROCESS | 20137 | Values: 147.0 146.0 145.0 145.0 145.0 146.0 146.0 146.0 145.0 146.0 02:30:32 INFO - PROCESS | 20137 | 02:30:32 INFO - PROCESS | 20137 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 02:30:32 INFO - PROCESS | 20137 | Values: 95.0 96.0 95.0 95.0 95.0 95.0 97.0 95.0 96.0 95.0 02:30:32 INFO - PROCESS | 20137 | 02:30:32 INFO - PROCESS | 20137 | [#8] json-parse-financial Cycles:10 Average:53.80 Median:54.00 stddev:1.14 (2.1%) stddev-sans-first:1.12 02:30:32 INFO - PROCESS | 20137 | Values: 55.0 54.0 53.0 54.0 53.0 54.0 56.0 54.0 53.0 52.0 02:30:32 INFO - PROCESS | 20137 | 02:30:32 INFO - PROCESS | 20137 | [#9] json-stringify-tinderbox Cycles:10 Average:63.50 Median:63.50 stddev:0.71 (1.1%) stddev-sans-first:0.50 02:30:32 INFO - PROCESS | 20137 | Values: 65.0 63.0 63.0 64.0 63.0 64.0 63.0 63.0 63.0 64.0 02:30:32 INFO - PROCESS | 20137 | 02:30:32 INFO - PROCESS | 20137 | [#10] stanford-crypto-aes Cycles:10 Average:75.10 Median:75.00 stddev:1.85 (2.5%) stddev-sans-first:1.94 02:30:32 INFO - PROCESS | 20137 | Values: 76.0 75.0 75.0 75.0 74.0 74.0 74.0 74.0 74.0 80.0 02:30:32 INFO - PROCESS | 20137 | 02:30:32 INFO - PROCESS | 20137 | [#11] stanford-crypto-ccm Cycles:10 Average:126.90 Median:121.00 stddev:17.79 (14.7%) stddev-sans-first:18.74 02:30:32 INFO - PROCESS | 20137 | Values: 121.0 119.0 121.0 119.0 121.0 120.0 121.0 128.0 177.0 122.0 02:30:32 INFO - PROCESS | 20137 | 02:30:32 INFO - PROCESS | 20137 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.20 Median:162.00 stddev:1.55 (1.0%) stddev-sans-first:1.62 02:30:32 INFO - PROCESS | 20137 | Values: 163.0 162.0 163.0 161.0 161.0 162.0 161.0 161.0 166.0 162.0 02:30:32 INFO - PROCESS | 20137 | 02:30:32 INFO - PROCESS | 20137 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.80 Median:63.50 stddev:1.93 (3.0%) stddev-sans-first:1.88 02:30:32 INFO - PROCESS | 20137 | Values: 66.0 63.0 63.0 64.0 63.0 68.0 63.0 63.0 64.0 61.0 02:30:32 INFO - PROCESS | 20137 | -------- Summary: end -------- 02:30:32 INFO - PROCESS | 20137 | 02:30:33 INFO - TEST-INFO | 20137: exit 0 02:30:33 INFO - TEST-OK | kraken | took 61340ms 02:30:33 INFO - SUITE-END | took 1175s 02:30:33 INFO - Completed test suite (00:19:35) 02:30:33 INFO - javascript benchmark 02:30:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3001.1896787867277, 3021.924451888704, 3049.0, 3051.023672424822, 3066.6166729158854, 5078.5175408336145, 5143.099957507436, 5170.121079416499, 5205.219217117429, 5297.576193904483, 5157.664751791131, 5159.613029022829, 5216.008958297921, 5230.137027390486, 5236.738163091849, 4756.643251756115, 4828.97585512072, 4839.951600483985, 4845.830395936143, 4979.975100124512, 4846.0, 4847.44254410742, 4877.02459508098, 4898.995705880304, 4921.434035085975, 4659.301104834268, 4710.0344429392235, 4719.834805781798, 4733.266343716729, 4773.236282194832, 4723.055388922195, 4729.834455794065, 4787.329773831666, 4791.904161916777, 4832.323474713543, 4736.881577960544, 4751.7624118794265, 4776.283557466373, 4781.282807578857, 4818.566329030369, 5058.215976523645, 5133.974330128325, 5212.270282160463, 5278.366596008504, 5281.973590132063, 5565.2486914266865, 5589.804356847531, 5594.86012849682, 5611.7474713637985, 5612.045952188097, 5429.0, 5497.39528651848, 5660.066089095294, 5679.574031947579, 5698.544116470673, 5139.691618502902, 5210.244514545446, 5242.580593552545, 5253.238280449314, 5256.526912577886, 5692.6299790513485, 5705.2012718219485, 5755.1367294906095, 5758.856028599234, 5768.480836724715, 5396.622236443412, 5448.046591846411, 5485.451454854483, 5489.6980666062955, 5500.779968801203, 5554.944450555524, 5585.078462053797, 5590.133529302964, 5640.774369025193, 5642.746076426571, 5570.944290557123, 5571.0807716726285, 5573.470520300565, 5574.58190635704, 5600.383957764642, 5409.323834520685, 5442.428545002796, 5476.507114359727, 5578.44215578447, 5591.9720401397735, 4263.040815816416, 4263.531011588722, 4267.893302667459, 4303.2469317869245, 4304.4834619845815, 3809.5238095238096, 3822.980885095557, 3825.6748176404762, 3860.0542866997766, 3861.9034524137123, 5100.846974590768, 5137.897242055138, 5195.090859099642, 5211.895762084813, 5248.029114613809, 5563.193336966198, 5574.665520068809, 5583.776648934078, 5584.078627026576, 5630.014747419185, 5218.08683480397, 5233.607479439057, 5243.764030618631, 5256.737163141827, 5290.92063619046, 4672.602828759594, 4785.688930219525, 4819.903601927942, 4827.927581086286, 4828.299896514985, 5746.367899531048, 5746.454086861741, 5751.367349591542, 5752.482276595127, 5763.88472230553, 5409.6213265071065, 5568.749406276808, 5585.664860108406, 5597.916031259616, 5637.5489960802215, 5669.461401166883, 5734.397888221677, 5744.827655170351, 5755.453231942959, 5772.826815195551, 5426.8371948841595, 5433.891322173614, 5444.237806706985, 5480.3971563127225, 5484.314460692413, 5361.169018802092, 5467.043267428105, 5526.55787536988, 5554.527865131347, 5584.553235741212, 5430.728463576885, 5464.098423760035, 5467.753951072132, 5471.069918113851, 5523.28197334344, 5425.348958125051, 5434.64674796137, 5438.918416223839, 5439.238506608999, 5454.4101966425105, 5217.50433708797, 5290.25936368901, 5297.311349524537, 5412.512873841373, 5452.6183167177915, 5461.0, 5465.9726701366235, 5496.725163741717, 5500.339959204921, 5524.779008839601, 5364.651297665795, 5393.892122157614, 5404.027275090364, 5415.566754659697, 5418.214358918013], "value": 5142.247408723318, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [598.5421152818095, 616.7995401494516, 618.1469571990652, 626.4862812493751, 642.6915080761236, 32437.0, 34810.303793924104, 43353.13293734124, 44480.77759611206, 44525.0, 45214.32178517317, 45506.77246613762, 45560.54439455613, 45656.0, 45665.77167114168, 8892.644294228223, 9070.773230669252, 9076.59155338008, 9077.863832042493, 9078.273738100968, 8712.782180445476, 8791.78020549485, 8807.295416366707, 8809.339299552526, 8822.867656985118, 8836.646534138627, 8865.335099867503, 8922.286217102615, 8925.107489251055, 8941.418807777474, 8837.38138330317, 8866.645334186625, 8879.822403551958, 8882.333824963154, 8884.422512536728, 8929.508877011762, 9007.684731034447, 9012.233960113399, 9015.594298256528, 9023.413478123966, 42615.36076958848, 42892.785536072435, 43036.56963430388, 43052.784736076435, 43076.56923430757, 3550.0, 3596.82015899204, 3628.546431696038, 3700.204456041937, 3738.9626103738888, 32915.50626740601, 33026.83486582552, 33161.83419082913, 33180.66819331824, 35001.0, 4251.532331443539, 4271.722338048048, 4278.614924656796, 4293.842735144944, 4339.652827773771, 335442.0, 336594.0, 336655.0, 337061.0, 337077.0, 57751.0, 57960.0, 57967.0, 57992.420075798706, 58009.70995144997, 35550.82224588861, 36411.4538281926, 36493.635063649555, 38021.80989095092, 38133.23733525314, 17340.826591734174, 17481.737773933146, 17534.473965781046, 17623.0, 17627.118644067745, 11853.288802671867, 11867.287962722265, 11961.0, 11963.581274655346, 11965.581204657796, 19464.70802937957, 19501.634885557876, 19542.671498188178, 19668.606627867364, 19717.309894153637, 6877.355001849028, 7161.785146445615, 7182.640867956581, 7226.530275532074, 7365.668544915492, 996.7059717383389, 1124.1624989382963, 1124.612008856943, 1129.711923459529, 1200.0939290835538, 31372.372552549277, 32184.195395114843, 32544.93188351456, 32627.18432039218, 32637.184070397954, 1081.621432498635, 1095.3537412926253, 1105.8728246251785, 1107.4960892793758, 1164.557468162093, 17069.7439538407, 17071.40250091241, 17075.316987320617, 17181.0, 17206.31174753021, 540093.0, 543644.0, 544925.0, 547060.0, 547812.0, 58796.706016469645, 59448.0, 59493.0, 59506.40493595095, 59543.70228148918, 1219.7377563823643, 1296.4101333893245, 1302.1666133674646, 1333.1934179821262, 1359.714459963399, 29651.26369185425, 32898.0, 32962.34075318528, 33053.0, 33098.12963367848, 50565.74717126391, 51389.65967212119, 51467.48532514777, 51486.74256628693, 51510.0, 378864.0, 381558.0, 381570.0, 381729.0, 382215.0, 24631.014759409423, 25153.371165721004, 25225.87387063053, 28279.575806363333, 28684.42631147407, 37093.443598345504, 39786.83304087871, 43324.35013474863, 46394.0, 46800.659967000836, 37126.25747485089, 39958.31442689835, 40156.0, 40815.1836963265, 41115.588844111175, 39654.80172599119, 39722.60277397189, 40520.78437646875, 40639.39040914329, 41126.383104254055, 41474.37788433115, 42407.575924240366, 42811.0, 44090.0, 44181.0, 35387.82306088453, 36842.21051263319, 37258.6274137266, 38013.809930951276, 38160.23679526449, 28183.57724634173, 28240.85879570589, 28453.146405607866, 28543.857280713462, 28616.14151575456], "value": 19768.63430357155, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [375.58122693197095, 384.09353924737616, 390.4943098687199, 394.4044492815848, 416.39414651681807, 14821.333040013198, 17185.398511052117, 19697.507562310948, 20072.397828065146, 20087.899560502177, 17740.556486087822, 18180.81819181811, 18391.08044597768, 18420.355287564937, 18465.35371262006, 4268.40242366069, 5658.603897727161, 5862.355140934494, 5864.970675146618, 5866.266716660418, 4894.5594896459315, 6597.0, 6600.735970561172, 6684.331566843325, 6711.395974362306, 6326.841828954267, 6554.016897465371, 6572.07990881277, 6597.703103360361, 6640.7343706251695, 6289.937100628981, 6529.183852018497, 6543.247526534438, 6548.639824809634, 6576.901346479806, 5784.334801497839, 5788.88422231553, 5802.042662960606, 5802.245708057968, 5802.506786923074, 23741.643875341884, 23812.761872381227, 23815.404614884592, 23893.805309734445, 24354.0, 2373.133806160756, 2401.183597576815, 2401.6277476991095, 2449.3631655769627, 2465.0879174705296, 14063.789043164361, 14816.925915370462, 14999.550013499613, 15178.165200913945, 15338.386464541405, 1953.2479995201807, 1966.8426525877896, 1966.8918209498615, 2006.2075480185244, 2011.6077364913847, 82222.17777822205, 82635.0, 84320.57839710762, 84345.15654843434, 84552.57723711403, 10507.579696812041, 10667.253292269466, 10817.78364432707, 10866.293690910066, 10938.671839844817, 14525.854741452662, 14607.488737894122, 14625.0, 14631.634209144857, 14645.560633181021, 8127.796805079802, 8132.390070744717, 8244.54654993981, 8246.134155913544, 8267.214614611603, 7925.167857375008, 7955.363570914313, 8052.637631306488, 8092.069412017693, 8201.097879233279, 6464.41820236181, 6530.869382612321, 6675.6662166891465, 6682.565633233824, 6782.491313151533, 1879.9696327965764, 1898.430470858737, 1901.2395041983318, 1911.7897031326543, 1935.4870959195825, 892.1479986612769, 994.6717583197527, 995.8804943406838, 1026.343140390151, 1081.124289325633, 19851.404457866287, 19867.701984470244, 19871.503212419804, 19886.105125269107, 19933.501662458555, 1031.200819364998, 1036.9325993810528, 1040.1262939131166, 1049.821530339844, 1076.5693722510903, 10893.891061089445, 11282.323060616389, 11352.205345625727, 11371.886281137247, 11385.373804440835, 461249.0, 467664.0, 468265.0, 468654.0, 470590.0, 52746.0, 87234.56382718173, 89214.55392723125, 89451.55274223587, 89858.0, 995.2485873165858, 1014.7260239735231, 1048.6749107776461, 1050.0497050169608, 1056.9101626361692, 17550.648987019933, 17608.29566817313, 17986.37047703324, 18038.278468861623, 18104.678905493307, 40272.395914060726, 44234.33648495211, 45140.32289515594, 45548.54451455443, 46617.53382466132, 54154.45845541652, 59625.70187149037, 60892.6955365238, 61429.0, 61984.52061917473, 5351.357837059578, 5441.993231252231, 8382.958085209535, 8825.426347287406, 8891.19979201875, 12241.755164896475, 13746.106503077268, 13828.516001939885, 13933.721325573635, 14297.142171469744, 11610.477528511406, 11666.125040622157, 11916.16586838913, 12063.939680301542, 12496.31270280107, 11832.940835295769, 11843.70390740204, 11869.5845645402, 11947.342896140795, 12310.692232693897, 11758.176927614984, 11848.763024739284, 12100.273983561014, 12122.393880305774, 12625.558105466265, 8513.489190648581, 8716.956415218137, 8779.868301975348, 8858.955705221433, 9051.185393314634, 5487.890242195213, 8498.74503764888, 9944.602215911282, 11284.492197851281, 12296.631101066982], "value": 9454.927168451093, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1355.9389827457762, 1472.9999999999998, 1505.5182341650673, 1630.217495602111, 1767.6553072150937, 8346.958265208681, 8739.650413983441, 8743.562821858914, 8967.327450441211, 8985.595648195831, 8718.258947989429, 8780.868286975685, 8894.644214231423, 8901.0, 8919.331050171231, 1883.7362769212252, 1930.1121484117323, 2194.714687090676, 2237.597232498146, 2260.4348912771807, 2265.275111964172, 2276.1805749930013, 2277.3281881844896, 2281.9885900570475, 2285.0859656137513, 2240.204727321802, 2241.4844585745286, 2276.8178545716305, 2277.658351247318, 2279.4985103277336, 1873.1383563560846, 1925.922963081475, 1926.5376309685576, 2097.9895100524554, 2176.9020394082227, 2234.7765223477686, 2261.8869056547105, 2266.410733209361, 2266.7279926408773, 2268.4442311633757, 8804.0, 8816.382853200279, 8829.602667879897, 8837.955810220908, 8845.778855528599, 4910.803567857281, 5033.219850923113, 5035.144025515671, 5036.697798132123, 5040.395152581677, 3175.872965081394, 3234.75739319552, 3306.50402439636, 3307.851146698404, 3315.370079684852, 1002.1832206751474, 1039.2725092435326, 1053.3100818963592, 1057.6351158850262, 1093.4095588382343, 12611.0, 12637.684057898627, 12665.873341266562, 12670.873291267062, 12677.302748348837, 4361.542038086019, 4438.755868427267, 4474.686771925999, 4546.181687296253, 4609.423822022247, 10676.572937082585, 10774.353538787698, 10777.946110269399, 10779.892201078046, 10781.892181078245, 5187.792488300502, 5205.765740541685, 5214.634975551675, 5216.321878155892, 5221.13851214553, 4165.10450253197, 4505.346724724896, 4584.541545845455, 4632.5135860734135, 4669.603083737852, 3807.5240594925635, 3903.648671619511, 3914.1388894443176, 3944.9605503944595, 3992.1017771001293, 1113.8050841102774, 1171.5255321594768, 1234.4198226833373, 1245.8131280308025, 1255.2468518888777, 862.2972277593741, 941.6045260990263, 947.5972711597543, 954.613381580461, 969.8739163908647, 5824.155497452845, 5851.707414629252, 5976.551758618121, 5978.3124940631515, 6194.101855231056, 973.6202880876464, 987.1146110928092, 1006.4967516241879, 1016.1972042086669, 1030.5208078243652, 3907.492026036597, 3992.720509564361, 4096.959030409717, 4126.649234815014, 4196.0, 10467.94766026165, 10783.0, 10900.836487452694, 10943.671689849158, 10954.123670106372, 10745.462726863781, 10774.838377424345, 10777.946110269555, 10786.406747628957, 10831.620893268699, 7985.8402831944195, 8130.634121464548, 8202.425830191829, 8208.630611622491, 8209.507429554127, 5988.461038506381, 5990.820275391745, 6049.395060494091, 6259.809066826574, 6290.370962903673, 10381.169506439315, 10561.10230630405, 10562.102221310966, 10582.0, 10583.047525722413, 10156.339837910513, 10494.737631559272, 10836.620718274822, 10845.728856778644, 10861.511231994422, 8723.956380218313, 8823.823523529365, 8886.111388861062, 8892.866607000771, 8900.109989001307, 8137.511749295061, 8465.407421480684, 8546.700865469678, 8623.180797824196, 8775.07861674515, 6107.9083813741945, 7294.562326260441, 7340.559566426032, 7387.482876198615, 7484.775456736306, 6973.093497845248, 7052.717891284291, 7119.537230080028, 7223.8555228896175, 7274.709011639687, 7010.824729381602, 7021.543599666005, 7056.294370563108, 7074.893876591958, 7090.680919358538, 4869.220924652039, 5084.21194714805, 5098.97450512745, 5181.3782346118705, 5230.869228269172, 5044.4451110377095, 5056.494350565061, 5069.822556210515, 5075.238714192753, 5121.129408000724], "value": 4580.582761515198, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [312.5046800820699, 312.596750192252, 325.87616705651857, 330.5471504039465, 332.77703938361293, 5323.920141197885, 5353.678779273237, 5390.703511306877, 5418.399168399171, 5429.972850135749, 5077.6953382797055, 5116.820911268106, 5256.817216126369, 5299.28459657946, 5347.25138480613, 4127.793610319487, 4153.916921661565, 4155.293600087993, 4156.812943417538, 4200.180964711874, 4196.237580216317, 4196.412502249687, 4208.263553878074, 4208.705390622642, 4212.1996820604145, 3959.4456776051375, 3983.58172391899, 4135.503739551243, 4147.336426171813, 4154.376843473488, 4141.295979683461, 4151.3150330195485, 4158.459400277975, 4162.979185104085, 4165.0, 3666.88160111166, 3683.336999340118, 3692.0, 3693.8153092345274, 3696.5933747287777, 5089.745512724386, 5135.666181698178, 5146.356705411824, 5190.896182076337, 5251.238570407308, 4750.239961606161, 4751.40607424072, 4755.096531659008, 4755.833545825914, 4770.856874293777, 5512.0, 5515.531179849718, 5521.171824226358, 5521.420250873681, 5554.750036248379, 3894.065424298148, 3998.580503921095, 4003.4795476587856, 4033.032072302626, 4055.3308704063793, 5619.4099619540175, 5625.493705566519, 5641.548676105902, 5663.2637757091725, 5666.291713535808, 4064.878053658336, 4094.754314741125, 4102.733322334038, 4125.731827431207, 4131.0, 4088.6320231178743, 4167.166566686675, 4175.436316097288, 4176.895577610584, 4177.3316269396755, 4716.551927566876, 4727.3854398927915, 4792.257200133985, 4795.20879054959, 4807.759612019385, 5499.862503437366, 5504.935649131576, 5546.27898373217, 5587.994161050969, 5593.74828132735, 1375.9656008599666, 1378.3521744779937, 1394.6861956059806, 1415.9008869379045, 1459.569427019032, 968.1238479176357, 1006.7533454303742, 1008.1884083313004, 1015.1979935850595, 1016.6797458800454, 5123.949590333973, 5262.631615786935, 5286.233496143038, 5317.494837990384, 5340.572754179656, 5669.477082698159, 5678.432156784289, 5695.914561281584, 5698.0, 5701.657900525982, 5156.690598564098, 5249.658772179796, 5300.595342234311, 5346.727640752664, 5358.5981051421295, 3052.3437460946, 3055.8624861881267, 3066.325408410191, 3068.6624471308137, 3073.3699591583672, 5908.202392676933, 5930.347661757203, 5936.317323507766, 5956.76172953077, 5971.880562388728, 5621.7189140542805, 5915.704214789243, 5916.0, 5919.585629005928, 5941.55438342126, 5917.171595976567, 5937.821865344046, 5943.9598070337515, 5951.0, 5955.106733989936, 5547.2511210986, 5739.799107031234, 5841.737121829443, 5855.0, 5855.590108692521, 5658.924804287172, 5664.207011018379, 5678.829635110953, 5706.343770466284, 5707.286589176353, 5931.220633809926, 5936.614120082181, 5977.521798256216, 5981.132735753378, 5991.281046274475, 3970.7617542947514, 4117.56765539626, 4164.58404142593, 4194.727342722713, 4215.156968606352, 5613.775448981995, 5690.544756419559, 5699.487046165865, 5725.942740572541, 5747.48272655463, 5421.2681288025615, 5476.2607048048, 5581.7767289309595, 5619.325680918152, 5630.0, 5537.889242215214, 5543.584231182758, 5564.777408903598, 5571.526420254324, 5588.692621905834, 5339.252504649275, 5523.226748255167, 5529.640573362719, 5533.391326954113, 5556.583256255716, 5600.579956503197, 5609.9158512621525, 5617.213590097472, 5626.465485778845, 5643.009205121292, 5490.6431081979545, 5500.1749737539685, 5505.834824955257, 5532.640378375393, 5551.916721249266], "value": 4263.340659833286, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [774.3843644302782, 776.9805754856128, 807.4670717326562, 810.6068556749972, 851.1743608699559, 14953.401863925443, 16145.273462694178, 16167.43413980511, 16291.755623665655, 16825.91587042063, 15901.681966360666, 15954.0, 16042.278097485612, 16069.116198609101, 16075.91962040188, 670.3497607320891, 809.878518222267, 821.1788211788212, 822.1696086952192, 823.17271142502, 787.8700014497601, 805.3798575097171, 807.9919200808005, 810.5744484145841, 811.0308181722844, 862.0991064337751, 862.9827403451927, 866.1728049712541, 866.5883705240024, 872.3457406944791, 692.3595674001529, 840.7603832907653, 864.8356812205661, 865.4461144867258, 865.9350548708841, 626.8934281172166, 628.0955424189153, 628.8365025093509, 628.8522197283635, 630.2877748144613, 14527.128372297697, 14555.927220363936, 14561.199134047623, 14565.126092434488, 14578.927105364406, 14257.71484570313, 14477.348519316656, 14548.927255363655, 14553.927230363886, 14733.0, 12859.16415432994, 12888.677783055498, 12959.935200323938, 12972.091953563255, 13394.598162055154, 4646.907061858744, 4708.458527269374, 4713.2458806590785, 4789.736564488987, 4844.951550484485, 58175.41824581785, 58240.0, 58479.12281315784, 58935.41064589342, 59404.70297648527, 10436.360735511185, 10902.127829773599, 10962.451877406098, 11915.880841191478, 11951.22317049389, 19527.0, 20044.799552004584, 20643.27748528794, 20797.168113275602, 20845.270415535382, 7763.978243360161, 7799.103103143211, 8004.07953085391, 8094.595270236582, 8313.6674533018, 4865.9026819463415, 4891.0, 4894.363732714795, 5105.438401775802, 5117.437081920985, 3462.774919630266, 3585.8207089645935, 3594.3530164570107, 3596.1549035976523, 3598.4962105305276, 633.654658211276, 644.7421031587403, 649.9707513161919, 649.9902501462482, 650.8405440667067, 722.8120688620996, 730.4010711216857, 746.4028776978396, 747.637395863006, 774.0, 9391.248700104112, 9453.90546094544, 9498.810023799486, 9778.804423911482, 10192.082712555906, 636.462189449914, 646.253577118429, 725.4631572636212, 759.3886921028515, 760.015779565453, 4600.53994600544, 4985.675931064469, 4990.3762029746285, 5001.574866136347, 5038.34501514808, 100083.49958250162, 102960.48519757354, 103948.48025759823, 110784.0, 117217.0, 92794.0, 99461.50269248753, 100270.0, 100873.0, 101426.49286753667, 90324.5483772577, 91115.0, 91371.62942555867, 92190.53904730434, 93408.92841965251, 9768.0, 10059.949700251746, 10286.125679317342, 10424.436334549879, 10427.94786026065, 51562.74218628883, 52733.47266527286, 52987.0, 53815.192772109236, 55225.171622424896, 75344.0, 79689.60155199187, 81404.0, 81602.0, 82123.17876821394, 13002.804957925828, 14391.856081439051, 14451.92774036123, 14486.927565362106, 14748.63128421798, 15330.616734581725, 15503.651529748717, 15612.141332226382, 15634.374625014872, 16260.349586016428, 14046.578602641937, 14253.786193207317, 14766.0, 14931.402743890558, 14992.625184370478, 14403.42386304536, 14416.711665766836, 14970.17664028489, 15019.549413517612, 15079.773803392738, 13698.65753356174, 13800.171989680652, 14169.645758856112, 14299.07056041354, 14354.138751674933, 10274.794504110025, 10412.0, 10615.522301496298, 11081.5567377304, 11101.11191104726, 11188.944055279997, 11217.66347009591, 11440.781137419497, 11556.47995840206, 11654.941725291319], "value": 7703.10328650521, "unit": "score"}], "name": "dromaeo_css", "value": 7244.832367219781, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 112.0, 111.0, 110.0, 110.0, 110.0, 113.0, 111.0, 109.0, 111.0], "value": 109.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 116.0, 118.0, 186.0, 119.0, 123.0, 154.0, 117.0, 157.0, 117.0], "value": 135.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 160.0, 159.0, 160.0, 161.0, 162.0, 160.0, 161.0, 161.0], "value": 160.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 75.0, 113.0, 74.0, 76.0, 73.0, 74.0, 111.0, 76.0], "value": 82.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 122.0, 84.0, 85.0, 84.0, 122.0, 84.0, 83.0, 136.0], "value": 96.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 119.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 145.0, 145.0, 145.0, 146.0, 146.0, 146.0, 145.0, 146.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 97.0, 95.0, 96.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 53.0, 54.0, 53.0, 54.0, 56.0, 54.0, 53.0, 52.0], "value": 53.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 63.0, 64.0, 63.0, 64.0, 63.0, 63.0, 63.0, 64.0], "value": 63.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 75.0, 75.0, 74.0, 74.0, 74.0, 74.0, 74.0, 80.0], "value": 75.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 119.0, 121.0, 119.0, 121.0, 120.0, 121.0, 128.0, 177.0, 122.0], "value": 126.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 163.0, 161.0, 161.0, 162.0, 161.0, 161.0, 166.0, 162.0], "value": 162.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 63.0, 63.0, 64.0, 63.0, 68.0, 63.0, 63.0, 64.0, 61.0], "value": 63.8, "unit": "score"}], "name": "kraken", "value": 1487.6, "alertThreshold": 2.0}]} 02:30:33 INFO - Return code: 0 02:30:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:30:33 INFO - # TBPL SUCCESS # 02:30:33 INFO - Running post-action listener: _resource_record_post_action 02:30:33 INFO - ##### 02:30:33 INFO - ##### Finished run-tests step (success) 02:30:33 INFO - ##### 02:30:33 INFO - Running post-run listener: _resource_record_post_run 02:30:33 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 559038464; Read time: 8; Write time: 458000 02:30:33 INFO - TinderboxPrint: CPU usage
12.9% 02:30:33 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 02:30:33 INFO - TinderboxPrint: I/O write bytes / time
559,038,464 / 458,000 02:30:33 INFO - TinderboxPrint: CPU idle
8,287.6 (87.0%) 02:30:33 INFO - TinderboxPrint: CPU user
1,191.4 (12.5%) 02:30:33 INFO - TinderboxPrint: Swap in / out
0 / 0 02:30:33 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 239992832; Read time: 0; Write time: 206720 02:30:33 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 294014976; Read time: 0; Write time: 246492 02:30:34 INFO - Running post-run listener: _upload_blobber_files 02:30:34 INFO - Blob upload gear active. 02:30:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:30:34 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 02:30:34 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'] 02:30:34 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 02:30:34 INFO - (blobuploader) - INFO - Open directory for files ... 02:30:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:30:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:30:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:30:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:30:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:30:35 INFO - (blobuploader) - INFO - Done attempting. 02:30:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:30:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:30:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:30:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:30:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:30:36 INFO - (blobuploader) - INFO - Done attempting. 02:30:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:30:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:30:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:30:41 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:30:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:30:41 INFO - (blobuploader) - INFO - Done attempting. 02:30:41 INFO - (blobuploader) - INFO - Iteration through files over. 02:30:41 INFO - Return code: 0 02:30:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:30:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:30:41 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a982280e007734bcb27e0f6c8eaf4927aacae6f2a072806e3f9d66afd8ce3680b481d298a3e07a7c77cf985102c2dcd86c6783885a5d99e621e3886aca21d8ca", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4829e9b547d7db6d0f9a97bd7199973ae106a44312f213c22c54fffde1bc6554e85e091a2727fd12601ab344f3c9488be6b0617442ba6d7079bc69bfc7fe71ff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8650750771a32444cfc3db799f6e8a3c9723011534214e9254f6c20d61ea1d0347d51ca1d6c19d77130c025934761c6768316778fbca519f8c9db3182ee41aa4"} 02:30:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:30:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:30:41 INFO - Contents: 02:30:41 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a982280e007734bcb27e0f6c8eaf4927aacae6f2a072806e3f9d66afd8ce3680b481d298a3e07a7c77cf985102c2dcd86c6783885a5d99e621e3886aca21d8ca", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4829e9b547d7db6d0f9a97bd7199973ae106a44312f213c22c54fffde1bc6554e85e091a2727fd12601ab344f3c9488be6b0617442ba6d7079bc69bfc7fe71ff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8650750771a32444cfc3db799f6e8a3c9723011534214e9254f6c20d61ea1d0347d51ca1d6c19d77130c025934761c6768316778fbca519f8c9db3182ee41aa4"} 02:30:41 INFO - Running post-run listener: copy_logs_to_upload_dir 02:30:41 INFO - Copying logs to upload dir... 02:30:41 INFO - mkdir: /builds/slave/test/build/upload/logs 02:30:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.954790 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-07-06 02:30:41.177760) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-06 02:30:41.180948) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1467794203.396150-714700313 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a982280e007734bcb27e0f6c8eaf4927aacae6f2a072806e3f9d66afd8ce3680b481d298a3e07a7c77cf985102c2dcd86c6783885a5d99e621e3886aca21d8ca", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4829e9b547d7db6d0f9a97bd7199973ae106a44312f213c22c54fffde1bc6554e85e091a2727fd12601ab344f3c9488be6b0617442ba6d7079bc69bfc7fe71ff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8650750771a32444cfc3db799f6e8a3c9723011534214e9254f6c20d61ea1d0347d51ca1d6c19d77130c025934761c6768316778fbca519f8c9db3182ee41aa4"} build_url:https://queue.taskcluster.net/v1/task/THuULqs_TwOzg5sEogSrkA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011419 build_url: 'https://queue.taskcluster.net/v1/task/THuULqs_TwOzg5sEogSrkA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a982280e007734bcb27e0f6c8eaf4927aacae6f2a072806e3f9d66afd8ce3680b481d298a3e07a7c77cf985102c2dcd86c6783885a5d99e621e3886aca21d8ca", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4829e9b547d7db6d0f9a97bd7199973ae106a44312f213c22c54fffde1bc6554e85e091a2727fd12601ab344f3c9488be6b0617442ba6d7079bc69bfc7fe71ff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8650750771a32444cfc3db799f6e8a3c9723011534214e9254f6c20d61ea1d0347d51ca1d6c19d77130c025934761c6768316778fbca519f8c9db3182ee41aa4"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-06 02:30:41.206292) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 02:30:41.206625) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1467794203.396150-714700313 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004442 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 02:30:41.289380) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-06 02:30:41.289704) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-06 02:30:41.290013) ========= ========= Total master_lag: 0.21 =========