builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-048 starttime: 1467230881.09 results: success (0) buildid: 20160629072230 builduid: 44330e7de3a149cabbd5abff280a7c1f revision: eeb6862f960c1310bde9aed159f3fc5bb2d4b6d7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-29 13:08:01.089806) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-29 13:08:01.090269) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-29 13:08:01.090608) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-29 13:08:01.111841) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 13:08:01.112124) ========= 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=fa44defc139c4ba8574fe040000001db-1467230586.323445-1134854676 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-29 13:08: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% 38.4M=0s 2016-06-29 13:08:01 (38.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.102493 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 13:08:01.236148) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 13:08:01.236443) ========= 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=fa44defc139c4ba8574fe040000001db-1467230586.323445-1134854676 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018066 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 13:08:01.290148) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 13:08:01.290479) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev eeb6862f960c1310bde9aed159f3fc5bb2d4b6d7 --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 eeb6862f960c1310bde9aed159f3fc5bb2d4b6d7 --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=fa44defc139c4ba8574fe040000001db-1467230586.323445-1134854676 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-29 13:08:01,653 truncating revision to first 12 chars 2016-06-29 13:08:01,653 Setting DEBUG logging. 2016-06-29 13:08:01,653 attempt 1/10 2016-06-29 13:08:01,653 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/eeb6862f960c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-29 13:08:01,958 unpacking tar archive at: fx-team-eeb6862f960c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.643239 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 13:08:01.951626) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-29 13:08:01.951951) ========= script_repo_revision: eeb6862f960c1310bde9aed159f3fc5bb2d4b6d7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-29 13:08:01.952360) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-29 13:08:01.952664) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-29 13:08:01.963328) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-06-29 13:08:01.963714) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] 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=fa44defc139c4ba8574fe040000001db-1467230586.323445-1134854676 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:08:02 INFO - MultiFileLogger online at 20160629 13:08:02 in /builds/slave/test 13:08:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 13:08:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:08:02 INFO - {'append_to_log': False, 13:08:02 INFO - 'base_work_dir': '/builds/slave/test', 13:08:02 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 13:08:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:08:02 INFO - 'branch': 'Fx-Team-Non-PGO', 13:08:02 INFO - 'buildbot_json_path': 'buildprops.json', 13:08:02 INFO - 'config_files': ('talos/linux_config.py',), 13:08:02 INFO - 'default_actions': ('clobber', 13:08:02 INFO - 'read-buildbot-config', 13:08:02 INFO - 'download-and-extract', 13:08:02 INFO - 'populate-webroot', 13:08:02 INFO - 'create-virtualenv', 13:08:02 INFO - 'install', 13:08:02 INFO - 'run-tests'), 13:08:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:08:02 INFO - 'download_minidump_stackwalk': True, 13:08:02 INFO - 'download_symbols': 'ondemand', 13:08:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:08:02 INFO - 'tooltool.py': '/tools/tooltool.py', 13:08:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:08:02 INFO - '/tools/misc-python/virtualenv.py')}, 13:08:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:08:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:08:02 INFO - 'installer_path': 'installer.exe', 13:08:02 INFO - 'log_level': 'info', 13:08:02 INFO - 'log_name': 'talos', 13:08:02 INFO - 'log_to_console': True, 13:08:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:08:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:08:02 INFO - 'opt_config_files': (), 13:08:02 INFO - 'pip_index': False, 13:08:02 INFO - 'sps_profile': False, 13:08:02 INFO - 'sps_profile_interval': 0, 13:08:02 INFO - 'suite': 'dromaeojs-e10s', 13:08:02 INFO - 'system_bits': '32', 13:08:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:08:02 INFO - 'title': 'talos-linux64-ix-048', 13:08:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:08:02 INFO - 'use_talos_json': True, 13:08:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:08:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:08:02 INFO - 'work_dir': 'build'} 13:08:02 INFO - ##### 13:08:02 INFO - ##### Running clobber step. 13:08:02 INFO - ##### 13:08:02 INFO - Running pre-action listener: _resource_record_pre_action 13:08:02 INFO - Running main action method: clobber 13:08:02 INFO - rmtree: /builds/slave/test/build 13:08:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:08:02 INFO - Running post-action listener: _resource_record_post_action 13:08:02 INFO - ##### 13:08:02 INFO - ##### Finished clobber step (success) 13:08:02 INFO - ##### 13:08:02 INFO - ##### 13:08:02 INFO - ##### Running read-buildbot-config step. 13:08:02 INFO - ##### 13:08:02 INFO - Running pre-action listener: _resource_record_pre_action 13:08:02 INFO - Running main action method: read_buildbot_config 13:08:02 INFO - Using buildbot properties: 13:08:02 INFO - { 13:08:02 INFO - "project": "", 13:08:02 INFO - "product": "firefox", 13:08:02 INFO - "script_repo_revision": "production", 13:08:02 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 13:08:02 INFO - "repository": "", 13:08:02 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 13:08:02 INFO - "buildid": "20160629072230", 13:08:02 INFO - "pgo_build": "False", 13:08:02 INFO - "basedir": "/builds/slave/test", 13:08:02 INFO - "buildnumber": 1394, 13:08:02 INFO - "slavename": "talos-linux64-ix-048", 13:08:02 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 13:08:02 INFO - "platform": "ubuntu64_hw", 13:08:02 INFO - "scheduler": "tests-fx-team-linux64-talos", 13:08:02 INFO - "branch": "fx-team", 13:08:02 INFO - "repo_path": "integration/fx-team", 13:08:02 INFO - "revision": "eeb6862f960c1310bde9aed159f3fc5bb2d4b6d7", 13:08:02 INFO - "stage_platform": "linux64", 13:08:02 INFO - "builduid": "44330e7de3a149cabbd5abff280a7c1f", 13:08:02 INFO - "slavebuilddir": "test" 13:08:02 INFO - } 13:08:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/ItgHgkJuQs6lLdTiQ9gDNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 13:08:02 INFO - Running post-action listener: _resource_record_post_action 13:08:02 INFO - ##### 13:08:02 INFO - ##### Finished read-buildbot-config step (success) 13:08:02 INFO - ##### 13:08:02 INFO - ##### 13:08:02 INFO - ##### Running download-and-extract step. 13:08:02 INFO - ##### 13:08:02 INFO - Running pre-action listener: _resource_record_pre_action 13:08:02 INFO - Running main action method: download_and_extract 13:08:02 INFO - mkdir: /builds/slave/test/build/tests 13:08:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:08:02 INFO - https://queue.taskcluster.net/v1/task/ItgHgkJuQs6lLdTiQ9gDNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 13:08:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ItgHgkJuQs6lLdTiQ9gDNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:08:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ItgHgkJuQs6lLdTiQ9gDNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:08:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ItgHgkJuQs6lLdTiQ9gDNA/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 13:08:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ItgHgkJuQs6lLdTiQ9gDNA/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 13:08:08 INFO - Downloaded 1361 bytes. 13:08:08 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:08:08 INFO - Using the following test package requirements: 13:08:08 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 13:08:08 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:08:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:08:08 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:08:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:08:08 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:08:08 INFO - u'jsshell-linux-x86_64.zip'], 13:08:08 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:08:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:08:08 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 13:08:08 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:08:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:08:08 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:08:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:08:08 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:08:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:08:08 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:08:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:08:08 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:08:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:08:08 INFO - https://queue.taskcluster.net/v1/task/ItgHgkJuQs6lLdTiQ9gDNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:08:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ItgHgkJuQs6lLdTiQ9gDNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:08:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ItgHgkJuQs6lLdTiQ9gDNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:08:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ItgHgkJuQs6lLdTiQ9gDNA/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 13:08:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ItgHgkJuQs6lLdTiQ9gDNA/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 13:08:10 INFO - Downloaded 22701715 bytes. 13:08: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'] 13:08: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 13:08:11 INFO - Return code: 0 13:08:11 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 13:08: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')]} 13:08:11 INFO - https://queue.taskcluster.net/v1/task/ItgHgkJuQs6lLdTiQ9gDNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:08:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ItgHgkJuQs6lLdTiQ9gDNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:08:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ItgHgkJuQs6lLdTiQ9gDNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:08:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ItgHgkJuQs6lLdTiQ9gDNA/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 13:08:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ItgHgkJuQs6lLdTiQ9gDNA/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 13:08:21 INFO - Downloaded 22701715 bytes. 13:08:21 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'] 13:08:21 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 13:08:22 INFO - Return code: 0 13:08:22 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')]} 13:08:22 INFO - https://queue.taskcluster.net/v1/task/ItgHgkJuQs6lLdTiQ9gDNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:08:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ItgHgkJuQs6lLdTiQ9gDNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 13:08:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ItgHgkJuQs6lLdTiQ9gDNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 13:08:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ItgHgkJuQs6lLdTiQ9gDNA/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 13:08:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ItgHgkJuQs6lLdTiQ9gDNA/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 13:08:23 INFO - Downloaded 14405245 bytes. 13:08:23 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'] 13:08:23 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 13:08:24 INFO - Return code: 0 13:08:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:08:24 INFO - https://queue.taskcluster.net/v1/task/ItgHgkJuQs6lLdTiQ9gDNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:08:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ItgHgkJuQs6lLdTiQ9gDNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:08:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ItgHgkJuQs6lLdTiQ9gDNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:08:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ItgHgkJuQs6lLdTiQ9gDNA/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 13:08:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ItgHgkJuQs6lLdTiQ9gDNA/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 13:08:25 INFO - Downloaded 56470205 bytes. 13:08:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ItgHgkJuQs6lLdTiQ9gDNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:08:25 INFO - mkdir: /builds/slave/test/properties 13:08:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:08:25 INFO - Writing to file /builds/slave/test/properties/build_url 13:08:25 INFO - Contents: 13:08:25 INFO - build_url:https://queue.taskcluster.net/v1/task/ItgHgkJuQs6lLdTiQ9gDNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:08:26 INFO - Running post-action listener: _resource_record_post_action 13:08:26 INFO - Running post-action listener: set_extra_try_arguments 13:08:26 INFO - ##### 13:08:26 INFO - ##### Finished download-and-extract step (success) 13:08:26 INFO - ##### 13:08:26 INFO - ##### 13:08:26 INFO - ##### Running populate-webroot step. 13:08:26 INFO - ##### 13:08:26 INFO - Running pre-action listener: _resource_record_pre_action 13:08:26 INFO - Running main action method: populate_webroot 13:08:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:08:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:08:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:08:26 INFO - '--tppagecycles', 13:08:26 INFO - '7'], 13:08:26 INFO - 'tests': ['tsvgm']}}, 13:08:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:08:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:08:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:08:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:08:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:08:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:08:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:08:26 INFO - 'talos_options': ['--disable-e10s'], 13:08:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:08:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:08:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:08:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:08:26 INFO - 'talos_options': ['--disable-e10s'], 13:08:26 INFO - 'tests': ['damp', 'tps']}, 13:08:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:08:26 INFO - 'tests': ['damp', 'tps']}, 13:08:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:08:26 INFO - 'tests': ['dromaeo_dom']}, 13:08:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:08:26 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:08:26 INFO - 'tests': ['basic_compositor_video']}, 13:08:26 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:08:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:08:26 INFO - 'tests': ['a11yr', 13:08:26 INFO - 'ts_paint', 13:08:26 INFO - 'tpaint', 13:08:26 INFO - 'sessionrestore', 13:08:26 INFO - 'sessionrestore_no_auto_restore', 13:08:26 INFO - 'tabpaint']}, 13:08:26 INFO - 'other-e10s': {'tests': ['a11yr', 13:08:26 INFO - 'ts_paint', 13:08:26 INFO - 'tpaint', 13:08:26 INFO - 'sessionrestore', 13:08:26 INFO - 'sessionrestore_no_auto_restore', 13:08:26 INFO - 'tabpaint']}, 13:08:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:08:26 INFO - 'ts_paint', 13:08:26 INFO - 'tpaint', 13:08:26 INFO - 'sessionrestore', 13:08:26 INFO - 'sessionrestore_no_auto_restore', 13:08:26 INFO - 'tabpaint']}, 13:08:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:08:26 INFO - 'ts_paint', 13:08:26 INFO - 'tpaint', 13:08:26 INFO - 'sessionrestore', 13:08:26 INFO - 'sessionrestore_no_auto_restore', 13:08:26 INFO - 'tabpaint']}, 13:08:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:08:26 INFO - 'tests': ['a11yr', 13:08:26 INFO - 'ts_paint', 13:08:26 INFO - 'tpaint', 13:08:26 INFO - 'sessionrestore', 13:08:26 INFO - 'sessionrestore_no_auto_restore', 13:08:26 INFO - 'tabpaint']}, 13:08:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:08:26 INFO - 'tests': ['a11yr', 13:08:26 INFO - 'ts_paint', 13:08:26 INFO - 'tpaint', 13:08:26 INFO - 'sessionrestore', 13:08:26 INFO - 'sessionrestore_no_auto_restore', 13:08:26 INFO - 'tabpaint']}, 13:08:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:08:26 INFO - 'tests': ['tsvgx', 13:08:26 INFO - 'tsvgr_opacity', 13:08:26 INFO - 'tart', 13:08:26 INFO - 'tscrollx', 13:08:26 INFO - 'cart']}, 13:08:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:08:26 INFO - 'tsvgr_opacity', 13:08:26 INFO - 'tart', 13:08:26 INFO - 'tscrollx', 13:08:26 INFO - 'cart']}, 13:08:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:08:26 INFO - 'talos_options': ['--disable-e10s'], 13:08:26 INFO - 'tests': ['tp5o']}, 13:08:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:08:26 INFO - 'tests': ['tp5o']}, 13:08:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:08:26 INFO - 'talos_options': ['--disable-e10s', 13:08:26 INFO - '--xperf_path', 13:08:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:08:26 INFO - 'tests': ['tp5n']}, 13:08:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:08:26 INFO - 'talos_options': ['--xperf_path', 13:08:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:08:26 INFO - 'tests': ['tp5n']}}, 13:08:26 INFO - 'talos.zip': {'path': '', 13:08:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:08:26 INFO - Running post-action listener: _resource_record_post_action 13:08:26 INFO - ##### 13:08:26 INFO - ##### Finished populate-webroot step (success) 13:08:26 INFO - ##### 13:08:26 INFO - ##### 13:08:26 INFO - ##### Running create-virtualenv step. 13:08:26 INFO - ##### 13:08:26 INFO - Running pre-action listener: _resource_record_pre_action 13:08:26 INFO - Running main action method: create_virtualenv 13:08:26 INFO - Creating virtualenv /builds/slave/test/build/venv 13:08:26 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 13:08:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:08:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:08:26 INFO - Using real prefix '/usr' 13:08:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:08:26 INFO - Installing distribute.............................................................................................................................................................................................done. 13:08:28 INFO - Installing pip.................done. 13:08:28 INFO - Return code: 0 13:08:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:08:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:08:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:08:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:08:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:08:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c3e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e6d400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efc570>, '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 0x1efd470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1efd900>, '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': 'fa44defc139c4ba8574fe040000001db-1467230586.323445-1134854676', '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 13:08:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 13:08:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 13:08:28 INFO - Using env: {'DISPLAY': ':0', 13:08:28 INFO - 'HOME': '/home/cltbld', 13:08:28 INFO - 'LANG': 'en_US.UTF-8', 13:08:28 INFO - 'LANGUAGE': 'en_US:en', 13:08:28 INFO - 'LOGNAME': 'cltbld', 13:08:28 INFO - 'MAIL': '/var/mail/cltbld', 13:08:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:08:28 INFO - 'MOZ_NO_REMOTE': '1', 13:08:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:08:28 INFO - 'NO_EM_RESTART': '1', 13:08:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:08:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:08:28 INFO - 'PWD': '/builds/slave/test', 13:08:28 INFO - 'SHELL': '/bin/bash', 13:08:28 INFO - 'SHLVL': '1', 13:08:28 INFO - 'TERM': 'linux', 13:08:28 INFO - 'TMOUT': '86400', 13:08:28 INFO - 'USER': 'cltbld', 13:08:28 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1467230586.323445-1134854676', 13:08:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:08:28 INFO - '_': '/tools/buildbot/bin/python'} 13:08:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:08:29 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 13:08:29 INFO - Cleaning up... 13:08:29 INFO - Return code: 0 13:08:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:08:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:08:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:08:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:08:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:08:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08: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', '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 0x1c3e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e6d400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efc570>, '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 0x1efd470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1efd900>, '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': 'fa44defc139c4ba8574fe040000001db-1467230586.323445-1134854676', '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 13:08: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', 'psutil>=3.1.1'] in /builds/slave/test/build 13:08: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 psutil>=3.1.1 13:08:29 INFO - Using env: {'DISPLAY': ':0', 13:08:29 INFO - 'HOME': '/home/cltbld', 13:08:29 INFO - 'LANG': 'en_US.UTF-8', 13:08:29 INFO - 'LANGUAGE': 'en_US:en', 13:08:29 INFO - 'LOGNAME': 'cltbld', 13:08:29 INFO - 'MAIL': '/var/mail/cltbld', 13:08:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:08:29 INFO - 'MOZ_NO_REMOTE': '1', 13:08:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:08:29 INFO - 'NO_EM_RESTART': '1', 13:08:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:08:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:08:29 INFO - 'PWD': '/builds/slave/test', 13:08:29 INFO - 'SHELL': '/bin/bash', 13:08:29 INFO - 'SHLVL': '1', 13:08:29 INFO - 'TERM': 'linux', 13:08:29 INFO - 'TMOUT': '86400', 13:08:29 INFO - 'USER': 'cltbld', 13:08:29 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1467230586.323445-1134854676', 13:08:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:08:29 INFO - '_': '/tools/buildbot/bin/python'} 13:08:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:08:29 INFO - Downloading/unpacking psutil>=3.1.1 13:08: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 13:08: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 13:08: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 13:08: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 13:08: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 13:08: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 13:08:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:08:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:08:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:08:31 INFO - Installing collected packages: psutil 13:08:31 INFO - Running setup.py install for psutil 13:08:31 INFO - building 'psutil._psutil_linux' extension 13:08:31 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 13:08:31 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 13:08:31 INFO - building 'psutil._psutil_posix' extension 13:08:31 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 13:08:31 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 13:08:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:08:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:08:31 INFO - Successfully installed psutil 13:08:31 INFO - Cleaning up... 13:08:31 INFO - Return code: 0 13:08:31 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:08:31 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')]} 13:08:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:08:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:31 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')]} 13:08:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:08:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:31 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 0x1c3e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e6d400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efc570>, '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 0x1efd470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1efd900>, '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': 'fa44defc139c4ba8574fe040000001db-1467230586.323445-1134854676', '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 13:08:31 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 13:08:31 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 13:08:31 INFO - Using env: {'DISPLAY': ':0', 13:08:31 INFO - 'HOME': '/home/cltbld', 13:08:31 INFO - 'LANG': 'en_US.UTF-8', 13:08:31 INFO - 'LANGUAGE': 'en_US:en', 13:08:31 INFO - 'LOGNAME': 'cltbld', 13:08:31 INFO - 'MAIL': '/var/mail/cltbld', 13:08:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:08:31 INFO - 'MOZ_NO_REMOTE': '1', 13:08:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:08:31 INFO - 'NO_EM_RESTART': '1', 13:08:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:08:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:08:31 INFO - 'PWD': '/builds/slave/test', 13:08:31 INFO - 'SHELL': '/bin/bash', 13:08:31 INFO - 'SHLVL': '1', 13:08:31 INFO - 'TERM': 'linux', 13:08:31 INFO - 'TMOUT': '86400', 13:08:31 INFO - 'USER': 'cltbld', 13:08:31 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1467230586.323445-1134854676', 13:08:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:08:31 INFO - '_': '/tools/buildbot/bin/python'} 13:08:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:08:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:08:32 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 13:08:32 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 13:08:32 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 13:08:32 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 13:08:32 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 13:08:32 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 13:08:33 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:08:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:08:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:08:33 INFO - Installing collected packages: mozsystemmonitor 13:08:33 INFO - Running setup.py install for mozsystemmonitor 13:08:34 INFO - Successfully installed mozsystemmonitor 13:08:34 INFO - Cleaning up... 13:08:34 INFO - Return code: 0 13:08:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:08:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:08:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:08:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:08:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:08:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:34 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 0x1c3e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e6d400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efc570>, '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 0x1efd470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1efd900>, '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': 'fa44defc139c4ba8574fe040000001db-1467230586.323445-1134854676', '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 13:08:34 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 13:08:34 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 13:08:34 INFO - Using env: {'DISPLAY': ':0', 13:08:34 INFO - 'HOME': '/home/cltbld', 13:08:34 INFO - 'LANG': 'en_US.UTF-8', 13:08:34 INFO - 'LANGUAGE': 'en_US:en', 13:08:34 INFO - 'LOGNAME': 'cltbld', 13:08:34 INFO - 'MAIL': '/var/mail/cltbld', 13:08:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:08:34 INFO - 'MOZ_NO_REMOTE': '1', 13:08:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:08:34 INFO - 'NO_EM_RESTART': '1', 13:08:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:08:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:08:34 INFO - 'PWD': '/builds/slave/test', 13:08:34 INFO - 'SHELL': '/bin/bash', 13:08:34 INFO - 'SHLVL': '1', 13:08:34 INFO - 'TERM': 'linux', 13:08:34 INFO - 'TMOUT': '86400', 13:08:34 INFO - 'USER': 'cltbld', 13:08:34 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1467230586.323445-1134854676', 13:08:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:08:34 INFO - '_': '/tools/buildbot/bin/python'} 13:08:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:08:34 INFO - Downloading/unpacking jsonschema==2.5.1 13:08:34 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 13:08:34 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 13:08:34 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 13:08:34 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 13:08:34 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 13:08:34 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 13:08:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:08:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:08:36 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 13:08:36 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 13:08:36 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 13:08:36 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 13:08:36 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 13:08:36 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 13:08:36 INFO - Downloading functools32-3.2.3-2.tar.gz 13:08:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:08:36 INFO - warning: no files found matching '*.txt' 13:08:36 INFO - no previously-included directories found matching 'build' 13:08:36 INFO - no previously-included directories found matching 'dist' 13:08:36 INFO - no previously-included directories found matching '.git*' 13:08:36 INFO - Installing collected packages: jsonschema, functools32 13:08:36 INFO - Running setup.py install for functools32 13:08:36 INFO - warning: no files found matching '*.txt' 13:08:36 INFO - no previously-included directories found matching 'build' 13:08:36 INFO - no previously-included directories found matching 'dist' 13:08:36 INFO - no previously-included directories found matching '.git*' 13:08:36 INFO - Successfully installed jsonschema functools32 13:08:36 INFO - Cleaning up... 13:08:36 INFO - Return code: 0 13:08:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:08: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')]} 13:08:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:08:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08: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')]} 13:08:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:08:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:36 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 0x1c3e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e6d400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efc570>, '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 0x1efd470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1efd900>, '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': 'fa44defc139c4ba8574fe040000001db-1467230586.323445-1134854676', '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 13:08:36 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 13:08:36 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 13:08:36 INFO - Using env: {'DISPLAY': ':0', 13:08:36 INFO - 'HOME': '/home/cltbld', 13:08:36 INFO - 'LANG': 'en_US.UTF-8', 13:08:36 INFO - 'LANGUAGE': 'en_US:en', 13:08:36 INFO - 'LOGNAME': 'cltbld', 13:08:36 INFO - 'MAIL': '/var/mail/cltbld', 13:08:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:08:36 INFO - 'MOZ_NO_REMOTE': '1', 13:08:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:08:36 INFO - 'NO_EM_RESTART': '1', 13:08:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:08:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:08:36 INFO - 'PWD': '/builds/slave/test', 13:08:36 INFO - 'SHELL': '/bin/bash', 13:08:36 INFO - 'SHLVL': '1', 13:08:36 INFO - 'TERM': 'linux', 13:08:36 INFO - 'TMOUT': '86400', 13:08:36 INFO - 'USER': 'cltbld', 13:08:36 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1467230586.323445-1134854676', 13:08:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:08:36 INFO - '_': '/tools/buildbot/bin/python'} 13:08:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:08:36 INFO - Downloading/unpacking blobuploader==1.2.4 13:08:36 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 13:08:36 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 13:08:36 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 13:08:36 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 13:08:36 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 13:08:36 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 13:08:38 INFO - Downloading blobuploader-1.2.4.tar.gz 13:08:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:08:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:08:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:08:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:08:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:08:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:08:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:08:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:08:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:08:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:08:39 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 13:08:39 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 13:08:39 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 13:08:39 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 13:08:39 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 13:08:39 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 13:08:39 INFO - Downloading docopt-0.6.1.tar.gz 13:08:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:08:39 INFO - Installing collected packages: blobuploader, requests, docopt 13:08:39 INFO - Running setup.py install for blobuploader 13:08:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:08:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:08:39 INFO - Running setup.py install for requests 13:08:39 INFO - Running setup.py install for docopt 13:08:40 INFO - Successfully installed blobuploader requests docopt 13:08:40 INFO - Cleaning up... 13:08:40 INFO - Return code: 0 13:08:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:08: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')]} 13:08:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:08:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08: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')]} 13:08:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:08:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:40 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 0x1c3e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e6d400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efc570>, '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 0x1efd470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1efd900>, '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': 'fa44defc139c4ba8574fe040000001db-1467230586.323445-1134854676', '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 13:08:40 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 13:08:40 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 13:08:40 INFO - Using env: {'DISPLAY': ':0', 13:08:40 INFO - 'HOME': '/home/cltbld', 13:08:40 INFO - 'LANG': 'en_US.UTF-8', 13:08:40 INFO - 'LANGUAGE': 'en_US:en', 13:08:40 INFO - 'LOGNAME': 'cltbld', 13:08:40 INFO - 'MAIL': '/var/mail/cltbld', 13:08:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:08:40 INFO - 'MOZ_NO_REMOTE': '1', 13:08:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:08:40 INFO - 'NO_EM_RESTART': '1', 13:08:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:08:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:08:40 INFO - 'PWD': '/builds/slave/test', 13:08:40 INFO - 'SHELL': '/bin/bash', 13:08:40 INFO - 'SHLVL': '1', 13:08:40 INFO - 'TERM': 'linux', 13:08:40 INFO - 'TMOUT': '86400', 13:08:40 INFO - 'USER': 'cltbld', 13:08:40 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1467230586.323445-1134854676', 13:08:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:08:40 INFO - '_': '/tools/buildbot/bin/python'} 13:08:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:08:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:08:40 INFO - Running setup.py (path:/tmp/pip-7XLA3a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:08:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:08:40 INFO - Running setup.py (path:/tmp/pip-HkEert-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:08:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:08:40 INFO - Running setup.py (path:/tmp/pip-_IA8tZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:08:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:08:40 INFO - Running setup.py (path:/tmp/pip-TbCSOt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:08:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:08:40 INFO - Running setup.py (path:/tmp/pip-xfstd0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:08:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:08:40 INFO - Running setup.py (path:/tmp/pip-xyfxyK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:08:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:08:40 INFO - Running setup.py (path:/tmp/pip-AbNW1k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:08:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:08:40 INFO - Running setup.py (path:/tmp/pip-BPSRP_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:08:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:08:40 INFO - Running setup.py (path:/tmp/pip-1pwjKb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:08:41 INFO - Running setup.py (path:/tmp/pip-9JuftK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:08:41 INFO - Running setup.py (path:/tmp/pip-fOj3r8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:08:41 INFO - Running setup.py (path:/tmp/pip-0UaKGS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:08:41 INFO - Running setup.py (path:/tmp/pip-bAFe7D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:08:41 INFO - Running setup.py (path:/tmp/pip-H7axRN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:08:41 INFO - Running setup.py (path:/tmp/pip-qVMxNA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:08:41 INFO - Running setup.py (path:/tmp/pip-rmzBl0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:08:41 INFO - Running setup.py (path:/tmp/pip-wDEBqr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:08:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:08:41 INFO - Running setup.py install for manifestparser 13:08:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:08:41 INFO - Running setup.py install for mozcrash 13:08:41 INFO - Running setup.py install for mozdebug 13:08:41 INFO - Running setup.py install for mozdevice 13:08:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:08:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:08:42 INFO - Running setup.py install for mozfile 13:08:42 INFO - Running setup.py install for mozhttpd 13:08:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:08:42 INFO - Running setup.py install for mozinfo 13:08:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:08:42 INFO - Running setup.py install for mozInstall 13:08:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:08:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:08:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:08:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:08:42 INFO - Running setup.py install for mozleak 13:08:42 INFO - Running setup.py install for mozlog 13:08:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:08:42 INFO - Running setup.py install for moznetwork 13:08:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:08:42 INFO - Running setup.py install for mozprocess 13:08:42 INFO - Running setup.py install for mozprofile 13:08:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:08:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:08:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:08:42 INFO - Running setup.py install for mozrunner 13:08:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:08:43 INFO - Running setup.py install for mozscreenshot 13:08:43 INFO - Running setup.py install for moztest 13:08:43 INFO - Running setup.py install for mozversion 13:08:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:08:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:08:43 INFO - Cleaning up... 13:08:43 INFO - Return code: 0 13:08:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:08:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:08:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:08:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:08:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:08:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:43 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 0x1c3e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e6d400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efc570>, '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 0x1efd470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1efd900>, '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': 'fa44defc139c4ba8574fe040000001db-1467230586.323445-1134854676', '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 13:08:43 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 13:08:43 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 13:08:43 INFO - Using env: {'DISPLAY': ':0', 13:08:43 INFO - 'HOME': '/home/cltbld', 13:08:43 INFO - 'LANG': 'en_US.UTF-8', 13:08:43 INFO - 'LANGUAGE': 'en_US:en', 13:08:43 INFO - 'LOGNAME': 'cltbld', 13:08:43 INFO - 'MAIL': '/var/mail/cltbld', 13:08:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:08:43 INFO - 'MOZ_NO_REMOTE': '1', 13:08:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:08:43 INFO - 'NO_EM_RESTART': '1', 13:08:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:08:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:08:43 INFO - 'PWD': '/builds/slave/test', 13:08:43 INFO - 'SHELL': '/bin/bash', 13:08:43 INFO - 'SHLVL': '1', 13:08:43 INFO - 'TERM': 'linux', 13:08:43 INFO - 'TMOUT': '86400', 13:08:43 INFO - 'USER': 'cltbld', 13:08:43 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1467230586.323445-1134854676', 13:08:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:08:43 INFO - '_': '/tools/buildbot/bin/python'} 13:08:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:08:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:08:43 INFO - Running setup.py (path:/tmp/pip-J93urM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:08:43 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)) 13:08:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:08:43 INFO - Running setup.py (path:/tmp/pip-EKzcPZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:08:43 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)) 13:08:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:08:43 INFO - Running setup.py (path:/tmp/pip-u6SpkK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:08:43 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)) 13:08:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:08:43 INFO - Running setup.py (path:/tmp/pip-RPI8lt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:08:43 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)) 13:08:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:08:43 INFO - Running setup.py (path:/tmp/pip-lx_AZZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:08:44 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)) 13:08:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:08:44 INFO - Running setup.py (path:/tmp/pip-2UGQ2v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:08:44 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)) 13:08:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:08:44 INFO - Running setup.py (path:/tmp/pip-cMvLP8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:08:44 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)) 13:08:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:08:44 INFO - Running setup.py (path:/tmp/pip-rYmpOH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:08:44 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)) 13:08:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:08:44 INFO - Running setup.py (path:/tmp/pip-DkLm4x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:08:44 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)) 13:08:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:08:44 INFO - Running setup.py (path:/tmp/pip-_JpyRx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:08:44 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)) 13:08:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:08:44 INFO - Running setup.py (path:/tmp/pip-9Dilud-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:08:44 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)) 13:08:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:08:44 INFO - Running setup.py (path:/tmp/pip-6t8LyK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:08:44 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)) 13:08:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:08:44 INFO - Running setup.py (path:/tmp/pip-4Q2LHY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:08:44 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)) 13:08:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:08:44 INFO - Running setup.py (path:/tmp/pip-JIT9CH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:08:44 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)) 13:08:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:08:44 INFO - Running setup.py (path:/tmp/pip-O1fEU7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:08:44 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)) 13:08:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:08:44 INFO - Running setup.py (path:/tmp/pip-MQNABH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:08:44 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)) 13:08:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:08:44 INFO - Running setup.py (path:/tmp/pip-9ltNYZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:08:44 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)) 13:08:44 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)) 13:08:44 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)) 13:08:44 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)) 13:08:44 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)) 13:08:44 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)) 13:08:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:08:44 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 13:08:44 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 13:08:44 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 13:08:44 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 13:08:44 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 13:08:44 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 13:08:46 INFO - Downloading blessings-1.6.tar.gz 13:08:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:08:46 INFO - Installing collected packages: blessings 13:08:46 INFO - Running setup.py install for blessings 13:08:46 INFO - Successfully installed blessings 13:08:46 INFO - Cleaning up... 13:08:47 INFO - Return code: 0 13:08:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:08:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:08:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:08:47 INFO - Reading from file tmpfile_stdout 13:08:47 INFO - Current package versions: 13:08:47 INFO - argparse == 1.2.1 13:08:47 INFO - blessings == 1.6 13:08:47 INFO - blobuploader == 1.2.4 13:08:47 INFO - docopt == 0.6.1 13:08:47 INFO - functools32 == 3.2.3-2 13:08:47 INFO - jsonschema == 2.5.1 13:08:47 INFO - manifestparser == 1.1 13:08:47 INFO - mozInstall == 1.12 13:08:47 INFO - mozcrash == 0.17 13:08:47 INFO - mozdebug == 0.1 13:08:47 INFO - mozdevice == 0.48 13:08:47 INFO - mozfile == 1.2 13:08:47 INFO - mozhttpd == 0.7 13:08:47 INFO - mozinfo == 0.9 13:08:47 INFO - mozleak == 0.1 13:08:47 INFO - mozlog == 3.2 13:08:47 INFO - moznetwork == 0.27 13:08:47 INFO - mozprocess == 0.22 13:08:47 INFO - mozprofile == 0.28 13:08:47 INFO - mozrunner == 6.11 13:08:47 INFO - mozscreenshot == 0.1 13:08:47 INFO - mozsystemmonitor == 0.3 13:08:47 INFO - moztest == 0.7 13:08:47 INFO - mozversion == 1.4 13:08:47 INFO - psutil == 3.1.1 13:08:47 INFO - requests == 1.2.3 13:08:47 INFO - wsgiref == 0.1.2 13:08:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:08:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:08:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:08:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:08:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:08:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:47 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 0x1c3e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e6d400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efc570>, '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 0x1efd470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1efd900>, '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': 'fa44defc139c4ba8574fe040000001db-1467230586.323445-1134854676', '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 13:08:47 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 13:08:47 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 13:08:47 INFO - Using env: {'DISPLAY': ':0', 13:08:47 INFO - 'HOME': '/home/cltbld', 13:08:47 INFO - 'LANG': 'en_US.UTF-8', 13:08:47 INFO - 'LANGUAGE': 'en_US:en', 13:08:47 INFO - 'LOGNAME': 'cltbld', 13:08:47 INFO - 'MAIL': '/var/mail/cltbld', 13:08:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:08:47 INFO - 'MOZ_NO_REMOTE': '1', 13:08:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:08:47 INFO - 'NO_EM_RESTART': '1', 13:08:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:08:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:08:47 INFO - 'PWD': '/builds/slave/test', 13:08:47 INFO - 'SHELL': '/bin/bash', 13:08:47 INFO - 'SHLVL': '1', 13:08:47 INFO - 'TERM': 'linux', 13:08:47 INFO - 'TMOUT': '86400', 13:08:47 INFO - 'USER': 'cltbld', 13:08:47 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1467230586.323445-1134854676', 13:08:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:08:47 INFO - '_': '/tools/buildbot/bin/python'} 13:08:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:08:47 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)) 13:08:47 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)) 13:08:47 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)) 13:08:47 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)) 13:08:47 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)) 13:08:47 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)) 13:08:47 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)) 13:08:47 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)) 13:08:47 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)) 13:08:47 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)) 13:08:47 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)) 13:08:47 INFO - Cleaning up... 13:08:47 INFO - Return code: 0 13:08:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:08:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:08:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:08:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:08:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:08:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c3e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e6d400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efc570>, '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 0x1efd470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1efd900>, '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': 'fa44defc139c4ba8574fe040000001db-1467230586.323445-1134854676', '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 13:08:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 13:08:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 13:08:47 INFO - Using env: {'DISPLAY': ':0', 13:08:47 INFO - 'HOME': '/home/cltbld', 13:08:47 INFO - 'LANG': 'en_US.UTF-8', 13:08:47 INFO - 'LANGUAGE': 'en_US:en', 13:08:47 INFO - 'LOGNAME': 'cltbld', 13:08:47 INFO - 'MAIL': '/var/mail/cltbld', 13:08:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:08:47 INFO - 'MOZ_NO_REMOTE': '1', 13:08:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:08:47 INFO - 'NO_EM_RESTART': '1', 13:08:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:08:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:08:47 INFO - 'PWD': '/builds/slave/test', 13:08:47 INFO - 'SHELL': '/bin/bash', 13:08:47 INFO - 'SHLVL': '1', 13:08:47 INFO - 'TERM': 'linux', 13:08:47 INFO - 'TMOUT': '86400', 13:08:47 INFO - 'USER': 'cltbld', 13:08:47 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1467230586.323445-1134854676', 13:08:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:08:47 INFO - '_': '/tools/buildbot/bin/python'} 13:08:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:08:47 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:08:47 INFO - Cleaning up... 13:08:47 INFO - Return code: 0 13:08:47 INFO - Running post-action listener: _resource_record_post_action 13:08:47 INFO - Running post-action listener: _start_resource_monitoring 13:08:47 INFO - Starting resource monitoring. 13:08:47 INFO - ##### 13:08:47 INFO - ##### Finished create-virtualenv step (success) 13:08:47 INFO - ##### 13:08:47 INFO - ##### 13:08:47 INFO - ##### Running install step. 13:08:47 INFO - ##### 13:08:47 INFO - Running pre-action listener: _resource_record_pre_action 13:08:47 INFO - Running main action method: install 13:08:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:08:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:08:47 INFO - Reading from file tmpfile_stdout 13:08:47 INFO - Detecting whether we're running mozinstall >=1.0... 13:08:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:08:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:08:47 INFO - Reading from file tmpfile_stdout 13:08:47 INFO - Output received: 13:08:47 INFO - Usage: mozinstall [options] installer 13:08:47 INFO - Options: 13:08:47 INFO - -h, --help show this help message and exit 13:08:47 INFO - -d DEST, --destination=DEST 13:08:47 INFO - Directory to install application into. [default: 13:08:47 INFO - "/builds/slave/test"] 13:08:47 INFO - --app=APP Application being installed. [default: firefox] 13:08:47 INFO - mkdir: /builds/slave/test/build/application 13:08:47 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'] 13:08:47 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 13:09:04 INFO - Reading from file tmpfile_stdout 13:09:04 INFO - Output received: 13:09:04 INFO - /builds/slave/test/build/application/firefox/firefox 13:09:04 INFO - Running post-action listener: _resource_record_post_action 13:09:04 INFO - ##### 13:09:04 INFO - ##### Finished install step (success) 13:09:04 INFO - ##### 13:09:04 INFO - ##### 13:09:04 INFO - ##### Running run-tests step. 13:09:04 INFO - ##### 13:09:04 INFO - Running pre-action listener: _resource_record_pre_action 13:09:04 INFO - Running main action method: run_tests 13:09:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:09:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:09:04 INFO - Python 2.7.3 13:09:04 INFO - Return code: 0 13:09:04 INFO - grabbing minidump binary from tooltool 13:09:04 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')]} 13:09:04 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 0x1efc570>, '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 0x1efd470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1efd900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:09:04 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 13:09:04 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 13:09:04 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 13:09:04 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:09:04 INFO - Return code: 0 13:09:04 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:09:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:09:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:09:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:09:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:09:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ItgHgkJuQs6lLdTiQ9gDNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 13:09:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ItgHgkJuQs6lLdTiQ9gDNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-048 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 13:09:04 INFO - Using env: {'DISPLAY': ':0', 13:09:04 INFO - 'HOME': '/home/cltbld', 13:09:04 INFO - 'LANG': 'en_US.UTF-8', 13:09:04 INFO - 'LANGUAGE': 'en_US:en', 13:09:04 INFO - 'LOGNAME': 'cltbld', 13:09:04 INFO - 'MAIL': '/var/mail/cltbld', 13:09:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:09:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:09:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:09:04 INFO - 'MOZ_NO_REMOTE': '1', 13:09:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:09:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:09:04 INFO - 'NO_EM_RESTART': '1', 13:09:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:09:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:09:04 INFO - 'PWD': '/builds/slave/test', 13:09:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:09:04 INFO - 'SHELL': '/bin/bash', 13:09:04 INFO - 'SHLVL': '1', 13:09:04 INFO - 'TERM': 'linux', 13:09:04 INFO - 'TMOUT': '86400', 13:09:04 INFO - 'USER': 'cltbld', 13:09:04 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1467230586.323445-1134854676', 13:09:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:09:04 INFO - '_': '/tools/buildbot/bin/python'} 13:09:04 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ItgHgkJuQs6lLdTiQ9gDNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 13:09:04 INFO - mozversion application_buildid: 20160629072230 13:09:04 INFO - mozversion application_changeset: eeb6862f960c1310bde9aed159f3fc5bb2d4b6d7 13:09:04 INFO - mozversion application_display_name: Nightly 13:09:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:09:04 INFO - mozversion application_name: Firefox 13:09:04 INFO - mozversion application_remotingname: firefox 13:09:04 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 13:09:04 INFO - mozversion application_vendor: Mozilla 13:09:04 INFO - mozversion application_version: 50.0a1 13:09:04 INFO - mozversion platform_buildid: 20160629072230 13:09:04 INFO - mozversion platform_changeset: eeb6862f960c1310bde9aed159f3fc5bb2d4b6d7 13:09:04 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 13:09:04 INFO - mozversion platform_version: 50.0a1 13:09:04 INFO - using testdate: 1467230944 13:09:04 INFO - actual date: 1467230944 13:09:04 INFO - starting webserver on 'localhost:34547' 13:09:04 INFO - SUITE-START | Running 2 tests 13:09:04 INFO - TEST-START | dromaeo_css 13:09:04 INFO - operating with platform_type : linux_ 13:09:04 INFO - Initialising browser for dromaeo_css test... 13:09:04 INFO - TEST-INFO | started process 19032 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpr0cMTR/profile http://localhost:34547/getInfo.html) 13:09:09 INFO - PROCESS | 19032 | __metrics Screen width/height:1600/1200 13:09:09 INFO - PROCESS | 19032 | colorDepth:24 13:09:09 INFO - PROCESS | 19032 | Browser inner width/height: 1024/697 13:09:09 INFO - PROCESS | 19032 | __metrics 13:09:10 ERROR - PROCESS | 19032 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 13:09:11 INFO - TEST-INFO | 19032: exit 0 13:09:11 INFO - Browser initialized. 13:09:11 INFO - Running cycle 1/1 for dromaeo_css test... 13:09:11 INFO - TEST-INFO | started process 19152 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpr0cMTR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:09:23 INFO - PROCESS | 19152 | RSS: Main: 169517056 13:09:23 INFO - PROCESS | 19152 | 13:10:12 INFO - PROCESS | 19152 | 1467231012913 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] 13:12:25 INFO - PROCESS | 19152 | Cycle 1(1): loaded http://localhost:34547/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34547/tests/dromaeo/cssquery-ext.html) 13:12:26 INFO - PROCESS | 19152 | RSS: Main: 172294144 13:12:26 INFO - PROCESS | 19152 | 13:15:28 INFO - PROCESS | 19152 | Cycle 1(1): loaded http://localhost:34547/tests/dromaeo/cssquery-ext.html (next: http://localhost:34547/tests/dromaeo/cssquery-jquery.html) 13:15:29 INFO - PROCESS | 19152 | RSS: Main: 169189376 13:15:29 INFO - PROCESS | 19152 | 13:18:31 INFO - PROCESS | 19152 | Cycle 1(1): loaded http://localhost:34547/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34547/tests/dromaeo/cssquery-mootools.html) 13:18:31 INFO - PROCESS | 19152 | RSS: Main: 172019712 13:18:31 INFO - PROCESS | 19152 | 13:21:33 INFO - PROCESS | 19152 | Cycle 1(1): loaded http://localhost:34547/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34547/tests/dromaeo/cssquery-prototype.html) 13:21:34 INFO - PROCESS | 19152 | RSS: Main: 167518208 13:21:34 INFO - PROCESS | 19152 | 13:24:37 INFO - PROCESS | 19152 | Cycle 1(1): loaded http://localhost:34547/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34547/tests/dromaeo/cssquery-yui.html) 13:24:37 INFO - PROCESS | 19152 | RSS: Main: 169766912 13:24:37 INFO - PROCESS | 19152 | 13:27:40 INFO - PROCESS | 19152 | Cycle 1(1): loaded http://localhost:34547/tests/dromaeo/cssquery-yui.html (next: http://localhost:34547/tests/dromaeo/cssquery-dojo.html) 13:27:40 INFO - PROCESS | 19152 | RSS: Main: 170823680 13:27:40 INFO - PROCESS | 19152 | 13:27:40 INFO - PROCESS | 19152 | __start_tp_report 13:27:40 INFO - PROCESS | 19152 | _x_x_mozilla_page_load 13:27:40 INFO - PROCESS | 19152 | _x_x_mozilla_page_load_details 13:27:40 INFO - PROCESS | 19152 | |i|pagename|runs| 13:27:40 INFO - PROCESS | 19152 | |0;dojo.html;2644.6561946946895;2676.5851293049586;2680.2093382452167;2694.9865250673743;2704.1481933191044;4676.812927482905;4746.881327966803;4787.473377928425;4818.060478206751;4864.829730959417;4690.788914498856;4838.806447742086;4892.094962431953;4895.0454661341055;4909.656324057318;4447.488538818037;4485.237509623372;4521.050579378318;4543.727376357413;4544.522825103366;4216.7680777557225;4495.415595972535;4504.842330518432;4572.222722137245;4577.816887324503;4369.169857727022;4389.034412429261;4407.537208593084;4408.448943882015;4446.1996840568845;4389.275769498029;4427.512973572904;4476.955230447719;4486.55134486552;4490.8877278067985;4438.068005718803;4476.507584165739;4476.992676647761;4497.482789479219;4516.909661806745;4787.16224660683;4814.855554333376;4838.491958344393;4842.12841688496;4886.14492463821;5177.223416487519;5196.870078248036;5197.220416937452;5225.954809038208;5249.212618107276;5058.519440653132;5122.1036318644465;5245.186996015624;5245.4754524547625;5266.499682530153;4798.1123492154065;4831.710097394168;4870.829520966749;4876.439209490883;4922.630802689777;5310.123829568078;5327.094393953037;5340.946590534123;5347.893042139135;5407.567394608422;4936.8765780855765;5072.797088116434;5111.539961403491;5123.462036486189;5123.487651234846;5079.847604571869;5217.973910130425;5244.29202057725;5247.632665713363;5282.366116066097;5006.824761133343;5031.018951304533;5056.64603477753;5097.923531147036;5114.514121158484;5056.544910958031;5058.114829904752;5078.949210507922;5098.056859480934;5132.5124113209185;4402.669799765031;4412.514623391425;4420.9336859947125;4463.598276155161;4465.464144302705;3818.8854334369457;3830.2148059647707;3860.247251785931;3867.284552357823;3885.9611403886165;4363.8435814509185;4403.9779801100785;4492.05666809967;4508.864734057984;4537.591616754508;5226.712530810842;5231.738413079407;5235.633505654644;5288.735563221823;5307.389650190277;4504.977475112603;4508.436445444319;4549.294859296814;4555.772211389417;4605.470370907388;4575.22221222393;4695.600873925686;4720.929186062212;4734.621230301567;4750.61995040396;4946.233333833262;4966.701997880139;4970.3290055842;4971.627127965345;4987.850364489072;5233.3196684432305;5288.233206185005;5310.628256022196;5314.070037743302;5340.786368545215;4770.5706486415;4835.347228124158;4851.854444366674;4885.511448855086;4958.578520825626;5094.847154585368;5113.3097031900215;5119.283300337881;5131.409887862795;5154.329937108152;5146.305248791366;5152.149895267389;5161.509656582619;5167.121589329748;5168.53483186515;4910.386201724785;4914.65597408178;5019.949800501949;5059.898802024012;5098.133317335987;5045.5459008689395;5071.416787069535;5080.593552515864;5083.059633967728;5107.131787596192;4908.7300198488;4930.359053323045;4948.455669876383;4987.47631498702;5022.773975171199;4975.925361119658;5035.697858128524;5075.923861142012;5087.592992560512;5108.335916330853;4985.6260780442335;4988.975055124701;5004.324416203766;5022.869854282903;5079.517445842639 13:27:40 INFO - PROCESS | 19152 | |1;ext.html;529.6643796169909;584.4506164205646;598.5929567893832;598.6019297167384;657.1818086482331;34997.12507187322;38839.41740873889;39106.8044659777;39294.410583841265;39414.211715765705;39379.21241575167;39522.40716389257;39793.80103099488;39842.20315593686;39961.80019099908;7840.372770178386;7864.528128312291;7929.881051784228;7963.681452741912;7989.800254993643;7859.174786647405;7941.28528432441;7944.443888927777;7958.602069896511;7972.641231144612;7993.2806047455715;7994.680212791511;7997.080335761404;8031.759047228593;8037.95981020094;7939.801504962365;7941.126476087655;7972.920270797275;7973.800654983614;7990.840183196304;7861.646225919847;7892.0529536455415;7942.007249093864;7953.920460795433;7965.044194696616;37697.62302376969;37905.81047094747;37945.62054379449;37985.24029519422;38022;3024.833634150121;3260.2012506935716;3326.640957341088;3620.420732682758;3625.1299688074673;29743.851280743456;29836.104916852528;29838.403231935456;30368.240793980105;30421.847890760626;3390.3897298486263;3394.59264888215;3416.6583341665632;3423.5891692997;3466.133466633342;180722;181749.09125454287;182239;182808;182855.08572457187;49140.75429622829;49155.754221228664;49302;49317.26024109641;49357.50642493601;33381.66618333785;34437.31125377479;34629.82685086609;36739.4489082664;57693.69225231028;15404.537863864101;15564.92217538905;15576.143312117942;15600.29798659063;15651.608709782118;11761.764764704658;11791.469383877746;11881.940590296994;11902.940485297519;11904.226225295328;18855.90572047131;18908.527286817938;18919.43241702751;18956.90521547411;19010;6858.2168636153965;6968.756093536803;6989.860202795916;7103.623952715506;7237.8552428951125;816.7263966571146;900.5497251374313;982.6069572171189;985.3053597213947;986.4032260482448;28673.13980580586;29441;29456.522280743062;29476.557851632242;29562.556561651592;976.4043933200742;980.3774603127066;982.6609819612222;996.5017491254373;1044.6552637629563;15430.768538471932;15457.381704731684;15523.767143492856;15695.450659226872;15752.606184845241;359917;363013;364927;366889;367369;50132.24801627979;51106.23340649893;51299.74350128225;51325.74337128291;51589;1196.4137572589368;1209.2563073709605;1214.228964607463;1216.5073145376136;1226.055936928578;26953.730462695123;27795.58306625443;28194.43611127807;28666.71333286724;28758.71241287644;44416.33375499305;44541;44673;45091.7745411284;45130;311238;314281;314831;315806;316115;25654.358641034123;26065.478690426466;26070.739292607588;26077;26104.216873493824;43121.568784311756;43133.56866431295;43933;44560.55439445564;44831.32753008773;36268.27463450769;36365;36405.45391819072;36666.083347916516;36724.44913326249;31286.687133128376;31320.37359252848;31327.686723132476;31563.52801191913;32187.195320117185;36677;37429.251414972096;37487.43768843524;38074.42888356732;38080;31294;32709.509357360133;32834.67165328316;32966.175845604055;33164.83417582993;25511;25559.488810224062;25795.226143215732;26133.869330653226;26229.73770262273 13:27:40 INFO - PROCESS | 19152 | |2;jquery.html;360.6916086745834;363.3659264583302;364.66815198169667;376.63842710997443;382.94447305140756;16212.432564860217;16873.746893796586;17699.734503982418;18006.459806205836;18172.636547269045;16600.25298861551;16683.332666693346;17495.650086998285;17561.56096097595;17703;5189.584833213334;5325.946740532584;5351.491608297225;5357.303550538444;5365.980463711901;5089.923651145235;5310.973445132769;5345.652532585389;5351.973240133794;5414.3232095988005;5412.512873841353;5414.512693857552;5447.727613619323;5458.372287186965;5471.480209380123;5350.491703288181;5458.317710286215;5472.26124473197;5638.492535671769;5640.351359593658;5374.167004114369;5405.27028851104;5425.83722488322;5426.647267927572;5455.645383050129;18748.906255468773;20134.79865201344;20218.595628087354;20636.27773027952;20654.07056682453;1928.3732786844191;2063.2778527515397;2197.209004758302;2245.7305123385136;2362.385779697291;8914.598843052014;9100.453972761588;9122.315826312986;11187.32876027441;12480.75038499234;1699.7875265591802;1782.3138091834737;1812.18451696737;1846.7414561961336;1884.9717254241198;67049.3295067048;68411;71482.64258678726;71943.92084118743;72982;9906.108450239513;10041.246906482043;10204.642837500653;10212.234082443847;10216.795664086676;13755.449782008807;13808.792868106986;13854.445822167201;13937.512187073606;13948.651283717989;6964.860702785916;7065.328793764687;7095.9290407096305;7141.214466408691;7259.52813067149;6447.516436267299;6475.579087359307;6496.090547323284;6609.107770450928;6619;4155.8675036330105;4203.822929579723;4335.934960975588;4359.520452750195;4409.294512877924;1772.8404443600139;1854.4343975087459;1863.3478282601252;1878.9718154227699;1884.1992153335052;793.6547601793238;873.4497266721925;898.2006014646969;928.3640706116332;944.1455482788087;16868;16943.322267109423;17048.147592620568;17660.823391765916;17744.11279436023;822.0751654388813;829.3655353654459;859.3254295378098;890.2788741119714;892.0811564088999;9277.304202184863;9567.091126342986;9570.377925434825;9646.228301735844;9818.361806482555;402635;409825;415375;417536;417798;55749.721251394294;69816;71025.64487177531;79832.60083699544;81466;865.8051888394102;883.0418995389946;892.2549671024638;893.3567831161554;893.6068130022769;15062.32219550101;15459.922700386425;15574.688506230039;15577;15693.136877471848;35651.28697426089;36250.09374765652;36550;37227.813860930524;37477.4378384319;51630;54770.72614637061;54863.45136548583;55005.174922375394;55359.169612455036;7040.718371265092;7192.31672991065;7212.386947109554;7321.341079302888;7347.669354878936;8309.584520773817;11043.83434248503;11135.443227838738;11169.553217871195;11182.944085279521;8058.83882322362;8625.482471051757;8804.075572064841;8885.333599979898;9195.77010574741;8920.643174272956;9130.269578433577;9259.72220833376;9564.904350956402;9776.413415195111;8720.738377848675;8813.735587932373;9013.594388252413;9074.27405807547;9345.205657519187;6759.966200168968;7073.787786366417;7256.383207427428;7317.780466586011;7345.375643070185;6729;7658.387329013777;8676.134631054354;8805.471671699719;8915.286777057949 13:27:40 INFO - PROCESS | 19152 | |3;mootools.html;1370.5408688089487;1409.6546346145192;1485.2944851195684;1709.752085947537;1711.178634255558;6816.591004539731;7266.818329541764;7656.732014379498;7753.961230193848;7758.806029849256;7760.961195194016;7981.28168464838;8044.511765323419;8050.758477245678;8053.43625946184;2220.134147682405;2254.88725563722;2264.5923733727923;2268.3761965459466;2270.5004898922293;2185.1368709359795;2195.2316689158747;2240.5294888073445;2248.336740661509;2250.2574150530286;2209.2930262316067;2229.9665505017438;2241.8430709850318;2257.3115199864037;2264.9773502265016;2162.902669379882;2175.380016695234;2184.759676435591;2198.604251234777;2204.911803527857;2179.2372669565525;2194.2100843696257;2200.834937379687;2203.4711669199437;2204.578047159589;7998.720044798462;8005.879911801328;8022.799430014238;8036.196380361976;8106.229908158715;4546.318052292149;4661.533846615345;4683.180443422388;4687.906241875177;4692.906141877143;2776.361436869511;2939.3533422646983;2956.231379841257;2957.31981644223;2979.1509419815247;930.3348106104168;932.6828878181451;955.8422860228054;961.1541843178029;977.3695966101825;10706.625268115578;10749.140068794477;10768.838467422995;10838;10866.293690910066;4016.9196616067516;4112.136451345251;4233.470816147981;4238.894027649333;4271.9359209611885;9265.25877929764;9310.208632266333;9351.064893510595;9357.344985850925;9362.62549498026;4654.906901861944;4656.32483289921;4665.136949664255;4685.765711714401;4691.413573303337;3717.5353080864893;4065.89835254121;4229.661627069827;4241.1093670328955;4290.442242508454;3652.433872749728;3674.375356189454;3716.9628303716618;3787.14789172434;3794.2032173243374;1185.6383802940186;1197.4671271284194;1206.7043574324346;1209.7520008398433;1215.9209651372632;760.9277118673717;765.3150430364792;808.3250485844386;812.829305845779;819.4182130687279;4786.401699787527;5127.589792816566;5210.478952104835;5276.208568714724;5357.651752636144;391.99216015679525;412.59771722570855;416.4981197656816;417.7869286663823;419.2014212924384;3577.5349204603235;3603.3694103531775;3646.106703857572;3875.1280961783373;3889.5721470638773;9659.855102173473;9755;9842.704718858446;9874.160696340892;9925.2059835213;9727.07592778685;9729.416235025921;9740.707778766648;9768.316217864824;9777.120059194707;6872.484563657746;7014.824629384204;7084.397826184729;7087.0432491614;7108.964455177691;5349.331333583302;5420.186971954238;5425.484578964992;5518.2826232589505;5524.723763811713;9064;9070.047644997445;9138.268938484773;9144.3598948073;9227.215686666708;8674.826503470022;9058.411203271766;9060.864087038832;9179.17387435134;9342.626294948126;6214.72033758491;6591.736330546724;6813.3527314905;6871.931280687129;6925.722971081101;7711.884321735066;7756.224377562198;7817.335526480313;7846.450748447553;7852.7251546197895;6877.449804015767;6961.164660240804;7060.894086588808;7198.5680859148615;7224.096987876515;6956.513044086865;6964.512484126062;6974.37230649244;7037.964810175917;7101.538400003983;6032.849178770566;6033.517318614413;6042.879142417215;6053.697315134137;6071.878562428815;4513.977430112828;4543.727376357429;4558.225101732647;4604.447466304065;4624;4557.840475583339;4578.2903649934315;4605.769711514344;4610.631149507964;4653.046125544188 13:27:40 INFO - PROCESS | 19152 | |4;prototype.html;288.51529430556667;295.3296018039051;297.7528651219488;301.28895805898077;303.329641492302;4950.475257618614;5074.238864170367;5109.441620305805;5128.589712822974;5148.845534633967;4772.401416212313;4960.305557221992;5059.721715305656;5068.84793456196;5100.897982040357;3961.8217180226957;3990.461287726156;4007.1184339445276;4018.4575082363945;4022.235775202702;3989.6608788253034;4000.7599544027453;4006.0755648376703;4017.1563971566006;4021;3706.9991102402337;3922.3332033554366;3936.323300155893;3984.561698213194;3986.880393588197;3882.670397761349;3910.7262491625597;3916.2559113768434;3927.4501569780255;3930.9803450982704;3428.708559772422;3435.4159792835276;3440.518327434161;3444;3455.6371580984137;4923.249064652628;5109.642325037249;5117.590592752571;5119.513646203604;5122;4495.685302028859;4505.5269196734525;4507.661925355612;4510.391097201868;4511.571400716926;5312;5349.833317506416;5370.516653501165;5386.542143917772;5412.188171774226;3756.4740936268945;3756.6055564165918;3760.6051364606597;3770.472133901256;3772.0758414188426;5265.842024739264;5448.291722076105;5470.64440811346;5627.2684551008515;5633.464820842013;3806.7906265155684;3815.637514436124;3824.3116239076676;3827.3684842001317;3852.6725228355904;3877.8254978526033;3893.1824316893203;3900.687944964453;3903.941440878389;3907.4138879167785;4487.371767952489;4491.977540112279;4506.504284528699;4507.301368287921;4515.751633660115;5157.871053223625;5308.177232528964;5310.999285403735;5323.387810401776;5323.787048518016;1307.9340337624806;1323.7352529493946;1325.9204447733166;1330.5276626797347;1332.2406228449884;824.6660102658433;841.2050612171439;846.1876598465542;857.8370109679141;862.844687956174;4215.59951804578;4256.404103425523;4259.488861336597;4262.422903525653;4278.336857786986;4946.530079642428;4950.628702847229;4956.231784073474;4962.900741985212;4984.675996060317;4206.26390381682;4212.967822883413;4247.405363249148;4253.48958125027;4280.993966417889;2470.3330100872663;2633.2231991562535;2639.2741995950882;2643.70919198888;2672.679278486594;4640.79116439761;4649.279766486422;4653.604443622262;4657.790399432034;4711;4989.850304490871;5004.449510553836;5039.5810011194835;5044.956792499043;5072.61587054084;4778.4982576829625;5231.476852314738;5253.999999999924;5280.755678836403;5289.338832645919;5606.327240731139;5606.943930560642;5614.07367784311;5632.633878797865;5643.604947653789;5224.791008359623;5443.374011988672;5478.91781623284;5487;5522.22688823557;4994.175960966545;5115.335006449138;5238;5240.480260724347;5248.816291429782;3832.7125465589634;3850.4609354690924;3873.96126038736;3879.4956655634587;3885.825137868746;5504.201890725903;5551.22282880389;5571.637843540157;5593.748281327269;5595.104783234663;5271.655727789389;5386.741021681826;5395.465969789794;5408.594355423437;5422.457754224703;5356.250124982584;5376.462353764592;5390.110631745718;5394.9460505394445;5428.972855135699;5078.619103567174;5239.554637855825;5298.549623282064;5310;5351.224072509543;5448.727563621882;5451.155070964007;5452.727363631882;5452.745868450199;5457.263269458731;5267.868303292448;5302.973485132704;5307.328191619627;5339.145736682112;5353.384360798403 13:27:40 INFO - PROCESS | 19152 | |5;yui.html;597.6892016151601;603.2097951683295;644.3556443556444;675.1155985658787;685.2975699907594;11585;12470.064745144105;12501.249925004506;12542.498300067986;12569;12123.939380303109;12979.480820767181;12985.09104362695;13349.199048057124;13375.13061650992;633.3318349141654;765.7473033898827;784.3999340504519;797.9042514898221;802.7230605441114;794.0154208781128;798.0702481608919;804.1556365815899;804.6097642643314;805.3114587028065;837.7696133563288;846.196113691992;847.9618417171212;848.6181218451691;849.8385306791721;829;832.6045128563944;834.5493433545847;837.2715737308581;838.7944953486405;612.543654977045;612.7212118486123;613;614.0114415790573;616.072810420319;12068.275903445734;12086.637400877988;12101.757964840743;12181.817272740916;12184.147109702324;12677;12975.156614820007;13094.279814610192;13113.934430327883;13185.406656700472;10072.597096116147;10076.546555405024;10320.277580569364;10338.379697218192;10369.948150259275;3207.9679203208134;3226.483762597973;3254.0400581828417;3318.767686261963;3348.7990720556845;68246;68720.6563967182;68884;69017;69142.30857691409;9604.95197524008;9768.21854251658;9996.400215987063;10053.246006549538;10102.444365559964;18255.452336429928;18258.269669213347;18278.360257390927;18351.54121146982;18358.357457488924;6528.738850446024;6597.769078082244;6755.459563234929;6921.823290040706;6927.168739751161;3686.060054686038;3780.9621903781162;3804.087019115392;3837.6354246346555;3879.7866117363815;2855.11491437655;2885.264257614337;2925.590417341574;2955.4827905116517;2978.1214541710247;472.8841433848729;477.23403936681126;478.9736564488917;482.1971417589744;487.6537658262673;443.2575436144445;498.8902441462872;547.9863003424946;554.3957086775434;555.1145922253999;7516.135644400854;7551.358134558624;7607.429442791813;7752.922470775333;7917;527.8838655495784;530.7346326836582;550.4986113993747;558.6508432229856;567.8060907395898;3510.8771193008124;3544.1848374873925;3648.85404583819;3657.305112028706;3680.8159592020293;74226;74253;91983;94033;99258;78135;79049.60475197702;79407.20592793998;79577.60211198906;79678;43625.78187109044;52315.476845231824;70775.64612176907;71527.49653762093;71647;8012.278894899487;8117.10711821711;8177.182281771775;8241.670333186605;8317.625706843328;41514.1697166049;42686.78656606697;43089.7845510783;43300.56699433091;44368.11263774771;54216.18675719946;54626.18060729013;56414.43585564092;60340.396596033475;61920.380796191464;10564.841527376942;10614.363138211733;10642.308249963728;10690.839637405601;10772.192085593455;11951.043916486486;12298.139130260795;12560.183588066746;12775.936120319338;13323.933380333036;11854.762904742029;11882.82175767347;11998.340091295062;12252.754944900873;12529.215067749159;11586.536538538365;11827.231229970024;11916.821247681464;11961.700957476132;12139;11141.16441266892;11313.151513636674;11406.657800266004;11518.193726439404;11690.824637630272;8333.291670207858;8595.785105372415;8643.87034194475;8707.129287071242;8866.42368246062;8897.644094236159;9160.024463858606;9184;9194.540272986458;9245.352825302165 13:27:40 INFO - PROCESS | 19152 | __end_tp_report 13:27:40 INFO - PROCESS | 19152 | __start_cc_report 13:27:40 INFO - PROCESS | 19152 | _x_x_mozilla_cycle_collect,401 13:27:40 INFO - PROCESS | 19152 | __end_cc_report 13:27:40 INFO - PROCESS | 19152 | __startTimestamp1467232060561__endTimestamp 13:27:40 INFO - PROCESS | 19152 | 13:27:40 INFO - PROCESS | 19152 | ------- Summary: start ------- 13:27:40 INFO - PROCESS | 19152 | Number of tests: 6 13:27:40 INFO - PROCESS | 19152 | 13:27:40 INFO - PROCESS | 19152 | [#0] dojo.html Cycles:165 Average:4795.78 Median:4930.36 stddev:505.14 (10.2%) stddev-sans-first:477.67 13:27:40 INFO - PROCESS | 19152 | Values: 2644.7 2676.6 2680.2 2695.0 2704.1 4676.8 4746.9 4787.5 4818.1 4864.8 4690.8 4838.8 4892.1 4895.0 4909.7 4447.5 4485.2 4521.1 4543.7 4544.5 4216.8 4495.4 4504.8 4572.2 4577.8 4369.2 4389.0 4407.5 4408.4 4446.2 4389.3 4427.5 4477.0 4486.6 4490.9 4438.1 4476.5 4477.0 4497.5 4516.9 4787.2 4814.9 4838.5 4842.1 4886.1 5177.2 5196.9 5197.2 5226.0 5249.2 5058.5 5122.1 5245.2 5245.5 5266.5 4798.1 4831.7 4870.8 4876.4 4922.6 5310.1 5327.1 5340.9 5347.9 5407.6 4936.9 5072.8 5111.5 5123.5 5123.5 5079.8 5218.0 5244.3 5247.6 5282.4 5006.8 5031.0 5056.6 5097.9 5114.5 5056.5 5058.1 5078.9 5098.1 5132.5 4402.7 4412.5 4420.9 4463.6 4465.5 3818.9 3830.2 3860.2 3867.3 3886.0 4363.8 4404.0 4492.1 4508.9 4537.6 5226.7 5231.7 5235.6 5288.7 5307.4 4505.0 4508.4 4549.3 4555.8 4605.5 4575.2 4695.6 4720.9 4734.6 4750.6 4946.2 4966.7 4970.3 4971.6 4987.9 5233.3 5288.2 5310.6 5314.1 5340.8 4770.6 4835.3 4851.9 4885.5 4958.6 5094.8 5113.3 5119.3 5131.4 5154.3 5146.3 5152.1 5161.5 5167.1 5168.5 4910.4 4914.7 5019.9 5059.9 5098.1 5045.5 5071.4 5080.6 5083.1 5107.1 4908.7 4930.4 4948.5 4987.5 5022.8 4975.9 5035.7 5075.9 5087.6 5108.3 4985.6 4989.0 5004.3 5022.9 5079.5 13:27:40 INFO - PROCESS | 19152 | 13:27:40 INFO - PROCESS | 19152 | [#1] ext.html Cycles:180 Average:44499.00 Median:200796.54 stddev:78163.75 (38.9%) stddev-sans-first:78313.30 13:27:40 INFO - PROCESS | 19152 | Values: 529.7 584.5 598.6 598.6 657.2 34997.1 38839.4 39106.8 39294.4 39414.2 39379.2 39522.4 39793.8 39842.2 39961.8 7840.4 7864.5 7929.9 7963.7 7989.8 7859.2 7941.3 7944.4 7958.6 7972.6 7993.3 7994.7 7997.1 8031.8 8038.0 7939.8 7941.1 7972.9 7973.8 7990.8 7861.6 7892.1 7942.0 7953.9 7965.0 37697.6 37905.8 37945.6 37985.2 38022.0 3024.8 3260.2 3326.6 3620.4 3625.1 29743.9 29836.1 29838.4 30368.2 30421.8 3390.4 3394.6 3416.7 3423.6 3466.1 180722.0 181749.1 182239.0 182808.0 182855.1 49140.8 49155.8 49302.0 49317.3 49357.5 33381.7 34437.3 34629.8 36739.4 57693.7 15404.5 15564.9 15576.1 15600.3 15651.6 11761.8 11791.5 11881.9 11902.9 11904.2 18855.9 18908.5 18919.4 18956.9 19010.0 6858.2 6968.8 6989.9 7103.6 7237.9 816.7 900.5 982.6 985.3 986.4 28673.1 29441.0 29456.5 29476.6 29562.6 976.4 980.4 982.7 996.5 1044.7 15430.8 15457.4 15523.8 15695.5 15752.6 359917.0 363013.0 364927.0 366889.0 367369.0 50132.2 51106.2 51299.7 51325.7 51589.0 1196.4 1209.3 1214.2 1216.5 1226.1 26953.7 27795.6 28194.4 28666.7 28758.7 44416.3 44541.0 44673.0 45091.8 45130.0 311238.0 314281.0 314831.0 315806.0 316115.0 25654.4 26065.5 26070.7 26077.0 26104.2 43121.6 43133.6 43933.0 44560.6 44831.3 36268.3 36365.0 36405.5 36666.1 36724.4 31286.7 31320.4 31327.7 31563.5 32187.2 36677.0 37429.3 37487.4 38074.4 38080.0 31294.0 32709.5 32834.7 32966.2 33164.8 25511.0 25559.5 25795.2 26133.9 26229.7 13:27:40 INFO - PROCESS | 19152 | 13:27:40 INFO - PROCESS | 19152 | [#2] jquery.html Cycles:180 Average:24737.09 Median:5420.17 stddev:68004.62 (1254.7%) stddev-sans-first:68170.76 13:27:40 INFO - PROCESS | 19152 | Values: 360.7 363.4 364.7 376.6 382.9 16212.4 16873.7 17699.7 18006.5 18172.6 16600.3 16683.3 17495.7 17561.6 17703.0 5189.6 5325.9 5351.5 5357.3 5366.0 5089.9 5311.0 5345.7 5352.0 5414.3 5412.5 5414.5 5447.7 5458.4 5471.5 5350.5 5458.3 5472.3 5638.5 5640.4 5374.2 5405.3 5425.8 5426.6 5455.6 18748.9 20134.8 20218.6 20636.3 20654.1 1928.4 2063.3 2197.2 2245.7 2362.4 8914.6 9100.5 9122.3 11187.3 12480.8 1699.8 1782.3 1812.2 1846.7 1885.0 67049.3 68411.0 71482.6 71943.9 72982.0 9906.1 10041.2 10204.6 10212.2 10216.8 13755.4 13808.8 13854.4 13937.5 13948.7 6964.9 7065.3 7095.9 7141.2 7259.5 6447.5 6475.6 6496.1 6609.1 6619.0 4155.9 4203.8 4335.9 4359.5 4409.3 1772.8 1854.4 1863.3 1879.0 1884.2 793.7 873.4 898.2 928.4 944.1 16868.0 16943.3 17048.1 17660.8 17744.1 822.1 829.4 859.3 890.3 892.1 9277.3 9567.1 9570.4 9646.2 9818.4 402635.0 409825.0 415375.0 417536.0 417798.0 55749.7 69816.0 71025.6 79832.6 81466.0 865.8 883.0 892.3 893.4 893.6 15062.3 15459.9 15574.7 15577.0 15693.1 35651.3 36250.1 36550.0 37227.8 37477.4 51630.0 54770.7 54863.5 55005.2 55359.2 7040.7 7192.3 7212.4 7321.3 7347.7 8309.6 11043.8 11135.4 11169.6 11182.9 8058.8 8625.5 8804.1 8885.3 9195.8 8920.6 9130.3 9259.7 9564.9 9776.4 8720.7 8813.7 9013.6 9074.3 9345.2 6760.0 7073.8 7256.4 7317.8 7345.4 6729.0 7658.4 8676.1 8805.5 8915.3 13:27:40 INFO - PROCESS | 19152 | 13:27:40 INFO - PROCESS | 19152 | [#3] mootools.html Cycles:180 Average:5186.22 Median:4957.00 stddev:2937.85 (59.3%) stddev-sans-first:2932.10 13:27:40 INFO - PROCESS | 19152 | Values: 1370.5 1409.7 1485.3 1709.8 1711.2 6816.6 7266.8 7656.7 7754.0 7758.8 7761.0 7981.3 8044.5 8050.8 8053.4 2220.1 2254.9 2264.6 2268.4 2270.5 2185.1 2195.2 2240.5 2248.3 2250.3 2209.3 2230.0 2241.8 2257.3 2265.0 2162.9 2175.4 2184.8 2198.6 2204.9 2179.2 2194.2 2200.8 2203.5 2204.6 7998.7 8005.9 8022.8 8036.2 8106.2 4546.3 4661.5 4683.2 4687.9 4692.9 2776.4 2939.4 2956.2 2957.3 2979.2 930.3 932.7 955.8 961.2 977.4 10706.6 10749.1 10768.8 10838.0 10866.3 4016.9 4112.1 4233.5 4238.9 4271.9 9265.3 9310.2 9351.1 9357.3 9362.6 4654.9 4656.3 4665.1 4685.8 4691.4 3717.5 4065.9 4229.7 4241.1 4290.4 3652.4 3674.4 3717.0 3787.1 3794.2 1185.6 1197.5 1206.7 1209.8 1215.9 760.9 765.3 808.3 812.8 819.4 4786.4 5127.6 5210.5 5276.2 5357.7 392.0 412.6 416.5 417.8 419.2 3577.5 3603.4 3646.1 3875.1 3889.6 9659.9 9755.0 9842.7 9874.2 9925.2 9727.1 9729.4 9740.7 9768.3 9777.1 6872.5 7014.8 7084.4 7087.0 7109.0 5349.3 5420.2 5425.5 5518.3 5524.7 9064.0 9070.0 9138.3 9144.4 9227.2 8674.8 9058.4 9060.9 9179.2 9342.6 6214.7 6591.7 6813.4 6871.9 6925.7 7711.9 7756.2 7817.3 7846.5 7852.7 6877.4 6961.2 7060.9 7198.6 7224.1 6956.5 6964.5 6974.4 7038.0 7101.5 6032.8 6033.5 6042.9 6053.7 6071.9 4514.0 4543.7 4558.2 4604.4 4624.0 4557.8 4578.3 4605.8 4610.6 4653.0 13:27:40 INFO - PROCESS | 19152 | 13:27:40 INFO - PROCESS | 19152 | [#4] prototype.html Cycles:180 Average:4357.92 Median:4953.43 stddev:1293.61 (26.1%) stddev-sans-first:1260.66 13:27:40 INFO - PROCESS | 19152 | Values: 288.5 295.3 297.8 301.3 303.3 4950.5 5074.2 5109.4 5128.6 5148.8 4772.4 4960.3 5059.7 5068.8 5100.9 3961.8 3990.5 4007.1 4018.5 4022.2 3989.7 4000.8 4006.1 4017.2 4021.0 3707.0 3922.3 3936.3 3984.6 3986.9 3882.7 3910.7 3916.3 3927.5 3931.0 3428.7 3435.4 3440.5 3444.0 3455.6 4923.2 5109.6 5117.6 5119.5 5122.0 4495.7 4505.5 4507.7 4510.4 4511.6 5312.0 5349.8 5370.5 5386.5 5412.2 3756.5 3756.6 3760.6 3770.5 3772.1 5265.8 5448.3 5470.6 5627.3 5633.5 3806.8 3815.6 3824.3 3827.4 3852.7 3877.8 3893.2 3900.7 3903.9 3907.4 4487.4 4492.0 4506.5 4507.3 4515.8 5157.9 5308.2 5311.0 5323.4 5323.8 1307.9 1323.7 1325.9 1330.5 1332.2 824.7 841.2 846.2 857.8 862.8 4215.6 4256.4 4259.5 4262.4 4278.3 4946.5 4950.6 4956.2 4962.9 4984.7 4206.3 4213.0 4247.4 4253.5 4281.0 2470.3 2633.2 2639.3 2643.7 2672.7 4640.8 4649.3 4653.6 4657.8 4711.0 4989.9 5004.4 5039.6 5045.0 5072.6 4778.5 5231.5 5254.0 5280.8 5289.3 5606.3 5606.9 5614.1 5632.6 5643.6 5224.8 5443.4 5478.9 5487.0 5522.2 4994.2 5115.3 5238.0 5240.5 5248.8 3832.7 3850.5 3874.0 3879.5 3885.8 5504.2 5551.2 5571.6 5593.7 5595.1 5271.7 5386.7 5395.5 5408.6 5422.5 5356.3 5376.5 5390.1 5394.9 5429.0 5078.6 5239.6 5298.5 5310.0 5351.2 5448.7 5451.2 5452.7 5452.7 5457.3 5267.9 5303.0 5307.3 5339.1 5353.4 13:27:40 INFO - PROCESS | 19152 | 13:27:40 INFO - PROCESS | 19152 | [#5] yui.html Cycles:180 Average:16797.24 Median:26421.68 stddev:23559.25 (89.2%) stddev-sans-first:23593.94 13:27:40 INFO - PROCESS | 19152 | Values: 597.7 603.2 644.4 675.1 685.3 11585.0 12470.1 12501.2 12542.5 12569.0 12123.9 12979.5 12985.1 13349.2 13375.1 633.3 765.7 784.4 797.9 802.7 794.0 798.1 804.2 804.6 805.3 837.8 846.2 848.0 848.6 849.8 829.0 832.6 834.5 837.3 838.8 612.5 612.7 613.0 614.0 616.1 12068.3 12086.6 12101.8 12181.8 12184.1 12677.0 12975.2 13094.3 13113.9 13185.4 10072.6 10076.5 10320.3 10338.4 10369.9 3208.0 3226.5 3254.0 3318.8 3348.8 68246.0 68720.7 68884.0 69017.0 69142.3 9605.0 9768.2 9996.4 10053.2 10102.4 18255.5 18258.3 18278.4 18351.5 18358.4 6528.7 6597.8 6755.5 6921.8 6927.2 3686.1 3781.0 3804.1 3837.6 3879.8 2855.1 2885.3 2925.6 2955.5 2978.1 472.9 477.2 479.0 482.2 487.7 443.3 498.9 548.0 554.4 555.1 7516.1 7551.4 7607.4 7752.9 7917.0 527.9 530.7 550.5 558.7 567.8 3510.9 3544.2 3648.9 3657.3 3680.8 74226.0 74253.0 91983.0 94033.0 99258.0 78135.0 79049.6 79407.2 79577.6 79678.0 43625.8 52315.5 70775.6 71527.5 71647.0 8012.3 8117.1 8177.2 8241.7 8317.6 41514.2 42686.8 43089.8 43300.6 44368.1 54216.2 54626.2 56414.4 60340.4 61920.4 10564.8 10614.4 10642.3 10690.8 10772.2 11951.0 12298.1 12560.2 12775.9 13323.9 11854.8 11882.8 11998.3 12252.8 12529.2 11586.5 11827.2 11916.8 11961.7 12139.0 11141.2 11313.2 11406.7 11518.2 11690.8 8333.3 8595.8 8643.9 8707.1 8866.4 8897.6 9160.0 9184.0 9194.5 9245.4 13:27:40 INFO - PROCESS | 19152 | -------- Summary: end -------- 13:27:40 INFO - PROCESS | 19152 | 13:27:41 INFO - TEST-INFO | 19152: exit 0 13:27:41 INFO - TEST-OK | dromaeo_css | took 1116796ms 13:27:41 INFO - TEST-START | kraken 13:27:41 INFO - operating with platform_type : linux_ 13:27:41 INFO - Initialising browser for kraken test... 13:27:41 INFO - TEST-INFO | started process 19404 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpn14ogZ/profile http://localhost:34547/getInfo.html) 13:27:46 INFO - PROCESS | 19404 | __metrics Screen width/height:1600/1200 13:27:46 INFO - PROCESS | 19404 | colorDepth:24 13:27:46 INFO - PROCESS | 19404 | Browser inner width/height: 1024/697 13:27:46 INFO - PROCESS | 19404 | __metrics 13:27:47 ERROR - PROCESS | 19404 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 13:27:47 INFO - TEST-INFO | 19404: exit 0 13:27:47 INFO - Browser initialized. 13:27:47 INFO - Running cycle 1/1 for kraken test... 13:27:47 INFO - TEST-INFO | started process 19527 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpn14ogZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:27:59 INFO - PROCESS | 19527 | RSS: Main: 169467904 13:27:59 INFO - PROCESS | 19527 | 13:28:02 INFO - PROCESS | 19527 | Cycle 1(1): loaded http://localhost:34547/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34547/tests/kraken/driver.html?testName=audio-beat-detection) 13:28:03 INFO - PROCESS | 19527 | RSS: Main: 174813184 13:28:03 INFO - PROCESS | 19527 | 13:28:06 INFO - PROCESS | 19527 | Cycle 1(1): loaded http://localhost:34547/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34547/tests/kraken/driver.html?testName=audio-dft) 13:28:06 INFO - PROCESS | 19527 | RSS: Main: 174817280 13:28:06 INFO - PROCESS | 19527 | 13:28:09 INFO - PROCESS | 19527 | Cycle 1(1): loaded http://localhost:34547/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34547/tests/kraken/driver.html?testName=audio-fft) 13:28:10 INFO - PROCESS | 19527 | RSS: Main: 169787392 13:28:10 INFO - PROCESS | 19527 | 13:28:12 INFO - PROCESS | 19527 | Cycle 1(1): loaded http://localhost:34547/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34547/tests/kraken/driver.html?testName=audio-oscillator) 13:28:13 INFO - PROCESS | 19527 | RSS: Main: 169697280 13:28:13 INFO - PROCESS | 19527 | 13:28:15 INFO - PROCESS | 19527 | Cycle 1(1): loaded http://localhost:34547/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34547/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:28:16 INFO - PROCESS | 19527 | RSS: Main: 170487808 13:28:16 INFO - PROCESS | 19527 | 13:28:19 INFO - PROCESS | 19527 | Cycle 1(1): loaded http://localhost:34547/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34547/tests/kraken/driver.html?testName=imaging-darkroom) 13:28:19 INFO - PROCESS | 19527 | RSS: Main: 170704896 13:28:19 INFO - PROCESS | 19527 | 13:28:23 INFO - PROCESS | 19527 | Cycle 1(1): loaded http://localhost:34547/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34547/tests/kraken/driver.html?testName=imaging-desaturate) 13:28:24 INFO - PROCESS | 19527 | RSS: Main: 168071168 13:28:24 INFO - PROCESS | 19527 | 13:28:27 INFO - PROCESS | 19527 | Cycle 1(1): loaded http://localhost:34547/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34547/tests/kraken/driver.html?testName=json-parse-financial) 13:28:27 INFO - PROCESS | 19527 | RSS: Main: 169287680 13:28:27 INFO - PROCESS | 19527 | 13:28:29 INFO - PROCESS | 19527 | Cycle 1(1): loaded http://localhost:34547/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34547/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:28:30 INFO - PROCESS | 19527 | RSS: Main: 169512960 13:28:30 INFO - PROCESS | 19527 | 13:28:32 INFO - PROCESS | 19527 | Cycle 1(1): loaded http://localhost:34547/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34547/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:28:32 INFO - PROCESS | 19527 | RSS: Main: 170078208 13:28:32 INFO - PROCESS | 19527 | 13:28:34 INFO - PROCESS | 19527 | Cycle 1(1): loaded http://localhost:34547/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34547/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:28:35 INFO - PROCESS | 19527 | RSS: Main: 170696704 13:28:35 INFO - PROCESS | 19527 | 13:28:38 INFO - PROCESS | 19527 | Cycle 1(1): loaded http://localhost:34547/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34547/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:28:39 INFO - PROCESS | 19527 | RSS: Main: 170586112 13:28:39 INFO - PROCESS | 19527 | 13:28:41 INFO - PROCESS | 19527 | Cycle 1(1): loaded http://localhost:34547/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34547/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:28:42 INFO - PROCESS | 19527 | RSS: Main: 169918464 13:28:42 INFO - PROCESS | 19527 | 13:28:44 INFO - PROCESS | 19527 | Cycle 1(1): loaded http://localhost:34547/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34547/tests/kraken/driver.html?testName=ai-astar) 13:28:44 INFO - PROCESS | 19527 | RSS: Main: 171261952 13:28:44 INFO - PROCESS | 19527 | 13:28:44 INFO - PROCESS | 19527 | __start_tp_report 13:28:44 INFO - PROCESS | 19527 | _x_x_mozilla_page_load 13:28:44 INFO - PROCESS | 19527 | _x_x_mozilla_page_load_details 13:28:44 INFO - PROCESS | 19527 | |i|pagename|runs| 13:28:44 INFO - PROCESS | 19527 | |0;ai-astar;109;116;109;117;116;114;117;115;115;114 13:28:44 INFO - PROCESS | 19527 | |1;audio-beat-detection;161;125;160;176;126;146;146;125;180;130 13:28:44 INFO - PROCESS | 19527 | |2;audio-dft;163;162;165;167;171;164;164;164;163;162 13:28:44 INFO - PROCESS | 19527 | |3;audio-fft;76;78;75;154;78;78;75;75;164;76 13:28:44 INFO - PROCESS | 19527 | |4;audio-oscillator;87;86;139;89;87;88;145;86;85;131 13:28:44 INFO - PROCESS | 19527 | |5;imaging-gaussian-blur;118;118;117;118;118;118;118;118;118;118 13:28:44 INFO - PROCESS | 19527 | |6;imaging-darkroom;148;147;147;148;149;148;148;147;149;148 13:28:44 INFO - PROCESS | 19527 | |7;imaging-desaturate;95;95;96;96;95;97;97;95;96;96 13:28:44 INFO - PROCESS | 19527 | |8;json-parse-financial;64;66;64;65;67;65;65;68;67;65 13:28:44 INFO - PROCESS | 19527 | |9;json-stringify-tinderbox;65;65;65;65;64;66;65;64;66;64 13:28:44 INFO - PROCESS | 19527 | |10;stanford-crypto-aes;83;83;80;84;84;88;79;90;80;80 13:28:44 INFO - PROCESS | 19527 | |11;stanford-crypto-ccm;130;130;132;132;140;132;140;139;175;144 13:28:44 INFO - PROCESS | 19527 | |12;stanford-crypto-pbkdf2;168;168;180;174;174;167;165;169;167;171 13:28:44 INFO - PROCESS | 19527 | |13;stanford-crypto-sha256-iterative;73;68;67;71;69;68;71;69;67;74 13:28:44 INFO - PROCESS | 19527 | __end_tp_report 13:28:44 INFO - PROCESS | 19527 | __start_cc_report 13:28:44 INFO - PROCESS | 19527 | _x_x_mozilla_cycle_collect,973 13:28:44 INFO - PROCESS | 19527 | __end_cc_report 13:28:44 INFO - PROCESS | 19527 | __startTimestamp1467232124605__endTimestamp 13:28:44 INFO - PROCESS | 19527 | 13:28:44 INFO - PROCESS | 19527 | ------- Summary: start ------- 13:28:44 INFO - PROCESS | 19527 | Number of tests: 14 13:28:44 INFO - PROCESS | 19527 | 13:28:44 INFO - PROCESS | 19527 | [#0] ai-astar Cycles:10 Average:114.20 Median:115.50 stddev:2.94 (2.5%) stddev-sans-first:2.44 13:28:44 INFO - PROCESS | 19527 | Values: 109.0 116.0 109.0 117.0 116.0 114.0 117.0 115.0 115.0 114.0 13:28:44 INFO - PROCESS | 19527 | 13:28:44 INFO - PROCESS | 19527 | [#1] audio-beat-detection Cycles:10 Average:147.50 Median:153.00 stddev:21.06 (13.8%) stddev-sans-first:21.77 13:28:44 INFO - PROCESS | 19527 | Values: 161.0 125.0 160.0 176.0 126.0 146.0 146.0 125.0 180.0 130.0 13:28:44 INFO - PROCESS | 19527 | 13:28:44 INFO - PROCESS | 19527 | [#2] audio-dft Cycles:10 Average:164.50 Median:164.00 stddev:2.72 (1.7%) stddev-sans-first:2.83 13:28:44 INFO - PROCESS | 19527 | Values: 163.0 162.0 165.0 167.0 171.0 164.0 164.0 164.0 163.0 162.0 13:28:44 INFO - PROCESS | 19527 | 13:28:44 INFO - PROCESS | 19527 | [#3] audio-fft Cycles:10 Average:92.90 Median:76.00 stddev:34.94 (46.0%) stddev-sans-first:36.52 13:28:44 INFO - PROCESS | 19527 | Values: 76.0 78.0 75.0 154.0 78.0 78.0 75.0 75.0 164.0 76.0 13:28:44 INFO - PROCESS | 19527 | 13:28:44 INFO - PROCESS | 19527 | [#4] audio-oscillator Cycles:10 Average:102.30 Median:86.50 stddev:25.11 (29.0%) stddev-sans-first:26.01 13:28:44 INFO - PROCESS | 19527 | Values: 87.0 86.0 139.0 89.0 87.0 88.0 145.0 86.0 85.0 131.0 13:28:44 INFO - PROCESS | 19527 | 13:28:44 INFO - PROCESS | 19527 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 13:28:44 INFO - PROCESS | 19527 | Values: 118.0 118.0 117.0 118.0 118.0 118.0 118.0 118.0 118.0 118.0 13:28:44 INFO - PROCESS | 19527 | 13:28:44 INFO - PROCESS | 19527 | [#6] imaging-darkroom Cycles:10 Average:147.90 Median:148.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 13:28:44 INFO - PROCESS | 19527 | Values: 148.0 147.0 147.0 148.0 149.0 148.0 148.0 147.0 149.0 148.0 13:28:44 INFO - PROCESS | 19527 | 13:28:44 INFO - PROCESS | 19527 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.79 (0.8%) stddev-sans-first:0.78 13:28:44 INFO - PROCESS | 19527 | Values: 95.0 95.0 96.0 96.0 95.0 97.0 97.0 95.0 96.0 96.0 13:28:44 INFO - PROCESS | 19527 | 13:28:44 INFO - PROCESS | 19527 | [#8] json-parse-financial Cycles:10 Average:65.60 Median:65.50 stddev:1.35 (2.1%) stddev-sans-first:1.30 13:28:44 INFO - PROCESS | 19527 | Values: 64.0 66.0 64.0 65.0 67.0 65.0 65.0 68.0 67.0 65.0 13:28:44 INFO - PROCESS | 19527 | 13:28:44 INFO - PROCESS | 19527 | [#9] json-stringify-tinderbox Cycles:10 Average:64.90 Median:65.00 stddev:0.74 (1.1%) stddev-sans-first:0.78 13:28:44 INFO - PROCESS | 19527 | Values: 65.0 65.0 65.0 65.0 64.0 66.0 65.0 64.0 66.0 64.0 13:28:44 INFO - PROCESS | 19527 | 13:28:44 INFO - PROCESS | 19527 | [#10] stanford-crypto-aes Cycles:10 Average:83.10 Median:83.50 stddev:3.63 (4.4%) stddev-sans-first:3.86 13:28:44 INFO - PROCESS | 19527 | Values: 83.0 83.0 80.0 84.0 84.0 88.0 79.0 90.0 80.0 80.0 13:28:44 INFO - PROCESS | 19527 | 13:28:44 INFO - PROCESS | 19527 | [#11] stanford-crypto-ccm Cycles:10 Average:139.40 Median:139.50 stddev:13.46 (9.6%) stddev-sans-first:13.84 13:28:44 INFO - PROCESS | 19527 | Values: 130.0 130.0 132.0 132.0 140.0 132.0 140.0 139.0 175.0 144.0 13:28:44 INFO - PROCESS | 19527 | 13:28:44 INFO - PROCESS | 19527 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.30 Median:170.00 stddev:4.52 (2.7%) stddev-sans-first:4.72 13:28:44 INFO - PROCESS | 19527 | Values: 168.0 168.0 180.0 174.0 174.0 167.0 165.0 169.0 167.0 171.0 13:28:44 INFO - PROCESS | 19527 | 13:28:44 INFO - PROCESS | 19527 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.70 Median:70.00 stddev:2.45 (3.5%) stddev-sans-first:2.29 13:28:44 INFO - PROCESS | 19527 | Values: 73.0 68.0 67.0 71.0 69.0 68.0 71.0 69.0 67.0 74.0 13:28:44 INFO - PROCESS | 19527 | -------- Summary: end -------- 13:28:44 INFO - PROCESS | 19527 | 13:28:45 INFO - TEST-INFO | 19527: exit 0 13:28:45 INFO - TEST-OK | kraken | took 64339ms 13:28:45 INFO - SUITE-END | took 1181s 13:28:45 INFO - Completed test suite (00:19:41) 13:28:45 INFO - javascript benchmark 13:28:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6403.391303541229, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2644.6561946946895, 2676.5851293049586, 2680.2093382452167, 2694.9865250673743, 2704.1481933191044, 4676.812927482905, 4746.881327966803, 4787.473377928425, 4818.060478206751, 4864.829730959417, 4690.788914498856, 4838.806447742086, 4892.094962431953, 4895.0454661341055, 4909.656324057318, 4447.488538818037, 4485.237509623372, 4521.050579378318, 4543.727376357413, 4544.522825103366, 4216.7680777557225, 4495.415595972535, 4504.842330518432, 4572.222722137245, 4577.816887324503, 4369.169857727022, 4389.034412429261, 4407.537208593084, 4408.448943882015, 4446.1996840568845, 4389.275769498029, 4427.512973572904, 4476.955230447719, 4486.55134486552, 4490.8877278067985, 4438.068005718803, 4476.507584165739, 4476.992676647761, 4497.482789479219, 4516.909661806745, 4787.16224660683, 4814.855554333376, 4838.491958344393, 4842.12841688496, 4886.14492463821, 5177.223416487519, 5196.870078248036, 5197.220416937452, 5225.954809038208, 5249.212618107276, 5058.519440653132, 5122.1036318644465, 5245.186996015624, 5245.4754524547625, 5266.499682530153, 4798.1123492154065, 4831.710097394168, 4870.829520966749, 4876.439209490883, 4922.630802689777, 5310.123829568078, 5327.094393953037, 5340.946590534123, 5347.893042139135, 5407.567394608422, 4936.8765780855765, 5072.797088116434, 5111.539961403491, 5123.462036486189, 5123.487651234846, 5079.847604571869, 5217.973910130425, 5244.29202057725, 5247.632665713363, 5282.366116066097, 5006.824761133343, 5031.018951304533, 5056.64603477753, 5097.923531147036, 5114.514121158484, 5056.544910958031, 5058.114829904752, 5078.949210507922, 5098.056859480934, 5132.5124113209185, 4402.669799765031, 4412.514623391425, 4420.9336859947125, 4463.598276155161, 4465.464144302705, 3818.8854334369457, 3830.2148059647707, 3860.247251785931, 3867.284552357823, 3885.9611403886165, 4363.8435814509185, 4403.9779801100785, 4492.05666809967, 4508.864734057984, 4537.591616754508, 5226.712530810842, 5231.738413079407, 5235.633505654644, 5288.735563221823, 5307.389650190277, 4504.977475112603, 4508.436445444319, 4549.294859296814, 4555.772211389417, 4605.470370907388, 4575.22221222393, 4695.600873925686, 4720.929186062212, 4734.621230301567, 4750.61995040396, 4946.233333833262, 4966.701997880139, 4970.3290055842, 4971.627127965345, 4987.850364489072, 5233.3196684432305, 5288.233206185005, 5310.628256022196, 5314.070037743302, 5340.786368545215, 4770.5706486415, 4835.347228124158, 4851.854444366674, 4885.511448855086, 4958.578520825626, 5094.847154585368, 5113.3097031900215, 5119.283300337881, 5131.409887862795, 5154.329937108152, 5146.305248791366, 5152.149895267389, 5161.509656582619, 5167.121589329748, 5168.53483186515, 4910.386201724785, 4914.65597408178, 5019.949800501949, 5059.898802024012, 5098.133317335987, 5045.5459008689395, 5071.416787069535, 5080.593552515864, 5083.059633967728, 5107.131787596192, 4908.7300198488, 4930.359053323045, 4948.455669876383, 4987.47631498702, 5022.773975171199, 4975.925361119658, 5035.697858128524, 5075.923861142012, 5087.592992560512, 5108.335916330853, 4985.6260780442335, 4988.975055124701, 5004.324416203766, 5022.869854282903, 5079.517445842639], "value": 4763.190894274649, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [529.6643796169909, 584.4506164205646, 598.5929567893832, 598.6019297167384, 657.1818086482331, 34997.12507187322, 38839.41740873889, 39106.8044659777, 39294.410583841265, 39414.211715765705, 39379.21241575167, 39522.40716389257, 39793.80103099488, 39842.20315593686, 39961.80019099908, 7840.372770178386, 7864.528128312291, 7929.881051784228, 7963.681452741912, 7989.800254993643, 7859.174786647405, 7941.28528432441, 7944.443888927777, 7958.602069896511, 7972.641231144612, 7993.2806047455715, 7994.680212791511, 7997.080335761404, 8031.759047228593, 8037.95981020094, 7939.801504962365, 7941.126476087655, 7972.920270797275, 7973.800654983614, 7990.840183196304, 7861.646225919847, 7892.0529536455415, 7942.007249093864, 7953.920460795433, 7965.044194696616, 37697.62302376969, 37905.81047094747, 37945.62054379449, 37985.24029519422, 38022.0, 3024.833634150121, 3260.2012506935716, 3326.640957341088, 3620.420732682758, 3625.1299688074673, 29743.851280743456, 29836.104916852528, 29838.403231935456, 30368.240793980105, 30421.847890760626, 3390.3897298486263, 3394.59264888215, 3416.6583341665632, 3423.5891692997, 3466.133466633342, 180722.0, 181749.09125454287, 182239.0, 182808.0, 182855.08572457187, 49140.75429622829, 49155.754221228664, 49302.0, 49317.26024109641, 49357.50642493601, 33381.66618333785, 34437.31125377479, 34629.82685086609, 36739.4489082664, 57693.69225231028, 15404.537863864101, 15564.92217538905, 15576.143312117942, 15600.29798659063, 15651.608709782118, 11761.764764704658, 11791.469383877746, 11881.940590296994, 11902.940485297519, 11904.226225295328, 18855.90572047131, 18908.527286817938, 18919.43241702751, 18956.90521547411, 19010.0, 6858.2168636153965, 6968.756093536803, 6989.860202795916, 7103.623952715506, 7237.8552428951125, 816.7263966571146, 900.5497251374313, 982.6069572171189, 985.3053597213947, 986.4032260482448, 28673.13980580586, 29441.0, 29456.522280743062, 29476.557851632242, 29562.556561651592, 976.4043933200742, 980.3774603127066, 982.6609819612222, 996.5017491254373, 1044.6552637629563, 15430.768538471932, 15457.381704731684, 15523.767143492856, 15695.450659226872, 15752.606184845241, 359917.0, 363013.0, 364927.0, 366889.0, 367369.0, 50132.24801627979, 51106.23340649893, 51299.74350128225, 51325.74337128291, 51589.0, 1196.4137572589368, 1209.2563073709605, 1214.228964607463, 1216.5073145376136, 1226.055936928578, 26953.730462695123, 27795.58306625443, 28194.43611127807, 28666.71333286724, 28758.71241287644, 44416.33375499305, 44541.0, 44673.0, 45091.7745411284, 45130.0, 311238.0, 314281.0, 314831.0, 315806.0, 316115.0, 25654.358641034123, 26065.478690426466, 26070.739292607588, 26077.0, 26104.216873493824, 43121.568784311756, 43133.56866431295, 43933.0, 44560.55439445564, 44831.32753008773, 36268.27463450769, 36365.0, 36405.45391819072, 36666.083347916516, 36724.44913326249, 31286.687133128376, 31320.37359252848, 31327.686723132476, 31563.52801191913, 32187.195320117185, 36677.0, 37429.251414972096, 37487.43768843524, 38074.42888356732, 38080.0, 31294.0, 32709.509357360133, 32834.67165328316, 32966.175845604055, 33164.83417582993, 25511.0, 25559.488810224062, 25795.226143215732, 26133.869330653226, 26229.73770262273], "value": 17459.419408739857, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [360.6916086745834, 363.3659264583302, 364.66815198169667, 376.63842710997443, 382.94447305140756, 16212.432564860217, 16873.746893796586, 17699.734503982418, 18006.459806205836, 18172.636547269045, 16600.25298861551, 16683.332666693346, 17495.650086998285, 17561.56096097595, 17703.0, 5189.584833213334, 5325.946740532584, 5351.491608297225, 5357.303550538444, 5365.980463711901, 5089.923651145235, 5310.973445132769, 5345.652532585389, 5351.973240133794, 5414.3232095988005, 5412.512873841353, 5414.512693857552, 5447.727613619323, 5458.372287186965, 5471.480209380123, 5350.491703288181, 5458.317710286215, 5472.26124473197, 5638.492535671769, 5640.351359593658, 5374.167004114369, 5405.27028851104, 5425.83722488322, 5426.647267927572, 5455.645383050129, 18748.906255468773, 20134.79865201344, 20218.595628087354, 20636.27773027952, 20654.07056682453, 1928.3732786844191, 2063.2778527515397, 2197.209004758302, 2245.7305123385136, 2362.385779697291, 8914.598843052014, 9100.453972761588, 9122.315826312986, 11187.32876027441, 12480.75038499234, 1699.7875265591802, 1782.3138091834737, 1812.18451696737, 1846.7414561961336, 1884.9717254241198, 67049.3295067048, 68411.0, 71482.64258678726, 71943.92084118743, 72982.0, 9906.108450239513, 10041.246906482043, 10204.642837500653, 10212.234082443847, 10216.795664086676, 13755.449782008807, 13808.792868106986, 13854.445822167201, 13937.512187073606, 13948.651283717989, 6964.860702785916, 7065.328793764687, 7095.9290407096305, 7141.214466408691, 7259.52813067149, 6447.516436267299, 6475.579087359307, 6496.090547323284, 6609.107770450928, 6619.0, 4155.8675036330105, 4203.822929579723, 4335.934960975588, 4359.520452750195, 4409.294512877924, 1772.8404443600139, 1854.4343975087459, 1863.3478282601252, 1878.9718154227699, 1884.1992153335052, 793.6547601793238, 873.4497266721925, 898.2006014646969, 928.3640706116332, 944.1455482788087, 16868.0, 16943.322267109423, 17048.147592620568, 17660.823391765916, 17744.11279436023, 822.0751654388813, 829.3655353654459, 859.3254295378098, 890.2788741119714, 892.0811564088999, 9277.304202184863, 9567.091126342986, 9570.377925434825, 9646.228301735844, 9818.361806482555, 402635.0, 409825.0, 415375.0, 417536.0, 417798.0, 55749.721251394294, 69816.0, 71025.64487177531, 79832.60083699544, 81466.0, 865.8051888394102, 883.0418995389946, 892.2549671024638, 893.3567831161554, 893.6068130022769, 15062.32219550101, 15459.922700386425, 15574.688506230039, 15577.0, 15693.136877471848, 35651.28697426089, 36250.09374765652, 36550.0, 37227.813860930524, 37477.4378384319, 51630.0, 54770.72614637061, 54863.45136548583, 55005.174922375394, 55359.169612455036, 7040.718371265092, 7192.31672991065, 7212.386947109554, 7321.341079302888, 7347.669354878936, 8309.584520773817, 11043.83434248503, 11135.443227838738, 11169.553217871195, 11182.944085279521, 8058.83882322362, 8625.482471051757, 8804.075572064841, 8885.333599979898, 9195.77010574741, 8920.643174272956, 9130.269578433577, 9259.72220833376, 9564.904350956402, 9776.413415195111, 8720.738377848675, 8813.735587932373, 9013.594388252413, 9074.27405807547, 9345.205657519187, 6759.966200168968, 7073.787786366417, 7256.383207427428, 7317.780466586011, 7345.375643070185, 6729.0, 7658.387329013777, 8676.134631054354, 8805.471671699719, 8915.286777057949], "value": 8090.792147871218, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1370.5408688089487, 1409.6546346145192, 1485.2944851195684, 1709.752085947537, 1711.178634255558, 6816.591004539731, 7266.818329541764, 7656.732014379498, 7753.961230193848, 7758.806029849256, 7760.961195194016, 7981.28168464838, 8044.511765323419, 8050.758477245678, 8053.43625946184, 2220.134147682405, 2254.88725563722, 2264.5923733727923, 2268.3761965459466, 2270.5004898922293, 2185.1368709359795, 2195.2316689158747, 2240.5294888073445, 2248.336740661509, 2250.2574150530286, 2209.2930262316067, 2229.9665505017438, 2241.8430709850318, 2257.3115199864037, 2264.9773502265016, 2162.902669379882, 2175.380016695234, 2184.759676435591, 2198.604251234777, 2204.911803527857, 2179.2372669565525, 2194.2100843696257, 2200.834937379687, 2203.4711669199437, 2204.578047159589, 7998.720044798462, 8005.879911801328, 8022.799430014238, 8036.196380361976, 8106.229908158715, 4546.318052292149, 4661.533846615345, 4683.180443422388, 4687.906241875177, 4692.906141877143, 2776.361436869511, 2939.3533422646983, 2956.231379841257, 2957.31981644223, 2979.1509419815247, 930.3348106104168, 932.6828878181451, 955.8422860228054, 961.1541843178029, 977.3695966101825, 10706.625268115578, 10749.140068794477, 10768.838467422995, 10838.0, 10866.293690910066, 4016.9196616067516, 4112.136451345251, 4233.470816147981, 4238.894027649333, 4271.9359209611885, 9265.25877929764, 9310.208632266333, 9351.064893510595, 9357.344985850925, 9362.62549498026, 4654.906901861944, 4656.32483289921, 4665.136949664255, 4685.765711714401, 4691.413573303337, 3717.5353080864893, 4065.89835254121, 4229.661627069827, 4241.1093670328955, 4290.442242508454, 3652.433872749728, 3674.375356189454, 3716.9628303716618, 3787.14789172434, 3794.2032173243374, 1185.6383802940186, 1197.4671271284194, 1206.7043574324346, 1209.7520008398433, 1215.9209651372632, 760.9277118673717, 765.3150430364792, 808.3250485844386, 812.829305845779, 819.4182130687279, 4786.401699787527, 5127.589792816566, 5210.478952104835, 5276.208568714724, 5357.651752636144, 391.99216015679525, 412.59771722570855, 416.4981197656816, 417.7869286663823, 419.2014212924384, 3577.5349204603235, 3603.3694103531775, 3646.106703857572, 3875.1280961783373, 3889.5721470638773, 9659.855102173473, 9755.0, 9842.704718858446, 9874.160696340892, 9925.2059835213, 9727.07592778685, 9729.416235025921, 9740.707778766648, 9768.316217864824, 9777.120059194707, 6872.484563657746, 7014.824629384204, 7084.397826184729, 7087.0432491614, 7108.964455177691, 5349.331333583302, 5420.186971954238, 5425.484578964992, 5518.2826232589505, 5524.723763811713, 9064.0, 9070.047644997445, 9138.268938484773, 9144.3598948073, 9227.215686666708, 8674.826503470022, 9058.411203271766, 9060.864087038832, 9179.17387435134, 9342.626294948126, 6214.72033758491, 6591.736330546724, 6813.3527314905, 6871.931280687129, 6925.722971081101, 7711.884321735066, 7756.224377562198, 7817.335526480313, 7846.450748447553, 7852.7251546197895, 6877.449804015767, 6961.164660240804, 7060.894086588808, 7198.5680859148615, 7224.096987876515, 6956.513044086865, 6964.512484126062, 6974.37230649244, 7037.964810175917, 7101.538400003983, 6032.849178770566, 6033.517318614413, 6042.879142417215, 6053.697315134137, 6071.878562428815, 4513.977430112828, 4543.727376357429, 4558.225101732647, 4604.447466304065, 4624.0, 4557.840475583339, 4578.2903649934315, 4605.769711514344, 4610.631149507964, 4653.046125544188], "value": 4100.757944105514, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [288.51529430556667, 295.3296018039051, 297.7528651219488, 301.28895805898077, 303.329641492302, 4950.475257618614, 5074.238864170367, 5109.441620305805, 5128.589712822974, 5148.845534633967, 4772.401416212313, 4960.305557221992, 5059.721715305656, 5068.84793456196, 5100.897982040357, 3961.8217180226957, 3990.461287726156, 4007.1184339445276, 4018.4575082363945, 4022.235775202702, 3989.6608788253034, 4000.7599544027453, 4006.0755648376703, 4017.1563971566006, 4021.0, 3706.9991102402337, 3922.3332033554366, 3936.323300155893, 3984.561698213194, 3986.880393588197, 3882.670397761349, 3910.7262491625597, 3916.2559113768434, 3927.4501569780255, 3930.9803450982704, 3428.708559772422, 3435.4159792835276, 3440.518327434161, 3444.0, 3455.6371580984137, 4923.249064652628, 5109.642325037249, 5117.590592752571, 5119.513646203604, 5122.0, 4495.685302028859, 4505.5269196734525, 4507.661925355612, 4510.391097201868, 4511.571400716926, 5312.0, 5349.833317506416, 5370.516653501165, 5386.542143917772, 5412.188171774226, 3756.4740936268945, 3756.6055564165918, 3760.6051364606597, 3770.472133901256, 3772.0758414188426, 5265.842024739264, 5448.291722076105, 5470.64440811346, 5627.2684551008515, 5633.464820842013, 3806.7906265155684, 3815.637514436124, 3824.3116239076676, 3827.3684842001317, 3852.6725228355904, 3877.8254978526033, 3893.1824316893203, 3900.687944964453, 3903.941440878389, 3907.4138879167785, 4487.371767952489, 4491.977540112279, 4506.504284528699, 4507.301368287921, 4515.751633660115, 5157.871053223625, 5308.177232528964, 5310.999285403735, 5323.387810401776, 5323.787048518016, 1307.9340337624806, 1323.7352529493946, 1325.9204447733166, 1330.5276626797347, 1332.2406228449884, 824.6660102658433, 841.2050612171439, 846.1876598465542, 857.8370109679141, 862.844687956174, 4215.59951804578, 4256.404103425523, 4259.488861336597, 4262.422903525653, 4278.336857786986, 4946.530079642428, 4950.628702847229, 4956.231784073474, 4962.900741985212, 4984.675996060317, 4206.26390381682, 4212.967822883413, 4247.405363249148, 4253.48958125027, 4280.993966417889, 2470.3330100872663, 2633.2231991562535, 2639.2741995950882, 2643.70919198888, 2672.679278486594, 4640.79116439761, 4649.279766486422, 4653.604443622262, 4657.790399432034, 4711.0, 4989.850304490871, 5004.449510553836, 5039.5810011194835, 5044.956792499043, 5072.61587054084, 4778.4982576829625, 5231.476852314738, 5253.999999999924, 5280.755678836403, 5289.338832645919, 5606.327240731139, 5606.943930560642, 5614.07367784311, 5632.633878797865, 5643.604947653789, 5224.791008359623, 5443.374011988672, 5478.91781623284, 5487.0, 5522.22688823557, 4994.175960966545, 5115.335006449138, 5238.0, 5240.480260724347, 5248.816291429782, 3832.7125465589634, 3850.4609354690924, 3873.96126038736, 3879.4956655634587, 3885.825137868746, 5504.201890725903, 5551.22282880389, 5571.637843540157, 5593.748281327269, 5595.104783234663, 5271.655727789389, 5386.741021681826, 5395.465969789794, 5408.594355423437, 5422.457754224703, 5356.250124982584, 5376.462353764592, 5390.110631745718, 5394.9460505394445, 5428.972855135699, 5078.619103567174, 5239.554637855825, 5298.549623282064, 5310.0, 5351.224072509543, 5448.727563621882, 5451.155070964007, 5452.727363631882, 5452.745868450199, 5457.263269458731, 5267.868303292448, 5302.973485132704, 5307.328191619627, 5339.145736682112, 5353.384360798403], "value": 3939.4809724335437, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [597.6892016151601, 603.2097951683295, 644.3556443556444, 675.1155985658787, 685.2975699907594, 11585.0, 12470.064745144105, 12501.249925004506, 12542.498300067986, 12569.0, 12123.939380303109, 12979.480820767181, 12985.09104362695, 13349.199048057124, 13375.13061650992, 633.3318349141654, 765.7473033898827, 784.3999340504519, 797.9042514898221, 802.7230605441114, 794.0154208781128, 798.0702481608919, 804.1556365815899, 804.6097642643314, 805.3114587028065, 837.7696133563288, 846.196113691992, 847.9618417171212, 848.6181218451691, 849.8385306791721, 829.0, 832.6045128563944, 834.5493433545847, 837.2715737308581, 838.7944953486405, 612.543654977045, 612.7212118486123, 613.0, 614.0114415790573, 616.072810420319, 12068.275903445734, 12086.637400877988, 12101.757964840743, 12181.817272740916, 12184.147109702324, 12677.0, 12975.156614820007, 13094.279814610192, 13113.934430327883, 13185.406656700472, 10072.597096116147, 10076.546555405024, 10320.277580569364, 10338.379697218192, 10369.948150259275, 3207.9679203208134, 3226.483762597973, 3254.0400581828417, 3318.767686261963, 3348.7990720556845, 68246.0, 68720.6563967182, 68884.0, 69017.0, 69142.30857691409, 9604.95197524008, 9768.21854251658, 9996.400215987063, 10053.246006549538, 10102.444365559964, 18255.452336429928, 18258.269669213347, 18278.360257390927, 18351.54121146982, 18358.357457488924, 6528.738850446024, 6597.769078082244, 6755.459563234929, 6921.823290040706, 6927.168739751161, 3686.060054686038, 3780.9621903781162, 3804.087019115392, 3837.6354246346555, 3879.7866117363815, 2855.11491437655, 2885.264257614337, 2925.590417341574, 2955.4827905116517, 2978.1214541710247, 472.8841433848729, 477.23403936681126, 478.9736564488917, 482.1971417589744, 487.6537658262673, 443.2575436144445, 498.8902441462872, 547.9863003424946, 554.3957086775434, 555.1145922253999, 7516.135644400854, 7551.358134558624, 7607.429442791813, 7752.922470775333, 7917.0, 527.8838655495784, 530.7346326836582, 550.4986113993747, 558.6508432229856, 567.8060907395898, 3510.8771193008124, 3544.1848374873925, 3648.85404583819, 3657.305112028706, 3680.8159592020293, 74226.0, 74253.0, 91983.0, 94033.0, 99258.0, 78135.0, 79049.60475197702, 79407.20592793998, 79577.60211198906, 79678.0, 43625.78187109044, 52315.476845231824, 70775.64612176907, 71527.49653762093, 71647.0, 8012.278894899487, 8117.10711821711, 8177.182281771775, 8241.670333186605, 8317.625706843328, 41514.1697166049, 42686.78656606697, 43089.7845510783, 43300.56699433091, 44368.11263774771, 54216.18675719946, 54626.18060729013, 56414.43585564092, 60340.396596033475, 61920.380796191464, 10564.841527376942, 10614.363138211733, 10642.308249963728, 10690.839637405601, 10772.192085593455, 11951.043916486486, 12298.139130260795, 12560.183588066746, 12775.936120319338, 13323.933380333036, 11854.762904742029, 11882.82175767347, 11998.340091295062, 12252.754944900873, 12529.215067749159, 11586.536538538365, 11827.231229970024, 11916.821247681464, 11961.700957476132, 12139.0, 11141.16441266892, 11313.151513636674, 11406.657800266004, 11518.193726439404, 11690.824637630272, 8333.291670207858, 8595.785105372415, 8643.87034194475, 8707.129287071242, 8866.42368246062, 8897.644094236159, 9160.024463858606, 9184.0, 9194.540272986458, 9245.352825302165], "value": 6341.483518069261, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1576.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 116.0, 109.0, 117.0, 116.0, 114.0, 117.0, 115.0, 115.0, 114.0], "value": 114.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 125.0, 160.0, 176.0, 126.0, 146.0, 146.0, 125.0, 180.0, 130.0], "value": 147.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 165.0, 167.0, 171.0, 164.0, 164.0, 164.0, 163.0, 162.0], "value": 164.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 78.0, 75.0, 154.0, 78.0, 78.0, 75.0, 75.0, 164.0, 76.0], "value": 92.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 139.0, 89.0, 87.0, 88.0, 145.0, 86.0, 85.0, 131.0], "value": 102.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 118.0, 118.0, 118.0, 118.0, 118.0, 118.0, 118.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 147.0, 148.0, 149.0, 148.0, 148.0, 147.0, 149.0, 148.0], "value": 147.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 96.0, 95.0, 97.0, 97.0, 95.0, 96.0, 96.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 64.0, 65.0, 67.0, 65.0, 65.0, 68.0, 67.0, 65.0], "value": 65.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 65.0, 64.0, 66.0, 65.0, 64.0, 66.0, 64.0], "value": 64.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 80.0, 84.0, 84.0, 88.0, 79.0, 90.0, 80.0, 80.0], "value": 83.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 130.0, 132.0, 132.0, 140.0, 132.0, 140.0, 139.0, 175.0, 144.0], "value": 139.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 168.0, 180.0, 174.0, 174.0, 167.0, 165.0, 169.0, 167.0, 171.0], "value": 170.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 68.0, 67.0, 71.0, 69.0, 68.0, 71.0, 69.0, 67.0, 74.0], "value": 69.7, "unit": "score"}]}]} 13:28:45 INFO - Return code: 0 13:28:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:28:45 ERROR - # TBPL SUCCESS # 13:28:45 INFO - Running post-action listener: _resource_record_post_action 13:28:45 INFO - ##### 13:28:45 INFO - ##### Finished run-tests step (success) 13:28:45 INFO - ##### 13:28:45 INFO - Running post-run listener: _resource_record_post_run 13:28:45 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 4096; Write bytes: 546451456; Read time: 20; Write time: 588480 13:28:45 INFO - TinderboxPrint: CPU usage
13.3% 13:28:45 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 13:28:45 INFO - TinderboxPrint: I/O write bytes / time
546,451,456 / 588,480 13:28:45 INFO - TinderboxPrint: CPU idle
8,283.0 (86.6%) 13:28:45 INFO - TinderboxPrint: CPU user
1,221.1 (12.8%) 13:28:45 INFO - TinderboxPrint: Swap in / out
0 / 0 13:28:46 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 246132736; Read time: 0; Write time: 327484 13:28:46 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 0; Write bytes: 300318720; Read time: 0; Write time: 260996 13:28:46 INFO - Running post-run listener: _upload_blobber_files 13:28:46 INFO - Blob upload gear active. 13:28:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:28:46 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 13:28:46 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:28:46 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:28:46 INFO - (blobuploader) - INFO - Open directory for files ... 13:28:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:28:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:28:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:28:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:28:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:28:47 INFO - (blobuploader) - INFO - Done attempting. 13:28:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:28:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:28:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:28:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:28:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:28:48 INFO - (blobuploader) - INFO - Done attempting. 13:28:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:28:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:28:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:28:51 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:28:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:28:51 INFO - (blobuploader) - INFO - Done attempting. 13:28:51 INFO - (blobuploader) - INFO - Iteration through files over. 13:28:51 INFO - Return code: 0 13:28:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:28:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:28:51 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0aab02a3341caac7d36d8b667ef2fab238db23ce59a0c44f032e8118d6409dc19a3279ae5c1ab263d6e44aebe0d446cf92745258fe4745efb1b59839f18538ff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c229ad273d9d294344fd5824b5d56c4941fda99b3e592d0fad75fda61b9e435d082ba1a021c13d3eddb8972f5de7735e00c01dfe63c8d6b0e9aaa6c34c29060e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e54cae83ccdadd3b766f8713257014686317d52b4d991682e1e3078eea3ffc671de5ae0f87c93c48367f1ddc2be2edbea683d8fe44f2a33ac13a28297ace0505"} 13:28:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:28:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:28:51 INFO - Contents: 13:28:51 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0aab02a3341caac7d36d8b667ef2fab238db23ce59a0c44f032e8118d6409dc19a3279ae5c1ab263d6e44aebe0d446cf92745258fe4745efb1b59839f18538ff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c229ad273d9d294344fd5824b5d56c4941fda99b3e592d0fad75fda61b9e435d082ba1a021c13d3eddb8972f5de7735e00c01dfe63c8d6b0e9aaa6c34c29060e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e54cae83ccdadd3b766f8713257014686317d52b4d991682e1e3078eea3ffc671de5ae0f87c93c48367f1ddc2be2edbea683d8fe44f2a33ac13a28297ace0505"} 13:28:51 INFO - Running post-run listener: copy_logs_to_upload_dir 13:28:51 INFO - Copying logs to upload dir... 13:28:51 INFO - mkdir: /builds/slave/test/build/upload/logs 13:28:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.725468 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-06-29 13:28:51.695949) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-29 13:28:51.700001) ========= 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=fa44defc139c4ba8574fe040000001db-1467230586.323445-1134854676 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0aab02a3341caac7d36d8b667ef2fab238db23ce59a0c44f032e8118d6409dc19a3279ae5c1ab263d6e44aebe0d446cf92745258fe4745efb1b59839f18538ff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c229ad273d9d294344fd5824b5d56c4941fda99b3e592d0fad75fda61b9e435d082ba1a021c13d3eddb8972f5de7735e00c01dfe63c8d6b0e9aaa6c34c29060e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e54cae83ccdadd3b766f8713257014686317d52b4d991682e1e3078eea3ffc671de5ae0f87c93c48367f1ddc2be2edbea683d8fe44f2a33ac13a28297ace0505"} build_url:https://queue.taskcluster.net/v1/task/ItgHgkJuQs6lLdTiQ9gDNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011355 build_url: 'https://queue.taskcluster.net/v1/task/ItgHgkJuQs6lLdTiQ9gDNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0aab02a3341caac7d36d8b667ef2fab238db23ce59a0c44f032e8118d6409dc19a3279ae5c1ab263d6e44aebe0d446cf92745258fe4745efb1b59839f18538ff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c229ad273d9d294344fd5824b5d56c4941fda99b3e592d0fad75fda61b9e435d082ba1a021c13d3eddb8972f5de7735e00c01dfe63c8d6b0e9aaa6c34c29060e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e54cae83ccdadd3b766f8713257014686317d52b4d991682e1e3078eea3ffc671de5ae0f87c93c48367f1ddc2be2edbea683d8fe44f2a33ac13a28297ace0505"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-29 13:28:51.726197) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 13:28:51.726569) ========= 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=fa44defc139c4ba8574fe040000001db-1467230586.323445-1134854676 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004436 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 13:28:51.813410) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-29 13:28:51.813956) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-29 13:28:51.814298) ========= ========= Total master_lag: 0.18 =========