builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-021 starttime: 1467230880.61 results: success (0) buildid: 20160629072230 builduid: 44330e7de3a149cabbd5abff280a7c1f revision: eeb6862f960c1310bde9aed159f3fc5bb2d4b6d7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-29 13:08:00.612283) ========= 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:00.612896) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-29 13:08:00.613199) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-29 13:08:00.629869) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 13:08:00.630181) ========= 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=df17445c3590ff7897617a0e00000225-1467229708.116181-1181107337 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% 89.0M=0s 2016-06-29 13:08:01 (89.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.106611 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 13:08:00.753395) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 13:08:00.753723) ========= 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=df17445c3590ff7897617a0e00000225-1467229708.116181-1181107337 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017819 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 13:08:00.813392) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 13:08:00.813769) ========= 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=df17445c3590ff7897617a0e00000225-1467229708.116181-1181107337 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-29 13:08:01,307 truncating revision to first 12 chars 2016-06-29 13:08:01,308 Setting DEBUG logging. 2016-06-29 13:08:01,308 attempt 1/10 2016-06-29 13:08:01,308 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,607 unpacking tar archive at: fx-team-eeb6862f960c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.621251 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 13:08:01.449498) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-29 13:08:01.449837) ========= script_repo_revision: eeb6862f960c1310bde9aed159f3fc5bb2d4b6d7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-29 13:08:01.450251) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-29 13:08:01.450579) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-29 13:08:01.461006) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-06-29 13:08:01.461424) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=df17445c3590ff7897617a0e00000225-1467229708.116181-1181107337 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 --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', 13:08:02 INFO - 'system_bits': '32', 13:08:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:08:02 INFO - 'title': 'talos-linux64-ix-021', 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", 13:08:02 INFO - "repository": "", 13:08:02 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 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": 1907, 13:08:02 INFO - "slavename": "talos-linux64-ix-021", 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:03 INFO - Downloaded 1361 bytes. 13:08:03 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:08:03 INFO - Using the following test package requirements: 13:08:03 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 13:08:03 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:08:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:08:03 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:08:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:08:03 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:08:03 INFO - u'jsshell-linux-x86_64.zip'], 13:08:03 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:08:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:08:03 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 13:08:03 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:08:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:08:03 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:08:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:08:03 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:08:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:08:03 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:08:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:08:03 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:08:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:08:03 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:03 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:03 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:03 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:03 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:04 INFO - Downloaded 22701715 bytes. 13:08:04 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:04 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:05 INFO - Return code: 0 13:08:05 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:05 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:05 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:05 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:05 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:05 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:05 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:09 INFO - Downloaded 22701715 bytes. 13:08:09 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:09 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:10 INFO - Return code: 0 13:08:10 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:10 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:10 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:10 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:10 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:10 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:11 INFO - Downloaded 14405245 bytes. 13:08:11 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:11 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:11 INFO - Return code: 0 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.tar.bz2 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.tar.bz2 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.tar.bz2 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.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:08:11 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:13 INFO - Downloaded 56470205 bytes. 13:08:13 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:13 INFO - mkdir: /builds/slave/test/properties 13:08:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:08:13 INFO - Writing to file /builds/slave/test/properties/build_url 13:08:13 INFO - Contents: 13:08:13 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:14 INFO - Running post-action listener: _resource_record_post_action 13:08:14 INFO - Running post-action listener: set_extra_try_arguments 13:08:14 INFO - ##### 13:08:14 INFO - ##### Finished download-and-extract step (success) 13:08:14 INFO - ##### 13:08:14 INFO - ##### 13:08:14 INFO - ##### Running populate-webroot step. 13:08:14 INFO - ##### 13:08:14 INFO - Running pre-action listener: _resource_record_pre_action 13:08:14 INFO - Running main action method: populate_webroot 13:08:14 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:08:14 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:08:14 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:08:14 INFO - '--tppagecycles', 13:08:14 INFO - '7'], 13:08:14 INFO - 'tests': ['tsvgm']}}, 13:08:14 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:08:14 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:08:14 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:08:14 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:08:14 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:08:14 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:08:14 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:08:14 INFO - 'talos_options': ['--disable-e10s'], 13:08:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:08:14 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:08:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:08:14 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:08:14 INFO - 'talos_options': ['--disable-e10s'], 13:08:14 INFO - 'tests': ['damp', 'tps']}, 13:08:14 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:08:14 INFO - 'tests': ['damp', 'tps']}, 13:08:14 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:08:14 INFO - 'tests': ['dromaeo_dom']}, 13:08:14 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:08:14 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:08:14 INFO - 'tests': ['basic_compositor_video']}, 13:08:14 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:08:14 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:08:14 INFO - 'tests': ['a11yr', 13:08:14 INFO - 'ts_paint', 13:08:14 INFO - 'tpaint', 13:08:14 INFO - 'sessionrestore', 13:08:14 INFO - 'sessionrestore_no_auto_restore', 13:08:14 INFO - 'tabpaint']}, 13:08:14 INFO - 'other-e10s': {'tests': ['a11yr', 13:08:14 INFO - 'ts_paint', 13:08:14 INFO - 'tpaint', 13:08:14 INFO - 'sessionrestore', 13:08:14 INFO - 'sessionrestore_no_auto_restore', 13:08:14 INFO - 'tabpaint']}, 13:08:14 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:08:14 INFO - 'ts_paint', 13:08:14 INFO - 'tpaint', 13:08:14 INFO - 'sessionrestore', 13:08:14 INFO - 'sessionrestore_no_auto_restore', 13:08:14 INFO - 'tabpaint']}, 13:08:14 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:08:14 INFO - 'ts_paint', 13:08:14 INFO - 'tpaint', 13:08:14 INFO - 'sessionrestore', 13:08:14 INFO - 'sessionrestore_no_auto_restore', 13:08:14 INFO - 'tabpaint']}, 13:08:14 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:08:14 INFO - 'tests': ['a11yr', 13:08:14 INFO - 'ts_paint', 13:08:14 INFO - 'tpaint', 13:08:14 INFO - 'sessionrestore', 13:08:14 INFO - 'sessionrestore_no_auto_restore', 13:08:14 INFO - 'tabpaint']}, 13:08:14 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:08:14 INFO - 'tests': ['a11yr', 13:08:14 INFO - 'ts_paint', 13:08:14 INFO - 'tpaint', 13:08:14 INFO - 'sessionrestore', 13:08:14 INFO - 'sessionrestore_no_auto_restore', 13:08:14 INFO - 'tabpaint']}, 13:08:14 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:08:14 INFO - 'tests': ['tsvgx', 13:08:14 INFO - 'tsvgr_opacity', 13:08:14 INFO - 'tart', 13:08:14 INFO - 'tscrollx', 13:08:14 INFO - 'cart']}, 13:08:14 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:08:14 INFO - 'tsvgr_opacity', 13:08:14 INFO - 'tart', 13:08:14 INFO - 'tscrollx', 13:08:14 INFO - 'cart']}, 13:08:14 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:08:14 INFO - 'talos_options': ['--disable-e10s'], 13:08:14 INFO - 'tests': ['tp5o']}, 13:08:14 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:08:14 INFO - 'tests': ['tp5o']}, 13:08:14 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:08:14 INFO - 'talos_options': ['--disable-e10s', 13:08:14 INFO - '--xperf_path', 13:08:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:08:14 INFO - 'tests': ['tp5n']}, 13:08:14 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:08:14 INFO - 'talos_options': ['--xperf_path', 13:08:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:08:14 INFO - 'tests': ['tp5n']}}, 13:08:14 INFO - 'talos.zip': {'path': '', 13:08:14 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:08:14 INFO - Running post-action listener: _resource_record_post_action 13:08:14 INFO - ##### 13:08:14 INFO - ##### Finished populate-webroot step (success) 13:08:14 INFO - ##### 13:08:14 INFO - ##### 13:08:14 INFO - ##### Running create-virtualenv step. 13:08:14 INFO - ##### 13:08:14 INFO - Running pre-action listener: _resource_record_pre_action 13:08:14 INFO - Running main action method: create_virtualenv 13:08:14 INFO - Creating virtualenv /builds/slave/test/build/venv 13:08:14 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:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:08:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:08:14 INFO - Using real prefix '/usr' 13:08:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:08:15 INFO - Installing distribute.............................................................................................................................................................................................done. 13:08:17 INFO - Installing pip.................done. 13:08:17 INFO - Return code: 0 13:08:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:08:17 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:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:08:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:17 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:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:08:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:17 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 0x11a5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1466180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14643b0>, '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 0x14652b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1465740>, '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': 'df17445c3590ff7897617a0e00000225-1467229708.116181-1181107337', '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:17 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:17 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:17 INFO - Using env: {'DISPLAY': ':0', 13:08:17 INFO - 'HOME': '/home/cltbld', 13:08:17 INFO - 'LANG': 'en_US.UTF-8', 13:08:17 INFO - 'LANGUAGE': 'en_US:en', 13:08:17 INFO - 'LOGNAME': 'cltbld', 13:08:17 INFO - 'MAIL': '/var/mail/cltbld', 13:08:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:08:17 INFO - 'MOZ_NO_REMOTE': '1', 13:08:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:08:17 INFO - 'NO_EM_RESTART': '1', 13:08:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:08:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:08:17 INFO - 'PWD': '/builds/slave/test', 13:08:17 INFO - 'SHELL': '/bin/bash', 13:08:17 INFO - 'SHLVL': '1', 13:08:17 INFO - 'TERM': 'linux', 13:08:17 INFO - 'TMOUT': '86400', 13:08:17 INFO - 'USER': 'cltbld', 13:08:17 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1467229708.116181-1181107337', 13:08:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:08:17 INFO - '_': '/tools/buildbot/bin/python'} 13:08:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:08:17 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:17 INFO - Cleaning up... 13:08:17 INFO - Return code: 0 13:08:17 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:08:17 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:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:08:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:17 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:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:08:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:17 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 0x11a5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1466180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14643b0>, '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 0x14652b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1465740>, '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': 'df17445c3590ff7897617a0e00000225-1467229708.116181-1181107337', '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:17 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:17 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:17 INFO - Using env: {'DISPLAY': ':0', 13:08:17 INFO - 'HOME': '/home/cltbld', 13:08:17 INFO - 'LANG': 'en_US.UTF-8', 13:08:17 INFO - 'LANGUAGE': 'en_US:en', 13:08:17 INFO - 'LOGNAME': 'cltbld', 13:08:17 INFO - 'MAIL': '/var/mail/cltbld', 13:08:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:08:17 INFO - 'MOZ_NO_REMOTE': '1', 13:08:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:08:17 INFO - 'NO_EM_RESTART': '1', 13:08:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:08:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:08:17 INFO - 'PWD': '/builds/slave/test', 13:08:17 INFO - 'SHELL': '/bin/bash', 13:08:17 INFO - 'SHLVL': '1', 13:08:17 INFO - 'TERM': 'linux', 13:08:17 INFO - 'TMOUT': '86400', 13:08:17 INFO - 'USER': 'cltbld', 13:08:17 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1467229708.116181-1181107337', 13:08:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:08:17 INFO - '_': '/tools/buildbot/bin/python'} 13:08:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:08:17 INFO - Downloading/unpacking psutil>=3.1.1 13:08:17 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:17 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:17 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:17 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:17 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:17 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:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:08:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:08:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:08:19 INFO - Installing collected packages: psutil 13:08:19 INFO - Running setup.py install for psutil 13:08:19 INFO - building 'psutil._psutil_linux' extension 13:08:19 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:19 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:19 INFO - building 'psutil._psutil_posix' extension 13:08:19 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:20 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:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:08:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:08:20 INFO - Successfully installed psutil 13:08:20 INFO - Cleaning up... 13:08:20 INFO - Return code: 0 13:08:20 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:08:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:08:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:08:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:08:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:08:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11a5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1466180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14643b0>, '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 0x14652b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1465740>, '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': 'df17445c3590ff7897617a0e00000225-1467229708.116181-1181107337', '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:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 13:08:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 13:08:20 INFO - Using env: {'DISPLAY': ':0', 13:08:20 INFO - 'HOME': '/home/cltbld', 13:08:20 INFO - 'LANG': 'en_US.UTF-8', 13:08:20 INFO - 'LANGUAGE': 'en_US:en', 13:08:20 INFO - 'LOGNAME': 'cltbld', 13:08:20 INFO - 'MAIL': '/var/mail/cltbld', 13:08:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:08:20 INFO - 'MOZ_NO_REMOTE': '1', 13:08:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:08:20 INFO - 'NO_EM_RESTART': '1', 13:08:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:08:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:08:20 INFO - 'PWD': '/builds/slave/test', 13:08:20 INFO - 'SHELL': '/bin/bash', 13:08:20 INFO - 'SHLVL': '1', 13:08:20 INFO - 'TERM': 'linux', 13:08:20 INFO - 'TMOUT': '86400', 13:08:20 INFO - 'USER': 'cltbld', 13:08:20 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1467229708.116181-1181107337', 13:08:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:08:20 INFO - '_': '/tools/buildbot/bin/python'} 13:08:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:08:20 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:08:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:08:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:08:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:08:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:08:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:08:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:08:22 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:08:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:08:22 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:22 INFO - Installing collected packages: mozsystemmonitor 13:08:22 INFO - Running setup.py install for mozsystemmonitor 13:08:22 INFO - Successfully installed mozsystemmonitor 13:08:22 INFO - Cleaning up... 13:08:22 INFO - Return code: 0 13:08:22 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 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 - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:08:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 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 - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:08:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:22 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 0x11a5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1466180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14643b0>, '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 0x14652b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1465740>, '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': 'df17445c3590ff7897617a0e00000225-1467229708.116181-1181107337', '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:22 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:22 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:22 INFO - Using env: {'DISPLAY': ':0', 13:08:22 INFO - 'HOME': '/home/cltbld', 13:08:22 INFO - 'LANG': 'en_US.UTF-8', 13:08:22 INFO - 'LANGUAGE': 'en_US:en', 13:08:22 INFO - 'LOGNAME': 'cltbld', 13:08:22 INFO - 'MAIL': '/var/mail/cltbld', 13:08:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:08:22 INFO - 'MOZ_NO_REMOTE': '1', 13:08:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:08:22 INFO - 'NO_EM_RESTART': '1', 13:08:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:08:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:08:22 INFO - 'PWD': '/builds/slave/test', 13:08:22 INFO - 'SHELL': '/bin/bash', 13:08:22 INFO - 'SHLVL': '1', 13:08:22 INFO - 'TERM': 'linux', 13:08:22 INFO - 'TMOUT': '86400', 13:08:22 INFO - 'USER': 'cltbld', 13:08:22 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1467229708.116181-1181107337', 13:08:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:08:22 INFO - '_': '/tools/buildbot/bin/python'} 13:08:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:08:22 INFO - Downloading/unpacking jsonschema==2.5.1 13:08:22 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:22 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:22 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:22 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:22 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:22 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:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:08:24 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:08:24 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:24 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:24 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:24 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:24 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:24 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:24 INFO - Downloading functools32-3.2.3-2.tar.gz 13:08:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:08:24 INFO - warning: no files found matching '*.txt' 13:08:24 INFO - no previously-included directories found matching 'build' 13:08:24 INFO - no previously-included directories found matching 'dist' 13:08:24 INFO - no previously-included directories found matching '.git*' 13:08:24 INFO - Installing collected packages: jsonschema, functools32 13:08:24 INFO - Running setup.py install for functools32 13:08:25 INFO - warning: no files found matching '*.txt' 13:08:25 INFO - no previously-included directories found matching 'build' 13:08:25 INFO - no previously-included directories found matching 'dist' 13:08:25 INFO - no previously-included directories found matching '.git*' 13:08:25 INFO - Successfully installed jsonschema functools32 13:08:25 INFO - Cleaning up... 13:08:25 INFO - Return code: 0 13:08:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:08:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:08:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:08:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:08:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:08:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:25 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 0x11a5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1466180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14643b0>, '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 0x14652b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1465740>, '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': 'df17445c3590ff7897617a0e00000225-1467229708.116181-1181107337', '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:25 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:25 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:25 INFO - Using env: {'DISPLAY': ':0', 13:08:25 INFO - 'HOME': '/home/cltbld', 13:08:25 INFO - 'LANG': 'en_US.UTF-8', 13:08:25 INFO - 'LANGUAGE': 'en_US:en', 13:08:25 INFO - 'LOGNAME': 'cltbld', 13:08:25 INFO - 'MAIL': '/var/mail/cltbld', 13:08:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:08:25 INFO - 'MOZ_NO_REMOTE': '1', 13:08:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:08:25 INFO - 'NO_EM_RESTART': '1', 13:08:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:08:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:08:25 INFO - 'PWD': '/builds/slave/test', 13:08:25 INFO - 'SHELL': '/bin/bash', 13:08:25 INFO - 'SHLVL': '1', 13:08:25 INFO - 'TERM': 'linux', 13:08:25 INFO - 'TMOUT': '86400', 13:08:25 INFO - 'USER': 'cltbld', 13:08:25 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1467229708.116181-1181107337', 13:08:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:08:25 INFO - '_': '/tools/buildbot/bin/python'} 13:08:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:08:25 INFO - Downloading/unpacking blobuploader==1.2.4 13:08:25 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:25 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:25 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:25 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:25 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:25 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:27 INFO - Downloading blobuploader-1.2.4.tar.gz 13:08:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:08:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:08:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:08:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:08:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:08:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:08:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:08:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:08:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:08:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:08:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:08:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:08:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:08:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:08:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:08:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:08:27 INFO - Downloading docopt-0.6.1.tar.gz 13:08:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:08:27 INFO - Installing collected packages: blobuploader, requests, docopt 13:08:27 INFO - Running setup.py install for blobuploader 13:08:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:08:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:08:28 INFO - Running setup.py install for requests 13:08:28 INFO - Running setup.py install for docopt 13:08:28 INFO - Successfully installed blobuploader requests docopt 13:08:28 INFO - Cleaning up... 13:08:28 INFO - Return code: 0 13:08:28 INFO - Installing None 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', '--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 0x11a5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1466180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14643b0>, '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 0x14652b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1465740>, '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': 'df17445c3590ff7897617a0e00000225-1467229708.116181-1181107337', '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', '--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:28 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: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': 'df17445c3590ff7897617a0e00000225-1467229708.116181-1181107337', 13:08:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:08:28 INFO - '_': '/tools/buildbot/bin/python'} 13:08:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:08:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:08:28 INFO - Running setup.py (path:/tmp/pip-0cH2f3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:08:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:08:28 INFO - Running setup.py (path:/tmp/pip-SrpFo_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:08:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:08:28 INFO - Running setup.py (path:/tmp/pip-CdAMGg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:08:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:08:29 INFO - Running setup.py (path:/tmp/pip-FSqpfF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:08:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:08:29 INFO - Running setup.py (path:/tmp/pip-CTkAFD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:08:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:08:29 INFO - Running setup.py (path:/tmp/pip-Tdw7eU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:08:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:08:29 INFO - Running setup.py (path:/tmp/pip-KBNipT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:08:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:08:29 INFO - Running setup.py (path:/tmp/pip-MEmQpx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:08:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:08:29 INFO - Running setup.py (path:/tmp/pip-Z8aj7V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:08:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:08:29 INFO - Running setup.py (path:/tmp/pip-vhdIs9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:08:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:08:29 INFO - Running setup.py (path:/tmp/pip-OEMkvq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:08:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:08:29 INFO - Running setup.py (path:/tmp/pip-rUps__-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:08:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:08:29 INFO - Running setup.py (path:/tmp/pip-HTOqGU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:08:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:08:29 INFO - Running setup.py (path:/tmp/pip-88YctF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:08:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:08:29 INFO - Running setup.py (path:/tmp/pip-bwkqfw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:08:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:08:29 INFO - Running setup.py (path:/tmp/pip-IyPKRG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:08:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:08:29 INFO - Running setup.py (path:/tmp/pip-1iLU0m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:08:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:08:30 INFO - Running setup.py install for manifestparser 13:08:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:08:30 INFO - Running setup.py install for mozcrash 13:08:30 INFO - Running setup.py install for mozdebug 13:08:30 INFO - Running setup.py install for mozdevice 13:08:30 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:08:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:08:30 INFO - Running setup.py install for mozfile 13:08:30 INFO - Running setup.py install for mozhttpd 13:08:30 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:08:30 INFO - Running setup.py install for mozinfo 13:08:30 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:08:30 INFO - Running setup.py install for mozInstall 13:08:30 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:08:30 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:08:30 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:08:30 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:08:30 INFO - Running setup.py install for mozleak 13:08:30 INFO - Running setup.py install for mozlog 13:08:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:08:31 INFO - Running setup.py install for moznetwork 13:08:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:08:31 INFO - Running setup.py install for mozprocess 13:08:31 INFO - Running setup.py install for mozprofile 13:08:31 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:08:31 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:08:31 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:08:31 INFO - Running setup.py install for mozrunner 13:08:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:08:31 INFO - Running setup.py install for mozscreenshot 13:08:31 INFO - Running setup.py install for moztest 13:08:31 INFO - Running setup.py install for mozversion 13:08:31 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:08:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:08:31 INFO - Cleaning up... 13:08:31 INFO - Return code: 0 13:08:31 INFO - Installing None 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', '-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 0x11a5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1466180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14643b0>, '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 0x14652b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1465740>, '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': 'df17445c3590ff7897617a0e00000225-1467229708.116181-1181107337', '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', '-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:31 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: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': 'df17445c3590ff7897617a0e00000225-1467229708.116181-1181107337', 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 - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:08:32 INFO - Running setup.py (path:/tmp/pip-E_TAp9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:08:32 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:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:08:32 INFO - Running setup.py (path:/tmp/pip-BlpEvl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:08:32 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:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:08:32 INFO - Running setup.py (path:/tmp/pip-LPnhT3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:08:32 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:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:08:32 INFO - Running setup.py (path:/tmp/pip-TXrUbM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:08:32 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:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:08:32 INFO - Running setup.py (path:/tmp/pip-LRxpoN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:08:32 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:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:08:32 INFO - Running setup.py (path:/tmp/pip-w_Vrm5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:08:32 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:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:08:32 INFO - Running setup.py (path:/tmp/pip-hDwCHC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:08:32 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:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:08:32 INFO - Running setup.py (path:/tmp/pip-JgLK4P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:08:32 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:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:08:32 INFO - Running setup.py (path:/tmp/pip-5jVTJi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:08:32 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:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:08:32 INFO - Running setup.py (path:/tmp/pip-nlFsE3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:08:32 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:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:08:32 INFO - Running setup.py (path:/tmp/pip-GbLHoy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:08:32 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:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:08:32 INFO - Running setup.py (path:/tmp/pip-ZJEugC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:08:32 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:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:08:32 INFO - Running setup.py (path:/tmp/pip-QOL5Gp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:08:32 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:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:08:33 INFO - Running setup.py (path:/tmp/pip-_NgMLH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:08:33 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:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:08:33 INFO - Running setup.py (path:/tmp/pip-HK2qZR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:08:33 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:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:08:33 INFO - Running setup.py (path:/tmp/pip-HeveIj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:08:33 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:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:08:33 INFO - Running setup.py (path:/tmp/pip-TYP5Fr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:08:33 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:33 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:33 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:33 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:33 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:33 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:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:08:33 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:33 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 - 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:33 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:33 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:33 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:35 INFO - Downloading blessings-1.6.tar.gz 13:08:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:08:35 INFO - Installing collected packages: blessings 13:08:35 INFO - Running setup.py install for blessings 13:08:35 INFO - Successfully installed blessings 13:08:35 INFO - Cleaning up... 13:08:35 INFO - Return code: 0 13:08:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:08:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:08:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:08:35 INFO - Reading from file tmpfile_stdout 13:08:35 INFO - Current package versions: 13:08:35 INFO - argparse == 1.2.1 13:08:35 INFO - blessings == 1.6 13:08:35 INFO - blobuploader == 1.2.4 13:08:35 INFO - docopt == 0.6.1 13:08:35 INFO - functools32 == 3.2.3-2 13:08:35 INFO - jsonschema == 2.5.1 13:08:35 INFO - manifestparser == 1.1 13:08:35 INFO - mozInstall == 1.12 13:08:35 INFO - mozcrash == 0.17 13:08:35 INFO - mozdebug == 0.1 13:08:35 INFO - mozdevice == 0.48 13:08:35 INFO - mozfile == 1.2 13:08:35 INFO - mozhttpd == 0.7 13:08:35 INFO - mozinfo == 0.9 13:08:35 INFO - mozleak == 0.1 13:08:35 INFO - mozlog == 3.2 13:08:35 INFO - moznetwork == 0.27 13:08:35 INFO - mozprocess == 0.22 13:08:35 INFO - mozprofile == 0.28 13:08:35 INFO - mozrunner == 6.11 13:08:35 INFO - mozscreenshot == 0.1 13:08:35 INFO - mozsystemmonitor == 0.3 13:08:35 INFO - moztest == 0.7 13:08:35 INFO - mozversion == 1.4 13:08:35 INFO - psutil == 3.1.1 13:08:35 INFO - requests == 1.2.3 13:08:35 INFO - wsgiref == 0.1.2 13:08:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:08:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:08:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:08:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:08:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:08:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:35 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 0x11a5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1466180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14643b0>, '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 0x14652b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1465740>, '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': 'df17445c3590ff7897617a0e00000225-1467229708.116181-1181107337', '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:35 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:35 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:35 INFO - Using env: {'DISPLAY': ':0', 13:08:35 INFO - 'HOME': '/home/cltbld', 13:08:35 INFO - 'LANG': 'en_US.UTF-8', 13:08:35 INFO - 'LANGUAGE': 'en_US:en', 13:08:35 INFO - 'LOGNAME': 'cltbld', 13:08:35 INFO - 'MAIL': '/var/mail/cltbld', 13:08:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:08:35 INFO - 'MOZ_NO_REMOTE': '1', 13:08:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:08:35 INFO - 'NO_EM_RESTART': '1', 13:08:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:08:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:08:35 INFO - 'PWD': '/builds/slave/test', 13:08:35 INFO - 'SHELL': '/bin/bash', 13:08:35 INFO - 'SHLVL': '1', 13:08:35 INFO - 'TERM': 'linux', 13:08:35 INFO - 'TMOUT': '86400', 13:08:35 INFO - 'USER': 'cltbld', 13:08:35 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1467229708.116181-1181107337', 13:08:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:08:35 INFO - '_': '/tools/buildbot/bin/python'} 13:08:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:08:35 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:35 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:35 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:35 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:35 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:35 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:35 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:35 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:35 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:35 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:35 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:35 INFO - Cleaning up... 13:08:35 INFO - Return code: 0 13:08:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:08:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:08:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:08:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:08:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:08:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:35 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 0x11a5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1466180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14643b0>, '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 0x14652b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1465740>, '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': 'df17445c3590ff7897617a0e00000225-1467229708.116181-1181107337', '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:35 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:35 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:35 INFO - Using env: {'DISPLAY': ':0', 13:08:35 INFO - 'HOME': '/home/cltbld', 13:08:35 INFO - 'LANG': 'en_US.UTF-8', 13:08:35 INFO - 'LANGUAGE': 'en_US:en', 13:08:35 INFO - 'LOGNAME': 'cltbld', 13:08:35 INFO - 'MAIL': '/var/mail/cltbld', 13:08:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:08:35 INFO - 'MOZ_NO_REMOTE': '1', 13:08:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:08:35 INFO - 'NO_EM_RESTART': '1', 13:08:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:08:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:08:35 INFO - 'PWD': '/builds/slave/test', 13:08:35 INFO - 'SHELL': '/bin/bash', 13:08:35 INFO - 'SHLVL': '1', 13:08:35 INFO - 'TERM': 'linux', 13:08:35 INFO - 'TMOUT': '86400', 13:08:35 INFO - 'USER': 'cltbld', 13:08:35 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1467229708.116181-1181107337', 13:08:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:08:35 INFO - '_': '/tools/buildbot/bin/python'} 13:08:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:08:36 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:08:36 INFO - Cleaning up... 13:08:36 INFO - Return code: 0 13:08:36 INFO - Running post-action listener: _resource_record_post_action 13:08:36 INFO - Running post-action listener: _start_resource_monitoring 13:08:36 INFO - Starting resource monitoring. 13:08:36 INFO - ##### 13:08:36 INFO - ##### Finished create-virtualenv step (success) 13:08:36 INFO - ##### 13:08:36 INFO - ##### 13:08:36 INFO - ##### Running install step. 13:08:36 INFO - ##### 13:08:36 INFO - Running pre-action listener: _resource_record_pre_action 13:08:36 INFO - Running main action method: install 13:08:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:08:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:08:36 INFO - Reading from file tmpfile_stdout 13:08:36 INFO - Detecting whether we're running mozinstall >=1.0... 13:08:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:08:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:08:36 INFO - Reading from file tmpfile_stdout 13:08:36 INFO - Output received: 13:08:36 INFO - Usage: mozinstall [options] installer 13:08:36 INFO - Options: 13:08:36 INFO - -h, --help show this help message and exit 13:08:36 INFO - -d DEST, --destination=DEST 13:08:36 INFO - Directory to install application into. [default: 13:08:36 INFO - "/builds/slave/test"] 13:08:36 INFO - --app=APP Application being installed. [default: firefox] 13:08:36 INFO - mkdir: /builds/slave/test/build/application 13:08:36 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:36 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:08:55 INFO - Reading from file tmpfile_stdout 13:08:55 INFO - Output received: 13:08:55 INFO - /builds/slave/test/build/application/firefox/firefox 13:08:55 INFO - Running post-action listener: _resource_record_post_action 13:08:55 INFO - ##### 13:08:55 INFO - ##### Finished install step (success) 13:08:55 INFO - ##### 13:08:55 INFO - ##### 13:08:55 INFO - ##### Running run-tests step. 13:08:55 INFO - ##### 13:08:55 INFO - Running pre-action listener: _resource_record_pre_action 13:08:55 INFO - Running main action method: run_tests 13:08:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:08:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:08:55 INFO - Python 2.7.3 13:08:55 INFO - Return code: 0 13:08:55 INFO - grabbing minidump binary from tooltool 13:08:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:08:55 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 0x14643b0>, '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 0x14652b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1465740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:08:55 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:08:55 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:08:55 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:08:55 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:08:55 INFO - Return code: 0 13:08:55 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:08:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:08:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:08:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:08:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:08:55 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', '--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-021', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 13:08:55 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 --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-021 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 13:08:55 INFO - Using env: {'DISPLAY': ':0', 13:08:55 INFO - 'HOME': '/home/cltbld', 13:08:55 INFO - 'LANG': 'en_US.UTF-8', 13:08:55 INFO - 'LANGUAGE': 'en_US:en', 13:08:55 INFO - 'LOGNAME': 'cltbld', 13:08:55 INFO - 'MAIL': '/var/mail/cltbld', 13:08:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:08:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:08:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:08:55 INFO - 'MOZ_NO_REMOTE': '1', 13:08:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:08:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:08:55 INFO - 'NO_EM_RESTART': '1', 13:08:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:08:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:08:55 INFO - 'PWD': '/builds/slave/test', 13:08:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:08:55 INFO - 'SHELL': '/bin/bash', 13:08:55 INFO - 'SHLVL': '1', 13:08:55 INFO - 'TERM': 'linux', 13:08:55 INFO - 'TMOUT': '86400', 13:08:55 INFO - 'USER': 'cltbld', 13:08:55 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1467229708.116181-1181107337', 13:08:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:08:55 INFO - '_': '/tools/buildbot/bin/python'} 13:08:55 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', '--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-021', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 13:08:55 INFO - mozversion application_buildid: 20160629072230 13:08:55 INFO - mozversion application_changeset: eeb6862f960c1310bde9aed159f3fc5bb2d4b6d7 13:08:55 INFO - mozversion application_display_name: Nightly 13:08:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:08:55 INFO - mozversion application_name: Firefox 13:08:55 INFO - mozversion application_remotingname: firefox 13:08:55 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 13:08:55 INFO - mozversion application_vendor: Mozilla 13:08:55 INFO - mozversion application_version: 50.0a1 13:08:55 INFO - mozversion platform_buildid: 20160629072230 13:08:55 INFO - mozversion platform_changeset: eeb6862f960c1310bde9aed159f3fc5bb2d4b6d7 13:08:55 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 13:08:55 INFO - mozversion platform_version: 50.0a1 13:08:55 INFO - using testdate: 1467230935 13:08:55 INFO - actual date: 1467230935 13:08:55 INFO - starting webserver on 'localhost:47528' 13:08:55 INFO - SUITE-START | Running 2 tests 13:08:55 INFO - TEST-START | dromaeo_css 13:08:55 INFO - operating with platform_type : linux_ 13:08:55 INFO - Initialising browser for dromaeo_css test... 13:08:55 INFO - TEST-INFO | started process 14241 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprwUd03/profile http://localhost:47528/getInfo.html) 13:09:01 INFO - PROCESS | 14241 | __metrics Screen width/height:1600/1200 13:09:01 INFO - PROCESS | 14241 | colorDepth:24 13:09:01 INFO - PROCESS | 14241 | Browser inner width/height: 1024/697 13:09:01 INFO - PROCESS | 14241 | __metrics 13:09:02 INFO - PROCESS | 14241 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:09:03 INFO - TEST-INFO | 14241: exit 0 13:09:03 INFO - Browser initialized. 13:09:03 INFO - Running cycle 1/1 for dromaeo_css test... 13:09:03 INFO - TEST-INFO | started process 14323 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprwUd03/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:09:15 INFO - PROCESS | 14323 | RSS: Main: 159354880 13:09:15 INFO - PROCESS | 14323 | 13:10:06 INFO - PROCESS | 14323 | 1467231006389 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:19 INFO - PROCESS | 14323 | Cycle 1(1): loaded http://localhost:47528/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47528/tests/dromaeo/cssquery-ext.html) 13:12:20 INFO - PROCESS | 14323 | RSS: Main: 236814336 13:12:20 INFO - PROCESS | 14323 | 13:15:23 INFO - PROCESS | 14323 | Cycle 1(1): loaded http://localhost:47528/tests/dromaeo/cssquery-ext.html (next: http://localhost:47528/tests/dromaeo/cssquery-jquery.html) 13:15:23 INFO - PROCESS | 14323 | RSS: Main: 242561024 13:15:23 INFO - PROCESS | 14323 | 13:18:26 INFO - PROCESS | 14323 | Cycle 1(1): loaded http://localhost:47528/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47528/tests/dromaeo/cssquery-mootools.html) 13:18:26 INFO - PROCESS | 14323 | RSS: Main: 238247936 13:18:26 INFO - PROCESS | 14323 | 13:21:28 INFO - PROCESS | 14323 | Cycle 1(1): loaded http://localhost:47528/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47528/tests/dromaeo/cssquery-prototype.html) 13:21:29 INFO - PROCESS | 14323 | RSS: Main: 240689152 13:21:29 INFO - PROCESS | 14323 | 13:24:32 INFO - PROCESS | 14323 | Cycle 1(1): loaded http://localhost:47528/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47528/tests/dromaeo/cssquery-yui.html) 13:24:33 INFO - PROCESS | 14323 | RSS: Main: 223903744 13:24:33 INFO - PROCESS | 14323 | 13:27:35 INFO - PROCESS | 14323 | Cycle 1(1): loaded http://localhost:47528/tests/dromaeo/cssquery-yui.html (next: http://localhost:47528/tests/dromaeo/cssquery-dojo.html) 13:27:36 INFO - PROCESS | 14323 | RSS: Main: 283561984 13:27:36 INFO - PROCESS | 14323 | 13:27:36 INFO - PROCESS | 14323 | __start_tp_report 13:27:36 INFO - PROCESS | 14323 | _x_x_mozilla_page_load 13:27:36 INFO - PROCESS | 14323 | _x_x_mozilla_page_load_details 13:27:36 INFO - PROCESS | 14323 | |i|pagename|runs| 13:27:36 INFO - PROCESS | 14323 | |0;dojo.html;2629.460960503097;2647.457271259392;2651.072124756335;2684.4899469100883;2697.649305590273;4641.071785642868;4728.692634978724;4788.114198873211;4805.375301210842;4824.710517368961;4759.309900064497;4760.8333708320215;4763.595094416979;4802.639802014845;4815.133276010317;4312.05134870328;4366.628836548897;4391.231534481469;4425.557444255564;4585.037142200142;4484.148011877749;4524.095180963804;4542.727436353813;4556.20266453371;4574.428196475441;4277.123189746095;4334.544872788343;4335.739855608674;4388.736675799462;4393.604575588212;4338.2191205582985;4359.106383191438;4373.103513779699;4417.845375411845;4428.911421771547;4376.190404775127;4401.581849724271;4410.572240158796;4447.3996010538485;4452.131834292314;4663.044075964419;4721.150192965265;4754.833580824655;4800.375951126366;4807.61539076873;5188.948110518922;5191.402988656315;5197.376314842205;5203.193505006692;5208.635395522315;5188.6367954243215;5200.765965531522;5224.39919409269;5231.764570594294;5238.816641417532;4667.743274119888;4726.645501587394;4779.593734532534;4801.15979703554;4803.735794531264;5322.414534401213;5329.813456529003;5334.813281535127;5339.359276886721;5343.171808369709;5068.138416469209;5092.668976516515;5117.488251174927;5119.3088932994315;5122.487751224848;4994.2508623706735;5017.523335283142;5064.772085256172;5072.239164125411;5142.228665700175;5014.423341315795;5032.84901452957;5041.369828771403;5043.974780126149;5091.08360495107;4843.515648435128;5009.073321435546;5012.67417617861;5014.147594908802;5020.422651395063;4322.848700295474;4362.585554372329;4367.912641747147;4369.148016136886;4419.9779001105435;3785.280796648628;3800.239952009609;3803.144292534213;3841.2317536492255;3843.327417701891;4303.591158839905;4400.9559904401185;4410.095930334273;4454.955450445519;4459.152760975404;5158.871028224249;5180.326557547494;5188.351456067991;5210.088234558937;5214.2960700304975;4403.713758605681;4431.556844315607;4437.334399839985;4458.687891847604;4480.260756975128;4486.3494793254795;4532.592066713945;4668.976655116703;4671.6262698984;4703.0593881223895;4759.7858096386435;4777.0684716479955;4786.880327991828;4799.400074990626;4833.492483289345;5095.745212739274;5097.235414687678;5098.898022039612;5102.107131251942;5132.409772876167;4664.533546645308;4788.209945358977;4835.903281934271;4849.369581954324;4887.780049897834;5007.949920500894;5046.798128074836;5058.140116180185;5060.949390506048;5101.46434624374;5122.103631864335;5136.178211486144;5142.305788718625;5144.151215049475;5176.352955880515;4845.685030473008;4929.211326187793;4946.480619535041;4979.3526841510375;4990.725510096834;4969.652124351405;4982.676126051795;4996.60027197816;5000.749962501933;5047.2681461187185;4862.440819305825;4888.706677599355;4895.681780684244;4943.30793688891;4948.8762780930765;4899.11815873132;5004.249362595494;5046.444891062054;5050.368703912011;5068;4940.92588611164;4952.10862044821;4984.800607975785;4992.650514463952;5033.245013248042 13:27:36 INFO - PROCESS | 14323 | |1;ext.html;578.7395671947623;586.3989410853874;592.8310431527016;594.708592789533;601.3505414152716;26581.202563923063;38979.220415591706;40340.39489407661;40644.59355406445;44258.33612495815;41135.794321028356;41456.792716036376;41583.37624935628;41634.58365416345;41674.79162604183;7421.2949769771785;7778.027746531669;7922.326602238788;7925.722599709012;7927.920720792805;10042.648507302245;10294.794104117913;10329.070383665468;10695.46522673867;10696;10193.694189174299;10284.074433301;10296.742581435486;10307.587696492168;10309.123724483428;7368.336849683501;10000.549975251131;10133.08802207801;10195.1843852492;10288.948555257251;10049.748756281078;10068.29521933465;10114.44370559619;10127.645532406405;10130.392176469435;38285.80857095725;38608.71825894802;38641.42037869434;38755.612443875485;38855;3016.622922134733;3034.7723920705816;3055.8624861881044;3212.2932954749917;3305.586801649794;29285.41429171426;29685.109446716633;29894;30229.546556801666;30751.692483075105;3397.303552771676;3435.2270739083506;3437.1063523483826;3440.17435815405;3463.792172469635;244111;244887;245903;245995;247823;31822.522662160085;50854.49145508498;51001.489985100416;51075.74462127666;51159;31987.840060799546;33809.661903381144;33899.322013560086;33964.66035339664;34002;13631.591052268448;13856.93071534656;13860.861391386159;13866.65333366674;13874.167549947035;10390.896091038992;10642.521086551124;10883.292585981886;10887.401192934307;11399.202055856176;7914.327282181079;7918.722844700408;7946;7993.160718124629;7993.640286187136;3085.460044492205;3184.3153721949893;3186.87252509897;3208.422483952911;3231.9838400808317;872.5951218538148;874.213208112691;904.1997831918668;942.3074040580168;1031.0823367203195;27612;28108.85945570259;28145.43709125806;28276.293092672848;28997.710022899922;979.5755505124902;987.3286165407449;1028.6619918364954;1031.8452232165234;1034.9379037257788;14499.92750036243;14644.341004654816;14853.2573371331;15155.166465844484;15262;370089;370123;373348;374389;375924;48244.03511929742;48576.757116214896;48683;48733.26900096501;48748.5125148751;1090.6346373964652;1175.5591653130077;1208.4139192491634;1209.2079687804503;1210.9636710898687;27539.862300688368;29042.27394315159;29176.416471670873;29369;29828.552571711007;41427.37858932179;42000.57999419967;42005.57994420139;42013;42031.57968420276;294018;298998;299469;300215;300273;22152.778472215716;24074.27777166688;24704.629430558914;25005.374865628506;26820.329491762863;42192.578074220095;42201.36697949472;42282;43097;43234.35148472712;34624;35997;36718.44922326114;36754.8162259187;37108;36598.817005915866;36964.44553331756;37168.25663486769;37212.44181337336;37266.8136659315;35364.64635353613;35730;37250.44124338083;37354.252914942095;40010.599894001854;29659.851700741357;31774.523382148825;31775.841120794248;32199.67800321967;32330.676693232766;25380.365490862878;25549.61675574905;25697.871510642326;25864.094756683426;25922.949469694624 13:27:36 INFO - PROCESS | 14323 | |2;jquery.html;338.9186595217146;366.59857456085587;366.8532586965212;371.4354181643901;386.17358852056606;13188.208707477546;16588.834111658878;17007.404740834074;18386.172622232;18396.999999999967;17371.47885563432;17725.37961171356;17879.374221902235;18211.90894045528;18525.888446693207;4793.6884102533395;5129.410117836441;5131.820386286481;5134.717590532519;5136.820211292606;3738.1776009277914;5071.2139618359215;5742.885142297151;6037.969810150965;6038.064100064497;6075.726592303335;6086.726097325631;6105.572609917285;6107.114468402079;6113.449789518964;5066.569341605968;5346.518813306782;5377.838664840061;5432.402435732066;5442.836714898559;3397.0827876473213;4961.801527938878;5255.237990491358;5270.6837589744355;5293.23248129023;12091.516339346415;12119.212251203731;12228.694282642917;12326.32205228712;12458.377081145996;1854.805245449222;2137.390843609564;2270.4096934796908;2316.6409206573007;2339.894704738291;9311.5809788559;9506.762330941712;13074.280914549696;13271.535496257682;13906.235157066358;1771.7253825657044;1783.9464816055408;1785.4554360919915;1808.882422642524;1820.7906090799595;68160;69625.30374696238;70620;71271;71952.64023679901;8732.301415886714;9123;9457.38526995743;9700.805983880424;10349.896501035044;11951.940240298743;12682.619521414372;12692.6038135805;13148.802767958488;13217.537386191629;5428.728563571805;7074.858502829915;7307.794213954744;7441.330280274801;7619.238076192447;7171.92828071723;7282.089738782653;7290.671919763623;7321.487495875238;7378.40972722181;4086.468759061303;4139;4157.251694694984;4237.300845360481;4520.59314661682;1789.2216885654782;1834.523024013766;1844.3729132094884;1868.23402405016;1888.7733471983174;794.4557977785236;812.8171161488737;828.1304630138451;847.741438861141;851.9403641745142;16684;17351.566210844576;17539.82460175382;17653.20560574777;18086.366977155736;824.2664029014182;840.6343240690319;846.094678693804;892.7143314139413;901.2609660078804;6652.866942661217;9637.662681806103;9658.517074146264;9729.902700973042;9810.460424676712;407412;409621;412739;415180;415984;81907.5904620485;82959;83135.16864831395;83877.58061209776;84109.57945210235;875.868619707049;891.6299735609779;892.1836519584507;894.4767311122936;897.2552781191596;14468.27658617086;15312.081275123528;15433.768493472831;15572.92213538925;15619.219039047775;29332.560011599417;32660.673393265763;38074.8096259528;38581.807090964365;39170.4124438128;51025.48974510207;52595.21107183472;53165.4683453176;53197;53330;7316.597587132759;7320.816979575553;7372.447066469929;7376.96311518439;7457.328840404172;9646.710598682052;10911.672649820519;11390.601328953448;11393.430328483708;11775.941120294343;9270.907290927003;9368.156865882103;9478.668246611336;9623.615055397706;9637.18083962871;9400.717978460658;9527.237820974444;9983.900160998297;10320.225983051452;10356.792864142826;9412.247020238228;9487.146156845916;9640.662576809778;9755.707328780149;9778.706638800848;6478;7434.516756410816;7500.474966752275;7506.361959233526;7798.727044553413;8879.200871921557;9080.182783549511;9116.680916167903;9354.204892584206;9769.56036978352 13:27:36 INFO - PROCESS | 14323 | |3;mootools.html;1240.193873981912;1288.9871101288984;1311.272243904633;1608.541565653789;1640.876934229933;7565.4704170708;7994.440389172761;8078;8080.555569443693;8099.109097999215;6793.830154246146;6998.370146686797;7006.754763583275;7218.314260145291;7917.802054948615;1928.5467915039953;2097.905594248255;2186.5189658275235;2190.76996915324;2192.6491761318193;2218.4010317214343;2222.9888850555726;2244.4164517225477;2247.0337754765446;2291.9083236670513;1922.5866438715673;2118.33272519156;2217.589745897006;2240.2383189715574;2243.2821497120926;2198.362474882282;2239.85440946338;2240.8767517786514;2242.6075436798496;2244.2706120510734;2116.407405926343;2118.925837595677;2132.051237199447;2171.0447403142566;2171.3485954213675;7872.645730942121;7889.329407000412;7895.447318687694;7914.0503139623615;7932.365410767125;4404.22925987954;4496.055828276066;4539.954600454019;4562.406887104655;4564.360989461478;2759.0059199928287;2814.1698199031334;2831.589419534156;2850.3586692994118;2854.9143525694262;900.342749792655;920.3005715656083;933.4072863731511;958.434523631054;964.9179819715332;10467.738306542322;10743.838842417448;10758.246922715412;10780.5687772489;10812.080973117294;4067.2678917794487;4079.632833044981;4204.087140351133;4266.189424009428;4267.637250833714;9317.906820931705;9323.160915517636;9329.346945713734;9348.1119293667;9362.812743745088;4648.488666246778;4655.348251244828;4659.720416774937;4661.044485880387;4661.906761864744;3540.3804334241404;4187.434696315959;4222.366645003274;4245.341971994346;4247.193033323659;3576.9821150894077;3678.521792167001;3735.7198210134347;3748.437734339871;3804.3152232597845;1177.1053998960851;1195.5217912834762;1201.597464849268;1206.330486579939;1214.6477521518661;591.6716222496556;602.3284038297267;620.6090163197157;635.9523035772336;655.5902560899438;4794.496577859344;4847.200211965057;4857.635677324144;4911.50884911506;4930.531599498042;853.159637756809;855.6876739989983;873.2010210657304;876.412803421709;883.0463099852144;3146.8269245191277;3180.538821870862;3303.6035675719068;3500.1599616092462;3579.570451545831;9681.37071090391;9777.902220977841;9859.35914165577;9907.25695572835;9940.652077177409;9081.54592270384;9812.558434870305;9819.165370943407;9842;9847.113759761656;7195.388391986635;7293.16128645202;7337;7378.483506154625;7393.704251829867;5087.491250874883;5155.355580552431;5268.9736551317;5397.136458166831;5490.0941344677685;8686.435381700168;9024;9026.232770214605;9100.590473428843;9122.498262595356;8971.955140224258;9262.30532710036;9273.350865439625;9280.164785169367;9366.484843333683;6211.3478084800445;6606.735730570916;6818.249992500721;6980.685869136003;6991.615461149686;7395.556266624019;7601;7621.847563048597;7691.346235570039;7714.884276735741;6700.899486507804;6988.860222795414;7042.049323341488;7084.822879428056;7163.31948464895;6476.417122459001;6546;6608.207015158212;6658.400743933069;6712.127423434922;6007.909881351696;6079.270487541523;6091.817245482643;6092.817215483543;6095.634261944298;4358.476982761962;4445.222086134978;4457;4497.460304763449;4597;4539.6822222445435;4605.585497305258;4610.861674149781;4641.814327426865;4698.765061746831 13:27:36 INFO - PROCESS | 14323 | |4;prototype.html;287.8359335178949;289.4789379117588;295.9862471036699;300.92777733344;302.01542969918074;4814.4222693276815;4886.63350248731;4889.559939605435;4900.191468407713;4911.115999120157;4523.117991991555;4655.394798676176;4736.59738922192;4739.653871333686;4842.24945133504;3757.7745335279833;3796.3925771876507;3799.563050249229;3811.3520701480675;3859.4982652255308;3821.3503704370187;3825.6365645263654;3846.384578467446;3857.633524815138;3860.7838530862828;3581.874634387797;3636.672699457048;3739.3456145174487;3765.491658626078;3773.5094437723055;3769.491118698968;3772.886813395589;3773.433984902259;3775.4336849472525;3785.848566057354;3350.2629421527467;3353.7987720736833;3363.596368435779;3365.528825964367;3368.326334733063;4510.323451482271;4712.858614241544;4720.976395118037;4725.881852953669;4749.316636100592;4294.828206871722;4356.386168299027;4366.410534577855;4368.737875727466;4387.4954380246045;5119.8208062717995;5124.538791508782;5126.61550383719;5132.0505706444055;5132.307138536287;3591.586967498745;3706.240220754739;3712.2761061593;3712.832922518493;3716.9070773230887;5235.528802407764;5260.605454590883;5265.420803711589;5265.552428043621;5292.311999440049;3749.4563288323584;3757.492738480325;3766.773993560395;3767.4913886625504;3768.1521657626813;3827.4641550182996;3828.693704503633;3830.199806091133;3830.751001184914;3837.4435706822915;4217.768022758716;4298.398224248608;4343.4146536513945;4352.455943007124;4357.607815296638;5038.748062596856;5071.2139618359215;5093.796248150106;5103.795848166106;5144.530625299877;1261.4701825233424;1287.2598256002836;1336.7927971164486;1336.7994800779961;1349.089364678838;903.304455569208;907.1427501011613;927.3647551427293;930.7533503621546;937.2689302344182;4424.73451592899;4435.068635586498;4442.267025940748;4460.174867649495;4468.50846406895;5146.279520867081;5163.380394352702;5190.235319991221;5197.402298735618;5200.97399513;4452.888677783081;4459.732416055047;4461.598456138898;4464.55354464551;4472.262076757299;2317.9188728394424;2444.0081333712965;2448.8408253463467;2456.484138330935;2465.3220364399936;4381.539938306432;4385.693001489929;4392.231359512072;4405.73104851002;4437.5784300491405;4670.743109128963;4675.275332323496;4700.976495117503;4737.549932756383;4762.78567464465;4219.952036934508;4305.031367942251;4347.108842687241;4378.81771921573;4379.386885835986;4584.587387135174;4603.273772335374;4615.953840461552;4625.699329543703;4633.884152896205;4513.977430112828;4519.502854685916;4570.771461426849;4574.290984897346;4581.823633773931;4331.523532411496;4375.1905897407805;4575.679702420799;4962.975185124052;4964.624055642198;3660.469231961404;3661.7253705971625;3675.650813172744;3695.3533131701306;3697.741158118906;5035.7985680572365;5165.7933682653775;5210.14032684618;5262.657927234717;5266.2363957225225;4928.630352723489;5004.549590536869;5006.374203224597;5011.624128190473;5040.899182016413;5041.873953151201;5068.417132029864;5088.796448142033;5090.574639101058;5136.383633963799;4835.20219163834;4963.138822941397;4968.751562421792;4985.775640096132;5009.198528235464;5086.872828179326;5095.312132862016;5095.949040509548;5099.23511473282;5125.231215317732;4995.950040499549;5002.099622068063;5020.3724534433195;5027.874303142451;5030.5975521957425 13:27:36 INFO - PROCESS | 14323 | |5;yui.html;589.9262592175977;606.7330374635162;652.3183273479214;657.9407154481287;667.8630880669464;10794.676159715202;11508.25196362237;12206.81689774653;12487.188332758387;12577.685557861058;12378.690532736686;12884.03369747268;12992.285424301659;13112.868871311308;13182.934085329583;740.7259314053795;772.8415674786655;777.7005852746705;781.7420251317052;782.7690831204808;629.9968500157493;761.113303002002;773.091617349612;781.4490783997296;782.0185666987923;832.4089896173724;832.6919039955225;835.3484282259847;837.409626213521;839.4669384940577;824.9422540422173;825.3479750996736;825.3933358981144;825.591332290517;825.6986200037003;606.5966132521868;606.7118118893534;606.754264522869;606.7906572232573;609.9359567245419;11607.4196290186;11615.070794336432;11651.475683594173;11655;11665.941670291679;12157.452914618863;12390.132690711655;12688;12841.165324253894;12854.871451285555;9423.293253006052;9434.952825235898;9486.478243696594;9706.72926291916;9890.604375824958;3068.4170007698467;3094.087244262948;3106.48742957414;3119.4540955332727;3183.3792410479964;58958.11562826561;59014.11478827821;59528.404715953155;60578.39421605771;62640;9718.562664680107;9724.17344525709;9788.21694264457;10028.849567256497;10170.186385089175;15880.682386352439;16189.919050404673;16225.350985960666;16228.918855405884;16273.267702953395;6929.68816403253;7014.438844892396;7031.964840175767;7070.5404148731195;7138.072050633385;3631.618680038611;3779.149691319486;3807.333716599584;3947.9013024674614;3984.621460961262;2673.612326212727;2750.876210570489;2752.1193218170392;2762.6270453488924;2762.7927905407173;484.6922204400231;492.7905640102942;497.0233491189757;517.7592419524939;518.7198912587236;472.7825200407782;501.08551892795066;537.4061661863584;544.4854612391331;558.3076984539142;7564.319211271012;7630.465867389341;7875.409344299201;7971.083325417535;8074.7577572671735;481.2228251374006;525.747641132251;551.2295896070815;555.4584280326649;565.0223323087389;3805.562360328542;3870.9806450967567;3928.6660633846445;3932.134930315326;4052.5744796796503;78597;96348.51825740826;96978.21152519256;100284.4985775081;100791;71045.64477177581;81573.18426815656;81829;82526;82614;51550.48449515532;68929.65535172392;73281.26718732744;74707.62646186844;76763.2323676756;7172.677229524788;7642.08295004603;7772.533647981139;7829.177936316605;7855.646495907584;44921.32618010798;45952.31071533863;46737;47090;47106.29340559963;63242;65123;65682;67111.32888671051;67309;9233;9456.858147127661;9522.143007129114;9672.95163524178;9741.9025809741;10859.294145880493;10870.184736144978;10996.175286853679;11182.776344472903;11199.60801371948;9392.812143757223;9408.811823763623;9685.806283874143;9761.414315141114;9781.706548803548;9523;9891.554880030271;10285.588576456857;10336.534855931352;10438.402939326508;9647.083527064917;9671.854922176033;9889.901100988898;9947.850782238127;10251.7437064074;8147.14454982242;8229.135940726377;8231.09457959636;8252.958735206286;8380.371472139735;8236.299914507334;8243.629036693243;8329.12544182852;8368.83262334762;8462.661493540436 13:27:36 INFO - PROCESS | 14323 | __end_tp_report 13:27:36 INFO - PROCESS | 14323 | __start_cc_report 13:27:36 INFO - PROCESS | 14323 | _x_x_mozilla_cycle_collect,1040 13:27:36 INFO - PROCESS | 14323 | __end_cc_report 13:27:36 INFO - PROCESS | 14323 | __startTimestamp1467232056117__endTimestamp 13:27:36 INFO - PROCESS | 14323 | 13:27:36 INFO - PROCESS | 14323 | ------- Summary: start ------- 13:27:36 INFO - PROCESS | 14323 | Number of tests: 6 13:27:36 INFO - PROCESS | 14323 | 13:27:36 INFO - PROCESS | 14323 | [#0] dojo.html Cycles:165 Average:4736.82 Median:4835.90 stddev:499.23 (10.3%) stddev-sans-first:472.59 13:27:36 INFO - PROCESS | 14323 | Values: 2629.5 2647.5 2651.1 2684.5 2697.6 4641.1 4728.7 4788.1 4805.4 4824.7 4759.3 4760.8 4763.6 4802.6 4815.1 4312.1 4366.6 4391.2 4425.6 4585.0 4484.1 4524.1 4542.7 4556.2 4574.4 4277.1 4334.5 4335.7 4388.7 4393.6 4338.2 4359.1 4373.1 4417.8 4428.9 4376.2 4401.6 4410.6 4447.4 4452.1 4663.0 4721.2 4754.8 4800.4 4807.6 5188.9 5191.4 5197.4 5203.2 5208.6 5188.6 5200.8 5224.4 5231.8 5238.8 4667.7 4726.6 4779.6 4801.2 4803.7 5322.4 5329.8 5334.8 5339.4 5343.2 5068.1 5092.7 5117.5 5119.3 5122.5 4994.3 5017.5 5064.8 5072.2 5142.2 5014.4 5032.8 5041.4 5044.0 5091.1 4843.5 5009.1 5012.7 5014.1 5020.4 4322.8 4362.6 4367.9 4369.1 4420.0 3785.3 3800.2 3803.1 3841.2 3843.3 4303.6 4401.0 4410.1 4455.0 4459.2 5158.9 5180.3 5188.4 5210.1 5214.3 4403.7 4431.6 4437.3 4458.7 4480.3 4486.3 4532.6 4669.0 4671.6 4703.1 4759.8 4777.1 4786.9 4799.4 4833.5 5095.7 5097.2 5098.9 5102.1 5132.4 4664.5 4788.2 4835.9 4849.4 4887.8 5007.9 5046.8 5058.1 5060.9 5101.5 5122.1 5136.2 5142.3 5144.2 5176.4 4845.7 4929.2 4946.5 4979.4 4990.7 4969.7 4982.7 4996.6 5000.7 5047.3 4862.4 4888.7 4895.7 4943.3 4948.9 4899.1 5004.2 5046.4 5050.4 5068.0 4940.9 4952.1 4984.8 4992.7 5033.2 13:27:36 INFO - PROCESS | 14323 | 13:27:36 INFO - PROCESS | 14323 | [#1] ext.html Cycles:180 Average:45492.41 Median:3210.36 stddev:81541.09 (2539.9%) stddev-sans-first:81700.11 13:27:36 INFO - PROCESS | 14323 | Values: 578.7 586.4 592.8 594.7 601.4 26581.2 38979.2 40340.4 40644.6 44258.3 41135.8 41456.8 41583.4 41634.6 41674.8 7421.3 7778.0 7922.3 7925.7 7927.9 10042.6 10294.8 10329.1 10695.5 10696.0 10193.7 10284.1 10296.7 10307.6 10309.1 7368.3 10000.5 10133.1 10195.2 10288.9 10049.7 10068.3 10114.4 10127.6 10130.4 38285.8 38608.7 38641.4 38755.6 38855.0 3016.6 3034.8 3055.9 3212.3 3305.6 29285.4 29685.1 29894.0 30229.5 30751.7 3397.3 3435.2 3437.1 3440.2 3463.8 244111.0 244887.0 245903.0 245995.0 247823.0 31822.5 50854.5 51001.5 51075.7 51159.0 31987.8 33809.7 33899.3 33964.7 34002.0 13631.6 13856.9 13860.9 13866.7 13874.2 10390.9 10642.5 10883.3 10887.4 11399.2 7914.3 7918.7 7946.0 7993.2 7993.6 3085.5 3184.3 3186.9 3208.4 3232.0 872.6 874.2 904.2 942.3 1031.1 27612.0 28108.9 28145.4 28276.3 28997.7 979.6 987.3 1028.7 1031.8 1034.9 14499.9 14644.3 14853.3 15155.2 15262.0 370089.0 370123.0 373348.0 374389.0 375924.0 48244.0 48576.8 48683.0 48733.3 48748.5 1090.6 1175.6 1208.4 1209.2 1211.0 27539.9 29042.3 29176.4 29369.0 29828.6 41427.4 42000.6 42005.6 42013.0 42031.6 294018.0 298998.0 299469.0 300215.0 300273.0 22152.8 24074.3 24704.6 25005.4 26820.3 42192.6 42201.4 42282.0 43097.0 43234.4 34624.0 35997.0 36718.4 36754.8 37108.0 36598.8 36964.4 37168.3 37212.4 37266.8 35364.6 35730.0 37250.4 37354.3 40010.6 29659.9 31774.5 31775.8 32199.7 32330.7 25380.4 25549.6 25697.9 25864.1 25922.9 13:27:36 INFO - PROCESS | 14323 | 13:27:36 INFO - PROCESS | 14323 | [#2] jquery.html Cycles:180 Average:24850.19 Median:53181.23 stddev:68146.06 (128.1%) stddev-sans-first:68312.38 13:27:36 INFO - PROCESS | 14323 | Values: 338.9 366.6 366.9 371.4 386.2 13188.2 16588.8 17007.4 18386.2 18397.0 17371.5 17725.4 17879.4 18211.9 18525.9 4793.7 5129.4 5131.8 5134.7 5136.8 3738.2 5071.2 5742.9 6038.0 6038.1 6075.7 6086.7 6105.6 6107.1 6113.4 5066.6 5346.5 5377.8 5432.4 5442.8 3397.1 4961.8 5255.2 5270.7 5293.2 12091.5 12119.2 12228.7 12326.3 12458.4 1854.8 2137.4 2270.4 2316.6 2339.9 9311.6 9506.8 13074.3 13271.5 13906.2 1771.7 1783.9 1785.5 1808.9 1820.8 68160.0 69625.3 70620.0 71271.0 71952.6 8732.3 9123.0 9457.4 9700.8 10349.9 11951.9 12682.6 12692.6 13148.8 13217.5 5428.7 7074.9 7307.8 7441.3 7619.2 7171.9 7282.1 7290.7 7321.5 7378.4 4086.5 4139.0 4157.3 4237.3 4520.6 1789.2 1834.5 1844.4 1868.2 1888.8 794.5 812.8 828.1 847.7 851.9 16684.0 17351.6 17539.8 17653.2 18086.4 824.3 840.6 846.1 892.7 901.3 6652.9 9637.7 9658.5 9729.9 9810.5 407412.0 409621.0 412739.0 415180.0 415984.0 81907.6 82959.0 83135.2 83877.6 84109.6 875.9 891.6 892.2 894.5 897.3 14468.3 15312.1 15433.8 15572.9 15619.2 29332.6 32660.7 38074.8 38581.8 39170.4 51025.5 52595.2 53165.5 53197.0 53330.0 7316.6 7320.8 7372.4 7377.0 7457.3 9646.7 10911.7 11390.6 11393.4 11775.9 9270.9 9368.2 9478.7 9623.6 9637.2 9400.7 9527.2 9983.9 10320.2 10356.8 9412.2 9487.1 9640.7 9755.7 9778.7 6478.0 7434.5 7500.5 7506.4 7798.7 8879.2 9080.2 9116.7 9354.2 9769.6 13:27:36 INFO - PROCESS | 14323 | 13:27:36 INFO - PROCESS | 14323 | [#3] mootools.html Cycles:180 Average:5128.61 Median:5121.42 stddev:2927.81 (57.2%) stddev-sans-first:2921.44 13:27:36 INFO - PROCESS | 14323 | Values: 1240.2 1289.0 1311.3 1608.5 1640.9 7565.5 7994.4 8078.0 8080.6 8099.1 6793.8 6998.4 7006.8 7218.3 7917.8 1928.5 2097.9 2186.5 2190.8 2192.6 2218.4 2223.0 2244.4 2247.0 2291.9 1922.6 2118.3 2217.6 2240.2 2243.3 2198.4 2239.9 2240.9 2242.6 2244.3 2116.4 2118.9 2132.1 2171.0 2171.3 7872.6 7889.3 7895.4 7914.1 7932.4 4404.2 4496.1 4540.0 4562.4 4564.4 2759.0 2814.2 2831.6 2850.4 2854.9 900.3 920.3 933.4 958.4 964.9 10467.7 10743.8 10758.2 10780.6 10812.1 4067.3 4079.6 4204.1 4266.2 4267.6 9317.9 9323.2 9329.3 9348.1 9362.8 4648.5 4655.3 4659.7 4661.0 4661.9 3540.4 4187.4 4222.4 4245.3 4247.2 3577.0 3678.5 3735.7 3748.4 3804.3 1177.1 1195.5 1201.6 1206.3 1214.6 591.7 602.3 620.6 636.0 655.6 4794.5 4847.2 4857.6 4911.5 4930.5 853.2 855.7 873.2 876.4 883.0 3146.8 3180.5 3303.6 3500.2 3579.6 9681.4 9777.9 9859.4 9907.3 9940.7 9081.5 9812.6 9819.2 9842.0 9847.1 7195.4 7293.2 7337.0 7378.5 7393.7 5087.5 5155.4 5269.0 5397.1 5490.1 8686.4 9024.0 9026.2 9100.6 9122.5 8972.0 9262.3 9273.4 9280.2 9366.5 6211.3 6606.7 6818.2 6980.7 6991.6 7395.6 7601.0 7621.8 7691.3 7714.9 6700.9 6988.9 7042.0 7084.8 7163.3 6476.4 6546.0 6608.2 6658.4 6712.1 6007.9 6079.3 6091.8 6092.8 6095.6 4358.5 4445.2 4457.0 4497.5 4597.0 4539.7 4605.6 4610.9 4641.8 4698.8 13:27:36 INFO - PROCESS | 14323 | 13:27:36 INFO - PROCESS | 14323 | [#4] prototype.html Cycles:180 Average:4124.53 Median:4470.39 stddev:1179.26 (26.4%) stddev-sans-first:1146.87 13:27:36 INFO - PROCESS | 14323 | Values: 287.8 289.5 296.0 300.9 302.0 4814.4 4886.6 4889.6 4900.2 4911.1 4523.1 4655.4 4736.6 4739.7 4842.2 3757.8 3796.4 3799.6 3811.4 3859.5 3821.4 3825.6 3846.4 3857.6 3860.8 3581.9 3636.7 3739.3 3765.5 3773.5 3769.5 3772.9 3773.4 3775.4 3785.8 3350.3 3353.8 3363.6 3365.5 3368.3 4510.3 4712.9 4721.0 4725.9 4749.3 4294.8 4356.4 4366.4 4368.7 4387.5 5119.8 5124.5 5126.6 5132.1 5132.3 3591.6 3706.2 3712.3 3712.8 3716.9 5235.5 5260.6 5265.4 5265.6 5292.3 3749.5 3757.5 3766.8 3767.5 3768.2 3827.5 3828.7 3830.2 3830.8 3837.4 4217.8 4298.4 4343.4 4352.5 4357.6 5038.7 5071.2 5093.8 5103.8 5144.5 1261.5 1287.3 1336.8 1336.8 1349.1 903.3 907.1 927.4 930.8 937.3 4424.7 4435.1 4442.3 4460.2 4468.5 5146.3 5163.4 5190.2 5197.4 5201.0 4452.9 4459.7 4461.6 4464.6 4472.3 2317.9 2444.0 2448.8 2456.5 2465.3 4381.5 4385.7 4392.2 4405.7 4437.6 4670.7 4675.3 4701.0 4737.5 4762.8 4220.0 4305.0 4347.1 4378.8 4379.4 4584.6 4603.3 4616.0 4625.7 4633.9 4514.0 4519.5 4570.8 4574.3 4581.8 4331.5 4375.2 4575.7 4963.0 4964.6 3660.5 3661.7 3675.7 3695.4 3697.7 5035.8 5165.8 5210.1 5262.7 5266.2 4928.6 5004.5 5006.4 5011.6 5040.9 5041.9 5068.4 5088.8 5090.6 5136.4 4835.2 4963.1 4968.8 4985.8 5009.2 5086.9 5095.3 5095.9 5099.2 5125.2 4996.0 5002.1 5020.4 5027.9 5030.6 13:27:36 INFO - PROCESS | 14323 | 13:27:36 INFO - PROCESS | 14323 | [#5] yui.html Cycles:180 Average:16923.64 Median:31635.00 stddev:24770.59 (78.3%) stddev-sans-first:24809.72 13:27:36 INFO - PROCESS | 14323 | Values: 589.9 606.7 652.3 657.9 667.9 10794.7 11508.3 12206.8 12487.2 12577.7 12378.7 12884.0 12992.3 13112.9 13182.9 740.7 772.8 777.7 781.7 782.8 630.0 761.1 773.1 781.4 782.0 832.4 832.7 835.3 837.4 839.5 824.9 825.3 825.4 825.6 825.7 606.6 606.7 606.8 606.8 609.9 11607.4 11615.1 11651.5 11655.0 11665.9 12157.5 12390.1 12688.0 12841.2 12854.9 9423.3 9435.0 9486.5 9706.7 9890.6 3068.4 3094.1 3106.5 3119.5 3183.4 58958.1 59014.1 59528.4 60578.4 62640.0 9718.6 9724.2 9788.2 10028.8 10170.2 15880.7 16189.9 16225.4 16228.9 16273.3 6929.7 7014.4 7032.0 7070.5 7138.1 3631.6 3779.1 3807.3 3947.9 3984.6 2673.6 2750.9 2752.1 2762.6 2762.8 484.7 492.8 497.0 517.8 518.7 472.8 501.1 537.4 544.5 558.3 7564.3 7630.5 7875.4 7971.1 8074.8 481.2 525.7 551.2 555.5 565.0 3805.6 3871.0 3928.7 3932.1 4052.6 78597.0 96348.5 96978.2 100284.5 100791.0 71045.6 81573.2 81829.0 82526.0 82614.0 51550.5 68929.7 73281.3 74707.6 76763.2 7172.7 7642.1 7772.5 7829.2 7855.6 44921.3 45952.3 46737.0 47090.0 47106.3 63242.0 65123.0 65682.0 67111.3 67309.0 9233.0 9456.9 9522.1 9673.0 9741.9 10859.3 10870.2 10996.2 11182.8 11199.6 9392.8 9408.8 9685.8 9761.4 9781.7 9523.0 9891.6 10285.6 10336.5 10438.4 9647.1 9671.9 9889.9 9947.9 10251.7 8147.1 8229.1 8231.1 8253.0 8380.4 8236.3 8243.6 8329.1 8368.8 8462.7 13:27:36 INFO - PROCESS | 14323 | -------- Summary: end -------- 13:27:36 INFO - PROCESS | 14323 | 13:27:36 INFO - TEST-INFO | 14323: exit 0 13:27:36 INFO - TEST-OK | dromaeo_css | took 1120936ms 13:27:36 INFO - TEST-START | kraken 13:27:36 INFO - operating with platform_type : linux_ 13:27:36 INFO - Initialising browser for kraken test... 13:27:36 INFO - TEST-INFO | started process 14511 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8rqEXw/profile http://localhost:47528/getInfo.html) 13:27:41 INFO - PROCESS | 14511 | __metrics Screen width/height:1600/1200 13:27:41 INFO - PROCESS | 14511 | colorDepth:24 13:27:41 INFO - PROCESS | 14511 | Browser inner width/height: 1024/697 13:27:41 INFO - PROCESS | 14511 | __metrics 13:27:43 INFO - PROCESS | 14511 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:27:43 INFO - PROCESS | 14511 | console.error: PushService: 13:27:43 INFO - PROCESS | 14511 | stateChangeProcessEnqueue: Error transitioning state 13:27:43 INFO - PROCESS | 14511 | UnknownError 13:27:44 INFO - TEST-INFO | 14511: exit 0 13:27:44 INFO - Browser initialized. 13:27:44 INFO - Running cycle 1/1 for kraken test... 13:27:44 INFO - TEST-INFO | started process 14593 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8rqEXw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:27:56 INFO - PROCESS | 14593 | RSS: Main: 158203904 13:27:56 INFO - PROCESS | 14593 | 13:27:58 INFO - PROCESS | 14593 | Cycle 1(1): loaded http://localhost:47528/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47528/tests/kraken/driver.html?testName=audio-beat-detection) 13:27:59 INFO - PROCESS | 14593 | RSS: Main: 216330240 13:27:59 INFO - PROCESS | 14593 | 13:28:02 INFO - PROCESS | 14593 | Cycle 1(1): loaded http://localhost:47528/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47528/tests/kraken/driver.html?testName=audio-dft) 13:28:03 INFO - PROCESS | 14593 | RSS: Main: 206073856 13:28:03 INFO - PROCESS | 14593 | 13:28:06 INFO - PROCESS | 14593 | Cycle 1(1): loaded http://localhost:47528/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47528/tests/kraken/driver.html?testName=audio-fft) 13:28:06 INFO - PROCESS | 14593 | RSS: Main: 271781888 13:28:06 INFO - PROCESS | 14593 | 13:28:09 INFO - PROCESS | 14593 | Cycle 1(1): loaded http://localhost:47528/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47528/tests/kraken/driver.html?testName=audio-oscillator) 13:28:09 INFO - PROCESS | 14593 | RSS: Main: 181911552 13:28:09 INFO - PROCESS | 14593 | 13:28:11 INFO - PROCESS | 14593 | Cycle 1(1): loaded http://localhost:47528/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47528/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:28:12 INFO - PROCESS | 14593 | RSS: Main: 186638336 13:28:12 INFO - PROCESS | 14593 | 13:28:15 INFO - PROCESS | 14593 | Cycle 1(1): loaded http://localhost:47528/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47528/tests/kraken/driver.html?testName=imaging-darkroom) 13:28:16 INFO - PROCESS | 14593 | RSS: Main: 222433280 13:28:16 INFO - PROCESS | 14593 | 13:28:19 INFO - PROCESS | 14593 | Cycle 1(1): loaded http://localhost:47528/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47528/tests/kraken/driver.html?testName=imaging-desaturate) 13:28:20 INFO - PROCESS | 14593 | RSS: Main: 218513408 13:28:20 INFO - PROCESS | 14593 | 13:28:23 INFO - PROCESS | 14593 | Cycle 1(1): loaded http://localhost:47528/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47528/tests/kraken/driver.html?testName=json-parse-financial) 13:28:23 INFO - PROCESS | 14593 | RSS: Main: 221028352 13:28:23 INFO - PROCESS | 14593 | 13:28:25 INFO - PROCESS | 14593 | Cycle 1(1): loaded http://localhost:47528/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47528/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:28:26 INFO - PROCESS | 14593 | RSS: Main: 206725120 13:28:26 INFO - PROCESS | 14593 | 13:28:28 INFO - PROCESS | 14593 | Cycle 1(1): loaded http://localhost:47528/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47528/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:28:28 INFO - PROCESS | 14593 | RSS: Main: 213487616 13:28:28 INFO - PROCESS | 14593 | 13:28:30 INFO - PROCESS | 14593 | Cycle 1(1): loaded http://localhost:47528/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47528/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:28:31 INFO - PROCESS | 14593 | RSS: Main: 211574784 13:28:31 INFO - PROCESS | 14593 | 13:28:34 INFO - PROCESS | 14593 | Cycle 1(1): loaded http://localhost:47528/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47528/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:28:35 INFO - PROCESS | 14593 | RSS: Main: 225837056 13:28:35 INFO - PROCESS | 14593 | 13:28:37 INFO - PROCESS | 14593 | Cycle 1(1): loaded http://localhost:47528/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47528/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:28:38 INFO - PROCESS | 14593 | RSS: Main: 224092160 13:28:38 INFO - PROCESS | 14593 | 13:28:40 INFO - PROCESS | 14593 | Cycle 1(1): loaded http://localhost:47528/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47528/tests/kraken/driver.html?testName=ai-astar) 13:28:40 INFO - PROCESS | 14593 | RSS: Main: 266104832 13:28:40 INFO - PROCESS | 14593 | 13:28:40 INFO - PROCESS | 14593 | __start_tp_report 13:28:40 INFO - PROCESS | 14593 | _x_x_mozilla_page_load 13:28:40 INFO - PROCESS | 14593 | _x_x_mozilla_page_load_details 13:28:40 INFO - PROCESS | 14593 | |i|pagename|runs| 13:28:40 INFO - PROCESS | 14593 | |0;ai-astar;107;116;114;114;115;117;114;114;116;115 13:28:40 INFO - PROCESS | 14593 | |1;audio-beat-detection;159;130;124;175;124;124;154;122;165;123 13:28:40 INFO - PROCESS | 14593 | |2;audio-dft;161;166;174;162;162;162;162;163;163;162 13:28:40 INFO - PROCESS | 14593 | |3;audio-fft;75;75;77;121;80;76;75;76;99;75 13:28:40 INFO - PROCESS | 14593 | |4;audio-oscillator;85;86;122;86;85;85;123;85;85;129 13:28:40 INFO - PROCESS | 14593 | |5;imaging-gaussian-blur;117;117;117;117;116;116;116;117;117;117 13:28:40 INFO - PROCESS | 14593 | |6;imaging-darkroom;146;146;146;146;146;146;147;146;146;146 13:28:40 INFO - PROCESS | 14593 | |7;imaging-desaturate;94;95;95;95;95;95;94;95;94;94 13:28:40 INFO - PROCESS | 14593 | |8;json-parse-financial;65;64;64;65;65;65;65;65;63;64 13:28:40 INFO - PROCESS | 14593 | |9;json-stringify-tinderbox;64;64;64;64;65;65;64;65;66;64 13:28:40 INFO - PROCESS | 14593 | |10;stanford-crypto-aes;78;77;87;80;78;78;77;84;78;82 13:28:40 INFO - PROCESS | 14593 | |11;stanford-crypto-ccm;133;131;131;129;131;126;132;138;204;130 13:28:40 INFO - PROCESS | 14593 | |12;stanford-crypto-pbkdf2;168;170;165;175;170;167;165;165;167;166 13:28:40 INFO - PROCESS | 14593 | |13;stanford-crypto-sha256-iterative;68;68;67;68;66;76;67;65;67;67 13:28:40 INFO - PROCESS | 14593 | __end_tp_report 13:28:40 INFO - PROCESS | 14593 | __start_cc_report 13:28:40 INFO - PROCESS | 14593 | _x_x_mozilla_cycle_collect,1913 13:28:40 INFO - PROCESS | 14593 | __end_cc_report 13:28:40 INFO - PROCESS | 14593 | __startTimestamp1467232120522__endTimestamp 13:28:40 INFO - PROCESS | 14593 | 13:28:40 INFO - PROCESS | 14593 | ------- Summary: start ------- 13:28:40 INFO - PROCESS | 14593 | Number of tests: 14 13:28:40 INFO - PROCESS | 14593 | 13:28:40 INFO - PROCESS | 14593 | [#0] ai-astar Cycles:10 Average:114.20 Median:115.00 stddev:2.74 (2.4%) stddev-sans-first:1.12 13:28:40 INFO - PROCESS | 14593 | Values: 107.0 116.0 114.0 114.0 115.0 117.0 114.0 114.0 116.0 115.0 13:28:40 INFO - PROCESS | 14593 | 13:28:40 INFO - PROCESS | 14593 | [#1] audio-beat-detection Cycles:10 Average:140.00 Median:142.00 stddev:20.78 (14.6%) stddev-sans-first:20.88 13:28:40 INFO - PROCESS | 14593 | Values: 159.0 130.0 124.0 175.0 124.0 124.0 154.0 122.0 165.0 123.0 13:28:40 INFO - PROCESS | 14593 | 13:28:40 INFO - PROCESS | 14593 | [#2] audio-dft Cycles:10 Average:163.70 Median:162.50 stddev:3.86 (2.4%) stddev-sans-first:3.97 13:28:40 INFO - PROCESS | 14593 | Values: 161.0 166.0 174.0 162.0 162.0 162.0 162.0 163.0 163.0 162.0 13:28:40 INFO - PROCESS | 14593 | 13:28:40 INFO - PROCESS | 14593 | [#3] audio-fft Cycles:10 Average:82.90 Median:76.00 stddev:15.27 (20.1%) stddev-sans-first:15.93 13:28:40 INFO - PROCESS | 14593 | Values: 75.0 75.0 77.0 121.0 80.0 76.0 75.0 76.0 99.0 75.0 13:28:40 INFO - PROCESS | 14593 | 13:28:40 INFO - PROCESS | 14593 | [#4] audio-oscillator Cycles:10 Average:97.10 Median:85.00 stddev:19.11 (22.5%) stddev-sans-first:19.76 13:28:40 INFO - PROCESS | 14593 | Values: 85.0 86.0 122.0 86.0 85.0 85.0 123.0 85.0 85.0 129.0 13:28:40 INFO - PROCESS | 14593 | 13:28:40 INFO - PROCESS | 14593 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 13:28:40 INFO - PROCESS | 14593 | Values: 117.0 117.0 117.0 117.0 116.0 116.0 116.0 117.0 117.0 117.0 13:28:40 INFO - PROCESS | 14593 | 13:28:40 INFO - PROCESS | 14593 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 13:28:40 INFO - PROCESS | 14593 | Values: 146.0 146.0 146.0 146.0 146.0 146.0 147.0 146.0 146.0 146.0 13:28:40 INFO - PROCESS | 14593 | 13:28:40 INFO - PROCESS | 14593 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 13:28:40 INFO - PROCESS | 14593 | Values: 94.0 95.0 95.0 95.0 95.0 95.0 94.0 95.0 94.0 94.0 13:28:40 INFO - PROCESS | 14593 | 13:28:40 INFO - PROCESS | 14593 | [#8] json-parse-financial Cycles:10 Average:64.50 Median:65.00 stddev:0.71 (1.1%) stddev-sans-first:0.73 13:28:40 INFO - PROCESS | 14593 | Values: 65.0 64.0 64.0 65.0 65.0 65.0 65.0 65.0 63.0 64.0 13:28:40 INFO - PROCESS | 14593 | 13:28:40 INFO - PROCESS | 14593 | [#9] json-stringify-tinderbox Cycles:10 Average:64.50 Median:64.50 stddev:0.71 (1.1%) stddev-sans-first:0.73 13:28:40 INFO - PROCESS | 14593 | Values: 64.0 64.0 64.0 64.0 65.0 65.0 64.0 65.0 66.0 64.0 13:28:40 INFO - PROCESS | 14593 | 13:28:40 INFO - PROCESS | 14593 | [#10] stanford-crypto-aes Cycles:10 Average:79.90 Median:79.00 stddev:3.38 (4.3%) stddev-sans-first:3.52 13:28:40 INFO - PROCESS | 14593 | Values: 78.0 77.0 87.0 80.0 78.0 78.0 77.0 84.0 78.0 82.0 13:28:40 INFO - PROCESS | 14593 | 13:28:40 INFO - PROCESS | 14593 | [#11] stanford-crypto-ccm Cycles:10 Average:138.50 Median:131.50 stddev:23.22 (17.7%) stddev-sans-first:24.54 13:28:40 INFO - PROCESS | 14593 | Values: 133.0 131.0 131.0 129.0 131.0 126.0 132.0 138.0 204.0 130.0 13:28:40 INFO - PROCESS | 14593 | 13:28:40 INFO - PROCESS | 14593 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.80 Median:167.50 stddev:3.16 (1.9%) stddev-sans-first:3.35 13:28:40 INFO - PROCESS | 14593 | Values: 168.0 170.0 165.0 175.0 170.0 167.0 165.0 165.0 167.0 166.0 13:28:40 INFO - PROCESS | 14593 | 13:28:40 INFO - PROCESS | 14593 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:67.50 stddev:3.00 (4.4%) stddev-sans-first:3.18 13:28:40 INFO - PROCESS | 14593 | Values: 68.0 68.0 67.0 68.0 66.0 76.0 67.0 65.0 67.0 67.0 13:28:40 INFO - PROCESS | 14593 | -------- Summary: end -------- 13:28:40 INFO - PROCESS | 14593 | 13:28:41 INFO - TEST-INFO | 14593: exit 0 13:28:41 INFO - TEST-OK | kraken | took 65064ms 13:28:41 INFO - SUITE-END | took 1186s 13:28:42 INFO - Completed test suite (00:19:46) 13:28:42 INFO - javascript benchmark 13:28:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2629.460960503097, 2647.457271259392, 2651.072124756335, 2684.4899469100883, 2697.649305590273, 4641.071785642868, 4728.692634978724, 4788.114198873211, 4805.375301210842, 4824.710517368961, 4759.309900064497, 4760.8333708320215, 4763.595094416979, 4802.639802014845, 4815.133276010317, 4312.05134870328, 4366.628836548897, 4391.231534481469, 4425.557444255564, 4585.037142200142, 4484.148011877749, 4524.095180963804, 4542.727436353813, 4556.20266453371, 4574.428196475441, 4277.123189746095, 4334.544872788343, 4335.739855608674, 4388.736675799462, 4393.604575588212, 4338.2191205582985, 4359.106383191438, 4373.103513779699, 4417.845375411845, 4428.911421771547, 4376.190404775127, 4401.581849724271, 4410.572240158796, 4447.3996010538485, 4452.131834292314, 4663.044075964419, 4721.150192965265, 4754.833580824655, 4800.375951126366, 4807.61539076873, 5188.948110518922, 5191.402988656315, 5197.376314842205, 5203.193505006692, 5208.635395522315, 5188.6367954243215, 5200.765965531522, 5224.39919409269, 5231.764570594294, 5238.816641417532, 4667.743274119888, 4726.645501587394, 4779.593734532534, 4801.15979703554, 4803.735794531264, 5322.414534401213, 5329.813456529003, 5334.813281535127, 5339.359276886721, 5343.171808369709, 5068.138416469209, 5092.668976516515, 5117.488251174927, 5119.3088932994315, 5122.487751224848, 4994.2508623706735, 5017.523335283142, 5064.772085256172, 5072.239164125411, 5142.228665700175, 5014.423341315795, 5032.84901452957, 5041.369828771403, 5043.974780126149, 5091.08360495107, 4843.515648435128, 5009.073321435546, 5012.67417617861, 5014.147594908802, 5020.422651395063, 4322.848700295474, 4362.585554372329, 4367.912641747147, 4369.148016136886, 4419.9779001105435, 3785.280796648628, 3800.239952009609, 3803.144292534213, 3841.2317536492255, 3843.327417701891, 4303.591158839905, 4400.9559904401185, 4410.095930334273, 4454.955450445519, 4459.152760975404, 5158.871028224249, 5180.326557547494, 5188.351456067991, 5210.088234558937, 5214.2960700304975, 4403.713758605681, 4431.556844315607, 4437.334399839985, 4458.687891847604, 4480.260756975128, 4486.3494793254795, 4532.592066713945, 4668.976655116703, 4671.6262698984, 4703.0593881223895, 4759.7858096386435, 4777.0684716479955, 4786.880327991828, 4799.400074990626, 4833.492483289345, 5095.745212739274, 5097.235414687678, 5098.898022039612, 5102.107131251942, 5132.409772876167, 4664.533546645308, 4788.209945358977, 4835.903281934271, 4849.369581954324, 4887.780049897834, 5007.949920500894, 5046.798128074836, 5058.140116180185, 5060.949390506048, 5101.46434624374, 5122.103631864335, 5136.178211486144, 5142.305788718625, 5144.151215049475, 5176.352955880515, 4845.685030473008, 4929.211326187793, 4946.480619535041, 4979.3526841510375, 4990.725510096834, 4969.652124351405, 4982.676126051795, 4996.60027197816, 5000.749962501933, 5047.2681461187185, 4862.440819305825, 4888.706677599355, 4895.681780684244, 4943.30793688891, 4948.8762780930765, 4899.11815873132, 5004.249362595494, 5046.444891062054, 5050.368703912011, 5068.0, 4940.92588611164, 4952.10862044821, 4984.800607975785, 4992.650514463952, 5033.245013248042], "value": 4704.727219915089, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [578.7395671947623, 586.3989410853874, 592.8310431527016, 594.708592789533, 601.3505414152716, 26581.202563923063, 38979.220415591706, 40340.39489407661, 40644.59355406445, 44258.33612495815, 41135.794321028356, 41456.792716036376, 41583.37624935628, 41634.58365416345, 41674.79162604183, 7421.2949769771785, 7778.027746531669, 7922.326602238788, 7925.722599709012, 7927.920720792805, 10042.648507302245, 10294.794104117913, 10329.070383665468, 10695.46522673867, 10696.0, 10193.694189174299, 10284.074433301, 10296.742581435486, 10307.587696492168, 10309.123724483428, 7368.336849683501, 10000.549975251131, 10133.08802207801, 10195.1843852492, 10288.948555257251, 10049.748756281078, 10068.29521933465, 10114.44370559619, 10127.645532406405, 10130.392176469435, 38285.80857095725, 38608.71825894802, 38641.42037869434, 38755.612443875485, 38855.0, 3016.622922134733, 3034.7723920705816, 3055.8624861881044, 3212.2932954749917, 3305.586801649794, 29285.41429171426, 29685.109446716633, 29894.0, 30229.546556801666, 30751.692483075105, 3397.303552771676, 3435.2270739083506, 3437.1063523483826, 3440.17435815405, 3463.792172469635, 244111.0, 244887.0, 245903.0, 245995.0, 247823.0, 31822.522662160085, 50854.49145508498, 51001.489985100416, 51075.74462127666, 51159.0, 31987.840060799546, 33809.661903381144, 33899.322013560086, 33964.66035339664, 34002.0, 13631.591052268448, 13856.93071534656, 13860.861391386159, 13866.65333366674, 13874.167549947035, 10390.896091038992, 10642.521086551124, 10883.292585981886, 10887.401192934307, 11399.202055856176, 7914.327282181079, 7918.722844700408, 7946.0, 7993.160718124629, 7993.640286187136, 3085.460044492205, 3184.3153721949893, 3186.87252509897, 3208.422483952911, 3231.9838400808317, 872.5951218538148, 874.213208112691, 904.1997831918668, 942.3074040580168, 1031.0823367203195, 27612.0, 28108.85945570259, 28145.43709125806, 28276.293092672848, 28997.710022899922, 979.5755505124902, 987.3286165407449, 1028.6619918364954, 1031.8452232165234, 1034.9379037257788, 14499.92750036243, 14644.341004654816, 14853.2573371331, 15155.166465844484, 15262.0, 370089.0, 370123.0, 373348.0, 374389.0, 375924.0, 48244.03511929742, 48576.757116214896, 48683.0, 48733.26900096501, 48748.5125148751, 1090.6346373964652, 1175.5591653130077, 1208.4139192491634, 1209.2079687804503, 1210.9636710898687, 27539.862300688368, 29042.27394315159, 29176.416471670873, 29369.0, 29828.552571711007, 41427.37858932179, 42000.57999419967, 42005.57994420139, 42013.0, 42031.57968420276, 294018.0, 298998.0, 299469.0, 300215.0, 300273.0, 22152.778472215716, 24074.27777166688, 24704.629430558914, 25005.374865628506, 26820.329491762863, 42192.578074220095, 42201.36697949472, 42282.0, 43097.0, 43234.35148472712, 34624.0, 35997.0, 36718.44922326114, 36754.8162259187, 37108.0, 36598.817005915866, 36964.44553331756, 37168.25663486769, 37212.44181337336, 37266.8136659315, 35364.64635353613, 35730.0, 37250.44124338083, 37354.252914942095, 40010.599894001854, 29659.851700741357, 31774.523382148825, 31775.841120794248, 32199.67800321967, 32330.676693232766, 25380.365490862878, 25549.61675574905, 25697.871510642326, 25864.094756683426, 25922.949469694624], "value": 16953.183219304196, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [338.9186595217146, 366.59857456085587, 366.8532586965212, 371.4354181643901, 386.17358852056606, 13188.208707477546, 16588.834111658878, 17007.404740834074, 18386.172622232, 18396.999999999967, 17371.47885563432, 17725.37961171356, 17879.374221902235, 18211.90894045528, 18525.888446693207, 4793.6884102533395, 5129.410117836441, 5131.820386286481, 5134.717590532519, 5136.820211292606, 3738.1776009277914, 5071.2139618359215, 5742.885142297151, 6037.969810150965, 6038.064100064497, 6075.726592303335, 6086.726097325631, 6105.572609917285, 6107.114468402079, 6113.449789518964, 5066.569341605968, 5346.518813306782, 5377.838664840061, 5432.402435732066, 5442.836714898559, 3397.0827876473213, 4961.801527938878, 5255.237990491358, 5270.6837589744355, 5293.23248129023, 12091.516339346415, 12119.212251203731, 12228.694282642917, 12326.32205228712, 12458.377081145996, 1854.805245449222, 2137.390843609564, 2270.4096934796908, 2316.6409206573007, 2339.894704738291, 9311.5809788559, 9506.762330941712, 13074.280914549696, 13271.535496257682, 13906.235157066358, 1771.7253825657044, 1783.9464816055408, 1785.4554360919915, 1808.882422642524, 1820.7906090799595, 68160.0, 69625.30374696238, 70620.0, 71271.0, 71952.64023679901, 8732.301415886714, 9123.0, 9457.38526995743, 9700.805983880424, 10349.896501035044, 11951.940240298743, 12682.619521414372, 12692.6038135805, 13148.802767958488, 13217.537386191629, 5428.728563571805, 7074.858502829915, 7307.794213954744, 7441.330280274801, 7619.238076192447, 7171.92828071723, 7282.089738782653, 7290.671919763623, 7321.487495875238, 7378.40972722181, 4086.468759061303, 4139.0, 4157.251694694984, 4237.300845360481, 4520.59314661682, 1789.2216885654782, 1834.523024013766, 1844.3729132094884, 1868.23402405016, 1888.7733471983174, 794.4557977785236, 812.8171161488737, 828.1304630138451, 847.741438861141, 851.9403641745142, 16684.0, 17351.566210844576, 17539.82460175382, 17653.20560574777, 18086.366977155736, 824.2664029014182, 840.6343240690319, 846.094678693804, 892.7143314139413, 901.2609660078804, 6652.866942661217, 9637.662681806103, 9658.517074146264, 9729.902700973042, 9810.460424676712, 407412.0, 409621.0, 412739.0, 415180.0, 415984.0, 81907.5904620485, 82959.0, 83135.16864831395, 83877.58061209776, 84109.57945210235, 875.868619707049, 891.6299735609779, 892.1836519584507, 894.4767311122936, 897.2552781191596, 14468.27658617086, 15312.081275123528, 15433.768493472831, 15572.92213538925, 15619.219039047775, 29332.560011599417, 32660.673393265763, 38074.8096259528, 38581.807090964365, 39170.4124438128, 51025.48974510207, 52595.21107183472, 53165.4683453176, 53197.0, 53330.0, 7316.597587132759, 7320.816979575553, 7372.447066469929, 7376.96311518439, 7457.328840404172, 9646.710598682052, 10911.672649820519, 11390.601328953448, 11393.430328483708, 11775.941120294343, 9270.907290927003, 9368.156865882103, 9478.668246611336, 9623.615055397706, 9637.18083962871, 9400.717978460658, 9527.237820974444, 9983.900160998297, 10320.225983051452, 10356.792864142826, 9412.247020238228, 9487.146156845916, 9640.662576809778, 9755.707328780149, 9778.706638800848, 6478.0, 7434.516756410816, 7500.474966752275, 7506.361959233526, 7798.727044553413, 8879.200871921557, 9080.182783549511, 9116.680916167903, 9354.204892584206, 9769.56036978352], "value": 8067.958273041668, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1240.193873981912, 1288.9871101288984, 1311.272243904633, 1608.541565653789, 1640.876934229933, 7565.4704170708, 7994.440389172761, 8078.0, 8080.555569443693, 8099.109097999215, 6793.830154246146, 6998.370146686797, 7006.754763583275, 7218.314260145291, 7917.802054948615, 1928.5467915039953, 2097.905594248255, 2186.5189658275235, 2190.76996915324, 2192.6491761318193, 2218.4010317214343, 2222.9888850555726, 2244.4164517225477, 2247.0337754765446, 2291.9083236670513, 1922.5866438715673, 2118.33272519156, 2217.589745897006, 2240.2383189715574, 2243.2821497120926, 2198.362474882282, 2239.85440946338, 2240.8767517786514, 2242.6075436798496, 2244.2706120510734, 2116.407405926343, 2118.925837595677, 2132.051237199447, 2171.0447403142566, 2171.3485954213675, 7872.645730942121, 7889.329407000412, 7895.447318687694, 7914.0503139623615, 7932.365410767125, 4404.22925987954, 4496.055828276066, 4539.954600454019, 4562.406887104655, 4564.360989461478, 2759.0059199928287, 2814.1698199031334, 2831.589419534156, 2850.3586692994118, 2854.9143525694262, 900.342749792655, 920.3005715656083, 933.4072863731511, 958.434523631054, 964.9179819715332, 10467.738306542322, 10743.838842417448, 10758.246922715412, 10780.5687772489, 10812.080973117294, 4067.2678917794487, 4079.632833044981, 4204.087140351133, 4266.189424009428, 4267.637250833714, 9317.906820931705, 9323.160915517636, 9329.346945713734, 9348.1119293667, 9362.812743745088, 4648.488666246778, 4655.348251244828, 4659.720416774937, 4661.044485880387, 4661.906761864744, 3540.3804334241404, 4187.434696315959, 4222.366645003274, 4245.341971994346, 4247.193033323659, 3576.9821150894077, 3678.521792167001, 3735.7198210134347, 3748.437734339871, 3804.3152232597845, 1177.1053998960851, 1195.5217912834762, 1201.597464849268, 1206.330486579939, 1214.6477521518661, 591.6716222496556, 602.3284038297267, 620.6090163197157, 635.9523035772336, 655.5902560899438, 4794.496577859344, 4847.200211965057, 4857.635677324144, 4911.50884911506, 4930.531599498042, 853.159637756809, 855.6876739989983, 873.2010210657304, 876.412803421709, 883.0463099852144, 3146.8269245191277, 3180.538821870862, 3303.6035675719068, 3500.1599616092462, 3579.570451545831, 9681.37071090391, 9777.902220977841, 9859.35914165577, 9907.25695572835, 9940.652077177409, 9081.54592270384, 9812.558434870305, 9819.165370943407, 9842.0, 9847.113759761656, 7195.388391986635, 7293.16128645202, 7337.0, 7378.483506154625, 7393.704251829867, 5087.491250874883, 5155.355580552431, 5268.9736551317, 5397.136458166831, 5490.0941344677685, 8686.435381700168, 9024.0, 9026.232770214605, 9100.590473428843, 9122.498262595356, 8971.955140224258, 9262.30532710036, 9273.350865439625, 9280.164785169367, 9366.484843333683, 6211.3478084800445, 6606.735730570916, 6818.249992500721, 6980.685869136003, 6991.615461149686, 7395.556266624019, 7601.0, 7621.847563048597, 7691.346235570039, 7714.884276735741, 6700.899486507804, 6988.860222795414, 7042.049323341488, 7084.822879428056, 7163.31948464895, 6476.417122459001, 6546.0, 6608.207015158212, 6658.400743933069, 6712.127423434922, 6007.909881351696, 6079.270487541523, 6091.817245482643, 6092.817215483543, 6095.634261944298, 4358.476982761962, 4445.222086134978, 4457.0, 4497.460304763449, 4597.0, 4539.6822222445435, 4605.585497305258, 4610.861674149781, 4641.814327426865, 4698.765061746831], "value": 4090.002551193515, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [287.8359335178949, 289.4789379117588, 295.9862471036699, 300.92777733344, 302.01542969918074, 4814.4222693276815, 4886.63350248731, 4889.559939605435, 4900.191468407713, 4911.115999120157, 4523.117991991555, 4655.394798676176, 4736.59738922192, 4739.653871333686, 4842.24945133504, 3757.7745335279833, 3796.3925771876507, 3799.563050249229, 3811.3520701480675, 3859.4982652255308, 3821.3503704370187, 3825.6365645263654, 3846.384578467446, 3857.633524815138, 3860.7838530862828, 3581.874634387797, 3636.672699457048, 3739.3456145174487, 3765.491658626078, 3773.5094437723055, 3769.491118698968, 3772.886813395589, 3773.433984902259, 3775.4336849472525, 3785.848566057354, 3350.2629421527467, 3353.7987720736833, 3363.596368435779, 3365.528825964367, 3368.326334733063, 4510.323451482271, 4712.858614241544, 4720.976395118037, 4725.881852953669, 4749.316636100592, 4294.828206871722, 4356.386168299027, 4366.410534577855, 4368.737875727466, 4387.4954380246045, 5119.8208062717995, 5124.538791508782, 5126.61550383719, 5132.0505706444055, 5132.307138536287, 3591.586967498745, 3706.240220754739, 3712.2761061593, 3712.832922518493, 3716.9070773230887, 5235.528802407764, 5260.605454590883, 5265.420803711589, 5265.552428043621, 5292.311999440049, 3749.4563288323584, 3757.492738480325, 3766.773993560395, 3767.4913886625504, 3768.1521657626813, 3827.4641550182996, 3828.693704503633, 3830.199806091133, 3830.751001184914, 3837.4435706822915, 4217.768022758716, 4298.398224248608, 4343.4146536513945, 4352.455943007124, 4357.607815296638, 5038.748062596856, 5071.2139618359215, 5093.796248150106, 5103.795848166106, 5144.530625299877, 1261.4701825233424, 1287.2598256002836, 1336.7927971164486, 1336.7994800779961, 1349.089364678838, 903.304455569208, 907.1427501011613, 927.3647551427293, 930.7533503621546, 937.2689302344182, 4424.73451592899, 4435.068635586498, 4442.267025940748, 4460.174867649495, 4468.50846406895, 5146.279520867081, 5163.380394352702, 5190.235319991221, 5197.402298735618, 5200.97399513, 4452.888677783081, 4459.732416055047, 4461.598456138898, 4464.55354464551, 4472.262076757299, 2317.9188728394424, 2444.0081333712965, 2448.8408253463467, 2456.484138330935, 2465.3220364399936, 4381.539938306432, 4385.693001489929, 4392.231359512072, 4405.73104851002, 4437.5784300491405, 4670.743109128963, 4675.275332323496, 4700.976495117503, 4737.549932756383, 4762.78567464465, 4219.952036934508, 4305.031367942251, 4347.108842687241, 4378.81771921573, 4379.386885835986, 4584.587387135174, 4603.273772335374, 4615.953840461552, 4625.699329543703, 4633.884152896205, 4513.977430112828, 4519.502854685916, 4570.771461426849, 4574.290984897346, 4581.823633773931, 4331.523532411496, 4375.1905897407805, 4575.679702420799, 4962.975185124052, 4964.624055642198, 3660.469231961404, 3661.7253705971625, 3675.650813172744, 3695.3533131701306, 3697.741158118906, 5035.7985680572365, 5165.7933682653775, 5210.14032684618, 5262.657927234717, 5266.2363957225225, 4928.630352723489, 5004.549590536869, 5006.374203224597, 5011.624128190473, 5040.899182016413, 5041.873953151201, 5068.417132029864, 5088.796448142033, 5090.574639101058, 5136.383633963799, 4835.20219163834, 4963.138822941397, 4968.751562421792, 4985.775640096132, 5009.198528235464, 5086.872828179326, 5095.312132862016, 5095.949040509548, 5099.23511473282, 5125.231215317732, 4995.950040499549, 5002.099622068063, 5020.3724534433195, 5027.874303142451, 5030.5975521957425], "value": 3755.059254257137, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [589.9262592175977, 606.7330374635162, 652.3183273479214, 657.9407154481287, 667.8630880669464, 10794.676159715202, 11508.25196362237, 12206.81689774653, 12487.188332758387, 12577.685557861058, 12378.690532736686, 12884.03369747268, 12992.285424301659, 13112.868871311308, 13182.934085329583, 740.7259314053795, 772.8415674786655, 777.7005852746705, 781.7420251317052, 782.7690831204808, 629.9968500157493, 761.113303002002, 773.091617349612, 781.4490783997296, 782.0185666987923, 832.4089896173724, 832.6919039955225, 835.3484282259847, 837.409626213521, 839.4669384940577, 824.9422540422173, 825.3479750996736, 825.3933358981144, 825.591332290517, 825.6986200037003, 606.5966132521868, 606.7118118893534, 606.754264522869, 606.7906572232573, 609.9359567245419, 11607.4196290186, 11615.070794336432, 11651.475683594173, 11655.0, 11665.941670291679, 12157.452914618863, 12390.132690711655, 12688.0, 12841.165324253894, 12854.871451285555, 9423.293253006052, 9434.952825235898, 9486.478243696594, 9706.72926291916, 9890.604375824958, 3068.4170007698467, 3094.087244262948, 3106.48742957414, 3119.4540955332727, 3183.3792410479964, 58958.11562826561, 59014.11478827821, 59528.404715953155, 60578.39421605771, 62640.0, 9718.562664680107, 9724.17344525709, 9788.21694264457, 10028.849567256497, 10170.186385089175, 15880.682386352439, 16189.919050404673, 16225.350985960666, 16228.918855405884, 16273.267702953395, 6929.68816403253, 7014.438844892396, 7031.964840175767, 7070.5404148731195, 7138.072050633385, 3631.618680038611, 3779.149691319486, 3807.333716599584, 3947.9013024674614, 3984.621460961262, 2673.612326212727, 2750.876210570489, 2752.1193218170392, 2762.6270453488924, 2762.7927905407173, 484.6922204400231, 492.7905640102942, 497.0233491189757, 517.7592419524939, 518.7198912587236, 472.7825200407782, 501.08551892795066, 537.4061661863584, 544.4854612391331, 558.3076984539142, 7564.319211271012, 7630.465867389341, 7875.409344299201, 7971.083325417535, 8074.7577572671735, 481.2228251374006, 525.747641132251, 551.2295896070815, 555.4584280326649, 565.0223323087389, 3805.562360328542, 3870.9806450967567, 3928.6660633846445, 3932.134930315326, 4052.5744796796503, 78597.0, 96348.51825740826, 96978.21152519256, 100284.4985775081, 100791.0, 71045.64477177581, 81573.18426815656, 81829.0, 82526.0, 82614.0, 51550.48449515532, 68929.65535172392, 73281.26718732744, 74707.62646186844, 76763.2323676756, 7172.677229524788, 7642.08295004603, 7772.533647981139, 7829.177936316605, 7855.646495907584, 44921.32618010798, 45952.31071533863, 46737.0, 47090.0, 47106.29340559963, 63242.0, 65123.0, 65682.0, 67111.32888671051, 67309.0, 9233.0, 9456.858147127661, 9522.143007129114, 9672.95163524178, 9741.9025809741, 10859.294145880493, 10870.184736144978, 10996.175286853679, 11182.776344472903, 11199.60801371948, 9392.812143757223, 9408.811823763623, 9685.806283874143, 9761.414315141114, 9781.706548803548, 9523.0, 9891.554880030271, 10285.588576456857, 10336.534855931352, 10438.402939326508, 9647.083527064917, 9671.854922176033, 9889.901100988898, 9947.850782238127, 10251.7437064074, 8147.14454982242, 8229.135940726377, 8231.09457959636, 8252.958735206286, 8380.371472139735, 8236.299914507334, 8243.629036693243, 8329.12544182852, 8368.83262334762, 8462.661493540436], "value": 6161.087314747324, "unit": "score"}], "name": "dromaeo_css", "value": 6272.383739300769, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 116.0, 114.0, 114.0, 115.0, 117.0, 114.0, 114.0, 116.0, 115.0], "value": 114.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 130.0, 124.0, 175.0, 124.0, 124.0, 154.0, 122.0, 165.0, 123.0], "value": 140.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 166.0, 174.0, 162.0, 162.0, 162.0, 162.0, 163.0, 163.0, 162.0], "value": 163.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 77.0, 121.0, 80.0, 76.0, 75.0, 76.0, 99.0, 75.0], "value": 82.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 122.0, 86.0, 85.0, 85.0, 123.0, 85.0, 85.0, 129.0], "value": 97.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 116.0, 116.0, 116.0, 117.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 94.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 64.0, 65.0, 65.0, 65.0, 65.0, 65.0, 63.0, 64.0], "value": 64.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 64.0, 65.0, 65.0, 64.0, 65.0, 66.0, 64.0], "value": 64.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 77.0, 87.0, 80.0, 78.0, 78.0, 77.0, 84.0, 78.0, 82.0], "value": 79.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 131.0, 131.0, 129.0, 131.0, 126.0, 132.0, 138.0, 204.0, 130.0], "value": 138.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 170.0, 165.0, 175.0, 170.0, 167.0, 165.0, 165.0, 167.0, 166.0], "value": 167.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 67.0, 68.0, 66.0, 76.0, 67.0, 65.0, 67.0, 67.0], "value": 67.9, "unit": "score"}], "name": "kraken", "value": 1538.4000000000003, "alertThreshold": 2.0}]} 13:28:42 INFO - Return code: 0 13:28:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:28:42 INFO - # TBPL SUCCESS # 13:28:42 INFO - Running post-action listener: _resource_record_post_action 13:28:42 INFO - ##### 13:28:42 INFO - ##### Finished run-tests step (success) 13:28:42 INFO - ##### 13:28:42 INFO - Running post-run listener: _resource_record_post_run 13:28:42 INFO - Total resource usage - Wall time: 1206s; CPU: 13.0%; Read bytes: 0; Write bytes: 553791488; Read time: 0; Write time: 1626516 13:28:42 INFO - TinderboxPrint: CPU usage
13.1% 13:28:42 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 13:28:42 INFO - TinderboxPrint: I/O write bytes / time
553,791,488 / 1,626,516 13:28:42 INFO - TinderboxPrint: CPU idle
8,361.2 (86.8%) 13:28:42 INFO - TinderboxPrint: CPU user
1,206.5 (12.5%) 13:28:42 INFO - TinderboxPrint: Swap in / out
0 / 0 13:28:42 INFO - install - Wall time: 20s; CPU: 18.0%; Read bytes: 0; Write bytes: 262152192; Read time: 0; Write time: 1119532 13:28:42 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 0; Write bytes: 291209216; Read time: 0; Write time: 506984 13:28:42 INFO - Running post-run listener: _upload_blobber_files 13:28:42 INFO - Blob upload gear active. 13:28:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:28:42 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:42 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:42 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:43 INFO - (blobuploader) - INFO - Open directory for files ... 13:28:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:28:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:28:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:28:47 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: 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_raw.log ... 13:28:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:28:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:28:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.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_errorsummary.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_errorsummary.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 - Iteration through files over. 13:28:48 INFO - Return code: 0 13:28:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:28:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:28:48 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/45ac197cdc9f9d43e311912e17716aff6481eb84a017cebeaadcd1f0c0fc09654a69a2693018209cc8b8b6747fd3483411c82f2ebdb0fd345a7679ff7b5eddb6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/db69083398ac3f464b4f7d211904c45af0a99c121b4b709d9757ba0085c374f2e63f345aac69ff1b97a96e13347ae87fb730a438e8b0f02e38b1ddbb7bcba724", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c9623db1c41d4c6ac4f2fe7c07b9388183c925402f1f27f6d56332613769f6fb5f243f91535f6b22f84e6df21c11c634fdcdd34b7176f52b824cc047103be791"} 13:28:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:28:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:28:48 INFO - Contents: 13:28:48 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/45ac197cdc9f9d43e311912e17716aff6481eb84a017cebeaadcd1f0c0fc09654a69a2693018209cc8b8b6747fd3483411c82f2ebdb0fd345a7679ff7b5eddb6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/db69083398ac3f464b4f7d211904c45af0a99c121b4b709d9757ba0085c374f2e63f345aac69ff1b97a96e13347ae87fb730a438e8b0f02e38b1ddbb7bcba724", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c9623db1c41d4c6ac4f2fe7c07b9388183c925402f1f27f6d56332613769f6fb5f243f91535f6b22f84e6df21c11c634fdcdd34b7176f52b824cc047103be791"} 13:28:48 INFO - Running post-run listener: copy_logs_to_upload_dir 13:28:48 INFO - Copying logs to upload dir... 13:28:48 INFO - mkdir: /builds/slave/test/build/upload/logs 13:28:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.589899 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-06-29 13:28:48.069322) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-29 13:28:48.072927) ========= 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=df17445c3590ff7897617a0e00000225-1467229708.116181-1181107337 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/45ac197cdc9f9d43e311912e17716aff6481eb84a017cebeaadcd1f0c0fc09654a69a2693018209cc8b8b6747fd3483411c82f2ebdb0fd345a7679ff7b5eddb6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/db69083398ac3f464b4f7d211904c45af0a99c121b4b709d9757ba0085c374f2e63f345aac69ff1b97a96e13347ae87fb730a438e8b0f02e38b1ddbb7bcba724", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c9623db1c41d4c6ac4f2fe7c07b9388183c925402f1f27f6d56332613769f6fb5f243f91535f6b22f84e6df21c11c634fdcdd34b7176f52b824cc047103be791"} 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.011242 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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/45ac197cdc9f9d43e311912e17716aff6481eb84a017cebeaadcd1f0c0fc09654a69a2693018209cc8b8b6747fd3483411c82f2ebdb0fd345a7679ff7b5eddb6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/db69083398ac3f464b4f7d211904c45af0a99c121b4b709d9757ba0085c374f2e63f345aac69ff1b97a96e13347ae87fb730a438e8b0f02e38b1ddbb7bcba724", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c9623db1c41d4c6ac4f2fe7c07b9388183c925402f1f27f6d56332613769f6fb5f243f91535f6b22f84e6df21c11c634fdcdd34b7176f52b824cc047103be791"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-29 13:28:48.099496) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 13:28:48.100210) ========= 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=df17445c3590ff7897617a0e00000225-1467229708.116181-1181107337 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004434 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 13:28:48.184473) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-29 13:28:48.185257) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-29 13:28:48.185993) ========= ========= Total master_lag: 0.19 =========