builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-005 starttime: 1467295712.79 results: success (0) buildid: 20160630043019 builduid: 617b4a1dd3d54393989b89c4066a5b7d revision: bcf4ff0c3eef498cd853a88270c75c161e524549 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-30 07:08:32.793926) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-30 07:08:32.794712) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-30 07:08:32.795459) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-30 07:08:32.811029) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 07:08:32.811386) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1467295255.553932-1238479860 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-30 07:08:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 33.5M=0s 2016-06-30 07:08:33 (33.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.288722 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 07:08:33.115111) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 07:08:33.115490) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1467295255.553932-1238479860 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018102 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 07:08:33.167743) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-30 07:08:33.168507) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev bcf4ff0c3eef498cd853a88270c75c161e524549 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev bcf4ff0c3eef498cd853a88270c75c161e524549 --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=7fc86f70bae03e018da0b1d8000001c4-1467295255.553932-1238479860 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-30 07:08:33,915 truncating revision to first 12 chars 2016-06-30 07:08:33,916 Setting DEBUG logging. 2016-06-30 07:08:33,916 attempt 1/10 2016-06-30 07:08:33,916 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/bcf4ff0c3eef?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-30 07:08:35,386 unpacking tar archive at: mozilla-central-bcf4ff0c3eef/testing/mozharness/ program finished with exit code 0 elapsedTime=1.822215 ========= master_lag: 0.07 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-30 07:08:35.058304) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-30 07:08:35.058670) ========= script_repo_revision: bcf4ff0c3eef498cd853a88270c75c161e524549 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-30 07:08:35.059164) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-30 07:08:35.059771) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-30 07:08:35.081756) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-06-30 07:08:35.082127) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=7fc86f70bae03e018da0b1d8000001c4-1467295255.553932-1238479860 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:08:35 INFO - MultiFileLogger online at 20160630 07:08:35 in /builds/slave/test 07:08:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 07:08:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:08:35 INFO - {'append_to_log': False, 07:08:35 INFO - 'base_work_dir': '/builds/slave/test', 07:08:35 INFO - 'blob_upload_branch': 'Firefox', 07:08:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:08:35 INFO - 'branch': 'Firefox', 07:08:35 INFO - 'buildbot_json_path': 'buildprops.json', 07:08:35 INFO - 'config_files': ('talos/linux_config.py',), 07:08:35 INFO - 'default_actions': ('clobber', 07:08:35 INFO - 'read-buildbot-config', 07:08:35 INFO - 'download-and-extract', 07:08:35 INFO - 'populate-webroot', 07:08:35 INFO - 'create-virtualenv', 07:08:35 INFO - 'install', 07:08:35 INFO - 'run-tests'), 07:08:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:08:35 INFO - 'download_minidump_stackwalk': True, 07:08:35 INFO - 'download_symbols': 'ondemand', 07:08:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:08:35 INFO - 'tooltool.py': '/tools/tooltool.py', 07:08:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:08:35 INFO - '/tools/misc-python/virtualenv.py')}, 07:08:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:08:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:08:35 INFO - 'installer_path': 'installer.exe', 07:08:35 INFO - 'log_level': 'info', 07:08:35 INFO - 'log_name': 'talos', 07:08:35 INFO - 'log_to_console': True, 07:08:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:08:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:08:35 INFO - 'opt_config_files': (), 07:08:35 INFO - 'pip_index': False, 07:08:35 INFO - 'sps_profile': False, 07:08:35 INFO - 'sps_profile_interval': 0, 07:08:35 INFO - 'suite': 'dromaeojs', 07:08:35 INFO - 'system_bits': '32', 07:08:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:08:35 INFO - 'title': 'talos-linux64-ix-005', 07:08:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:08:35 INFO - 'use_talos_json': True, 07:08:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:08:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:08:35 INFO - 'work_dir': 'build'} 07:08:35 INFO - ##### 07:08:35 INFO - ##### Running clobber step. 07:08:35 INFO - ##### 07:08:35 INFO - Running pre-action listener: _resource_record_pre_action 07:08:35 INFO - Running main action method: clobber 07:08:35 INFO - rmtree: /builds/slave/test/build 07:08:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:08:36 INFO - Running post-action listener: _resource_record_post_action 07:08:36 INFO - ##### 07:08:36 INFO - ##### Finished clobber step (success) 07:08:36 INFO - ##### 07:08:36 INFO - ##### 07:08:36 INFO - ##### Running read-buildbot-config step. 07:08:36 INFO - ##### 07:08:36 INFO - Running pre-action listener: _resource_record_pre_action 07:08:36 INFO - Running main action method: read_buildbot_config 07:08:36 INFO - Using buildbot properties: 07:08:36 INFO - { 07:08:36 INFO - "project": "", 07:08:36 INFO - "product": "firefox", 07:08:36 INFO - "script_repo_revision": "production", 07:08:36 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 07:08:36 INFO - "repository": "", 07:08:36 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 07:08:36 INFO - "buildid": "20160630043019", 07:08:36 INFO - "pgo_build": "True", 07:08:36 INFO - "basedir": "/builds/slave/test", 07:08:36 INFO - "buildnumber": 487, 07:08:36 INFO - "slavename": "talos-linux64-ix-005", 07:08:36 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 07:08:36 INFO - "platform": "ubuntu64_hw", 07:08:36 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 07:08:36 INFO - "branch": "mozilla-central", 07:08:36 INFO - "repo_path": "mozilla-central", 07:08:36 INFO - "revision": "bcf4ff0c3eef498cd853a88270c75c161e524549", 07:08:36 INFO - "stage_platform": "linux64-pgo", 07:08:36 INFO - "builduid": "617b4a1dd3d54393989b89c4066a5b7d", 07:08:36 INFO - "slavebuilddir": "test" 07:08:36 INFO - } 07:08:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/S9HeRt61Q8SUOKu3uvFxQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 07:08:36 INFO - Running post-action listener: _resource_record_post_action 07:08:36 INFO - ##### 07:08:36 INFO - ##### Finished read-buildbot-config step (success) 07:08:36 INFO - ##### 07:08:36 INFO - ##### 07:08:36 INFO - ##### Running download-and-extract step. 07:08:36 INFO - ##### 07:08:36 INFO - Running pre-action listener: _resource_record_pre_action 07:08:36 INFO - Running main action method: download_and_extract 07:08:36 INFO - mkdir: /builds/slave/test/build/tests 07:08:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:08:36 INFO - https://queue.taskcluster.net/v1/task/S9HeRt61Q8SUOKu3uvFxQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:08:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S9HeRt61Q8SUOKu3uvFxQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:08:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S9HeRt61Q8SUOKu3uvFxQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:08:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S9HeRt61Q8SUOKu3uvFxQA/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 07:08:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S9HeRt61Q8SUOKu3uvFxQA/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 07:08:40 INFO - Downloaded 1361 bytes. 07:08:40 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:08:40 INFO - Using the following test package requirements: 07:08:40 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:08:40 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:08:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:08:40 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:08:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:08:40 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:08:40 INFO - u'jsshell-linux-x86_64.zip'], 07:08:40 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:08:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:08:40 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:08:40 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:08:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:08:40 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:08:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:08:40 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:08:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:08:40 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:08:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:08:40 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:08:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:08:40 INFO - https://queue.taskcluster.net/v1/task/S9HeRt61Q8SUOKu3uvFxQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:08:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S9HeRt61Q8SUOKu3uvFxQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:08:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S9HeRt61Q8SUOKu3uvFxQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:08:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S9HeRt61Q8SUOKu3uvFxQA/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 07:08:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S9HeRt61Q8SUOKu3uvFxQA/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 07:08:49 INFO - Downloaded 24268109 bytes. 07:08:49 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'] 07:08:49 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 07:08:51 INFO - Return code: 0 07:08:51 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 07:08:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:08:51 INFO - https://queue.taskcluster.net/v1/task/S9HeRt61Q8SUOKu3uvFxQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:08:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S9HeRt61Q8SUOKu3uvFxQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:08:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S9HeRt61Q8SUOKu3uvFxQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:08:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S9HeRt61Q8SUOKu3uvFxQA/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 07:08:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S9HeRt61Q8SUOKu3uvFxQA/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 07:08:56 INFO - Downloaded 24268109 bytes. 07:08:56 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'] 07:08:56 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 07:08:57 INFO - Return code: 0 07:08:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:08:57 INFO - https://queue.taskcluster.net/v1/task/S9HeRt61Q8SUOKu3uvFxQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:08:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S9HeRt61Q8SUOKu3uvFxQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:08:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S9HeRt61Q8SUOKu3uvFxQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:08:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S9HeRt61Q8SUOKu3uvFxQA/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 07:08:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S9HeRt61Q8SUOKu3uvFxQA/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 07:08:59 INFO - Downloaded 14405242 bytes. 07:08:59 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'] 07:08:59 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 07:08:59 INFO - Return code: 0 07:08:59 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')]} 07:08:59 INFO - https://queue.taskcluster.net/v1/task/S9HeRt61Q8SUOKu3uvFxQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:08:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S9HeRt61Q8SUOKu3uvFxQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:08:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S9HeRt61Q8SUOKu3uvFxQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:08:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S9HeRt61Q8SUOKu3uvFxQA/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 07:08:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S9HeRt61Q8SUOKu3uvFxQA/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 07:09:01 INFO - Downloaded 60330009 bytes. 07:09:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/S9HeRt61Q8SUOKu3uvFxQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:09:01 INFO - mkdir: /builds/slave/test/properties 07:09:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:09:01 INFO - Writing to file /builds/slave/test/properties/build_url 07:09:01 INFO - Contents: 07:09:01 INFO - build_url:https://queue.taskcluster.net/v1/task/S9HeRt61Q8SUOKu3uvFxQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:09:01 INFO - Running post-action listener: _resource_record_post_action 07:09:01 INFO - Running post-action listener: set_extra_try_arguments 07:09:01 INFO - ##### 07:09:01 INFO - ##### Finished download-and-extract step (success) 07:09:01 INFO - ##### 07:09:01 INFO - ##### 07:09:01 INFO - ##### Running populate-webroot step. 07:09:01 INFO - ##### 07:09:01 INFO - Running pre-action listener: _resource_record_pre_action 07:09:01 INFO - Running main action method: populate_webroot 07:09:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:09:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:09:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:09:01 INFO - '--tppagecycles', 07:09:01 INFO - '7'], 07:09:01 INFO - 'tests': ['tsvgm']}}, 07:09:01 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:09:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:09:01 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:09:01 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:09:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:09:01 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:09:01 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:09:01 INFO - 'talos_options': ['--disable-e10s'], 07:09:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:09:01 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:09:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:09:01 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:09:01 INFO - 'talos_options': ['--disable-e10s'], 07:09:01 INFO - 'tests': ['damp', 'tps']}, 07:09:01 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:09:01 INFO - 'tests': ['damp', 'tps']}, 07:09:01 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:09:01 INFO - 'tests': ['dromaeo_dom']}, 07:09:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:09:01 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:09:01 INFO - 'tests': ['basic_compositor_video']}, 07:09:01 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:09:01 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:09:01 INFO - 'tests': ['a11yr', 07:09:01 INFO - 'ts_paint', 07:09:01 INFO - 'tpaint', 07:09:01 INFO - 'sessionrestore', 07:09:01 INFO - 'sessionrestore_no_auto_restore', 07:09:01 INFO - 'tabpaint']}, 07:09:01 INFO - 'other-e10s': {'tests': ['a11yr', 07:09:01 INFO - 'ts_paint', 07:09:01 INFO - 'tpaint', 07:09:01 INFO - 'sessionrestore', 07:09:01 INFO - 'sessionrestore_no_auto_restore', 07:09:01 INFO - 'tabpaint']}, 07:09:01 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:09:01 INFO - 'ts_paint', 07:09:01 INFO - 'tpaint', 07:09:01 INFO - 'sessionrestore', 07:09:01 INFO - 'sessionrestore_no_auto_restore', 07:09:01 INFO - 'tabpaint']}, 07:09:01 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:09:01 INFO - 'ts_paint', 07:09:01 INFO - 'tpaint', 07:09:01 INFO - 'sessionrestore', 07:09:01 INFO - 'sessionrestore_no_auto_restore', 07:09:01 INFO - 'tabpaint']}, 07:09:01 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:09:01 INFO - 'tests': ['a11yr', 07:09:01 INFO - 'ts_paint', 07:09:01 INFO - 'tpaint', 07:09:01 INFO - 'sessionrestore', 07:09:01 INFO - 'sessionrestore_no_auto_restore', 07:09:01 INFO - 'tabpaint']}, 07:09:01 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:09:01 INFO - 'tests': ['a11yr', 07:09:01 INFO - 'ts_paint', 07:09:01 INFO - 'tpaint', 07:09:01 INFO - 'sessionrestore', 07:09:01 INFO - 'sessionrestore_no_auto_restore', 07:09:01 INFO - 'tabpaint']}, 07:09:01 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:09:01 INFO - 'tests': ['tsvgx', 07:09:01 INFO - 'tsvgr_opacity', 07:09:01 INFO - 'tart', 07:09:01 INFO - 'tscrollx', 07:09:01 INFO - 'cart']}, 07:09:01 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:09:01 INFO - 'tsvgr_opacity', 07:09:01 INFO - 'tart', 07:09:01 INFO - 'tscrollx', 07:09:01 INFO - 'cart']}, 07:09:01 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:09:01 INFO - 'talos_options': ['--disable-e10s'], 07:09:01 INFO - 'tests': ['tp5o']}, 07:09:01 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:09:01 INFO - 'tests': ['tp5o']}, 07:09:01 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:09:01 INFO - 'talos_options': ['--disable-e10s', 07:09:01 INFO - '--xperf_path', 07:09:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:09:01 INFO - 'tests': ['tp5n']}, 07:09:01 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:09:01 INFO - 'talos_options': ['--xperf_path', 07:09:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:09:01 INFO - 'tests': ['tp5n']}}, 07:09:01 INFO - 'talos.zip': {'path': '', 07:09:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:09:01 INFO - Running post-action listener: _resource_record_post_action 07:09:01 INFO - ##### 07:09:01 INFO - ##### Finished populate-webroot step (success) 07:09:01 INFO - ##### 07:09:01 INFO - ##### 07:09:01 INFO - ##### Running create-virtualenv step. 07:09:01 INFO - ##### 07:09:01 INFO - Running pre-action listener: _resource_record_pre_action 07:09:01 INFO - Running main action method: create_virtualenv 07:09:01 INFO - Creating virtualenv /builds/slave/test/build/venv 07:09:01 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 07:09:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:09:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:09:01 INFO - Using real prefix '/usr' 07:09:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:09:02 INFO - Installing distribute.............................................................................................................................................................................................done. 07:09:04 INFO - Installing pip.................done. 07:09:04 INFO - Return code: 0 07:09:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:09:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:09:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:09:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:04 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 0x236d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x262e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x262c3b0>, '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 0x262d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x262d740>, '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': '7fc86f70bae03e018da0b1d8000001c4-1467295255.553932-1238479860', '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 07:09:04 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 07:09:04 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 07:09:04 INFO - Using env: {'DISPLAY': ':0', 07:09:04 INFO - 'HOME': '/home/cltbld', 07:09:04 INFO - 'LANG': 'en_US.UTF-8', 07:09:04 INFO - 'LANGUAGE': 'en_US:en', 07:09:04 INFO - 'LOGNAME': 'cltbld', 07:09:04 INFO - 'MAIL': '/var/mail/cltbld', 07:09:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:04 INFO - 'MOZ_NO_REMOTE': '1', 07:09:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:04 INFO - 'NO_EM_RESTART': '1', 07:09:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:09:04 INFO - 'PWD': '/builds/slave/test', 07:09:04 INFO - 'SHELL': '/bin/bash', 07:09:04 INFO - 'SHLVL': '1', 07:09:04 INFO - 'TERM': 'linux', 07:09:04 INFO - 'TMOUT': '86400', 07:09:04 INFO - 'USER': 'cltbld', 07:09:04 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1467295255.553932-1238479860', 07:09:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:04 INFO - '_': '/tools/buildbot/bin/python'} 07:09:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:09:04 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 07:09:04 INFO - Cleaning up... 07:09:04 INFO - Return code: 0 07:09:04 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:09:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:09:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:09:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:04 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 0x236d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x262e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x262c3b0>, '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 0x262d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x262d740>, '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': '7fc86f70bae03e018da0b1d8000001c4-1467295255.553932-1238479860', '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 07:09:04 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 07:09:04 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 07:09:04 INFO - Using env: {'DISPLAY': ':0', 07:09:04 INFO - 'HOME': '/home/cltbld', 07:09:04 INFO - 'LANG': 'en_US.UTF-8', 07:09:04 INFO - 'LANGUAGE': 'en_US:en', 07:09:04 INFO - 'LOGNAME': 'cltbld', 07:09:04 INFO - 'MAIL': '/var/mail/cltbld', 07:09:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:04 INFO - 'MOZ_NO_REMOTE': '1', 07:09:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:04 INFO - 'NO_EM_RESTART': '1', 07:09:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:09:04 INFO - 'PWD': '/builds/slave/test', 07:09:04 INFO - 'SHELL': '/bin/bash', 07:09:04 INFO - 'SHLVL': '1', 07:09:04 INFO - 'TERM': 'linux', 07:09:04 INFO - 'TMOUT': '86400', 07:09:04 INFO - 'USER': 'cltbld', 07:09:04 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1467295255.553932-1238479860', 07:09:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:04 INFO - '_': '/tools/buildbot/bin/python'} 07:09:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:09:04 INFO - Downloading/unpacking psutil>=3.1.1 07:09:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:09:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:09:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:09:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:09:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:09:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:09:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:09:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:09:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:09:06 INFO - Installing collected packages: psutil 07:09:06 INFO - Running setup.py install for psutil 07:09:06 INFO - building 'psutil._psutil_linux' extension 07:09:06 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 07:09:07 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 07:09:07 INFO - building 'psutil._psutil_posix' extension 07:09:07 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 07:09:07 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 07:09:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:09:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:09:07 INFO - Successfully installed psutil 07:09:07 INFO - Cleaning up... 07:09:07 INFO - Return code: 0 07:09:07 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:09:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:09:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:09:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x236d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x262e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x262c3b0>, '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 0x262d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x262d740>, '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': '7fc86f70bae03e018da0b1d8000001c4-1467295255.553932-1238479860', '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 07:09:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:09:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:09:07 INFO - Using env: {'DISPLAY': ':0', 07:09:07 INFO - 'HOME': '/home/cltbld', 07:09:07 INFO - 'LANG': 'en_US.UTF-8', 07:09:07 INFO - 'LANGUAGE': 'en_US:en', 07:09:07 INFO - 'LOGNAME': 'cltbld', 07:09:07 INFO - 'MAIL': '/var/mail/cltbld', 07:09:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:07 INFO - 'MOZ_NO_REMOTE': '1', 07:09:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:07 INFO - 'NO_EM_RESTART': '1', 07:09:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:09:07 INFO - 'PWD': '/builds/slave/test', 07:09:07 INFO - 'SHELL': '/bin/bash', 07:09:07 INFO - 'SHLVL': '1', 07:09:07 INFO - 'TERM': 'linux', 07:09:07 INFO - 'TMOUT': '86400', 07:09:07 INFO - 'USER': 'cltbld', 07:09:07 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1467295255.553932-1238479860', 07:09:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:07 INFO - '_': '/tools/buildbot/bin/python'} 07:09:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:09:07 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:09:07 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 07:09:07 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 07:09:07 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 07:09:07 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 07:09:07 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 07:09:07 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 07:09:09 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:09:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:09:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:09:09 INFO - Installing collected packages: mozsystemmonitor 07:09:09 INFO - Running setup.py install for mozsystemmonitor 07:09:09 INFO - Successfully installed mozsystemmonitor 07:09:09 INFO - Cleaning up... 07:09:09 INFO - Return code: 0 07:09:09 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:09:09 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')]} 07:09:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:09:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:09 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')]} 07:09:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:09:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:09 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 0x236d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x262e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x262c3b0>, '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 0x262d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x262d740>, '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': '7fc86f70bae03e018da0b1d8000001c4-1467295255.553932-1238479860', '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 07:09:09 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 07:09:09 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 07:09:09 INFO - Using env: {'DISPLAY': ':0', 07:09:09 INFO - 'HOME': '/home/cltbld', 07:09:09 INFO - 'LANG': 'en_US.UTF-8', 07:09:09 INFO - 'LANGUAGE': 'en_US:en', 07:09:09 INFO - 'LOGNAME': 'cltbld', 07:09:09 INFO - 'MAIL': '/var/mail/cltbld', 07:09:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:09 INFO - 'MOZ_NO_REMOTE': '1', 07:09:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:09 INFO - 'NO_EM_RESTART': '1', 07:09:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:09:09 INFO - 'PWD': '/builds/slave/test', 07:09:09 INFO - 'SHELL': '/bin/bash', 07:09:09 INFO - 'SHLVL': '1', 07:09:09 INFO - 'TERM': 'linux', 07:09:09 INFO - 'TMOUT': '86400', 07:09:09 INFO - 'USER': 'cltbld', 07:09:09 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1467295255.553932-1238479860', 07:09:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:09 INFO - '_': '/tools/buildbot/bin/python'} 07:09:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:09:09 INFO - Downloading/unpacking jsonschema==2.5.1 07:09:09 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 07:09:09 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 07:09:09 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 07:09:09 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 07:09:09 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 07:09:09 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 07:09:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:09:11 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:09:11 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 07:09:11 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 07:09:11 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 07:09:11 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 07:09:11 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 07:09:11 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 07:09:12 INFO - Downloading functools32-3.2.3-2.tar.gz 07:09:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:09:12 INFO - warning: no files found matching '*.txt' 07:09:12 INFO - no previously-included directories found matching 'build' 07:09:12 INFO - no previously-included directories found matching 'dist' 07:09:12 INFO - no previously-included directories found matching '.git*' 07:09:12 INFO - Installing collected packages: jsonschema, functools32 07:09:12 INFO - Running setup.py install for functools32 07:09:12 INFO - warning: no files found matching '*.txt' 07:09:12 INFO - no previously-included directories found matching 'build' 07:09:12 INFO - no previously-included directories found matching 'dist' 07:09:12 INFO - no previously-included directories found matching '.git*' 07:09:12 INFO - Successfully installed jsonschema functools32 07:09:12 INFO - Cleaning up... 07:09:12 INFO - Return code: 0 07:09:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:09:12 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')]} 07:09:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:09:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:12 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')]} 07:09:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:09:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:12 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 0x236d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x262e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x262c3b0>, '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 0x262d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x262d740>, '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': '7fc86f70bae03e018da0b1d8000001c4-1467295255.553932-1238479860', '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 07:09:12 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 07:09:12 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 07:09:12 INFO - Using env: {'DISPLAY': ':0', 07:09:12 INFO - 'HOME': '/home/cltbld', 07:09:12 INFO - 'LANG': 'en_US.UTF-8', 07:09:12 INFO - 'LANGUAGE': 'en_US:en', 07:09:12 INFO - 'LOGNAME': 'cltbld', 07:09:12 INFO - 'MAIL': '/var/mail/cltbld', 07:09:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:12 INFO - 'MOZ_NO_REMOTE': '1', 07:09:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:12 INFO - 'NO_EM_RESTART': '1', 07:09:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:09:12 INFO - 'PWD': '/builds/slave/test', 07:09:12 INFO - 'SHELL': '/bin/bash', 07:09:12 INFO - 'SHLVL': '1', 07:09:12 INFO - 'TERM': 'linux', 07:09:12 INFO - 'TMOUT': '86400', 07:09:12 INFO - 'USER': 'cltbld', 07:09:12 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1467295255.553932-1238479860', 07:09:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:12 INFO - '_': '/tools/buildbot/bin/python'} 07:09:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:09:12 INFO - Downloading/unpacking blobuploader==1.2.4 07:09:12 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 07:09:12 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 07:09:12 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 07:09:12 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 07:09:12 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 07:09:12 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 07:09:15 INFO - Downloading blobuploader-1.2.4.tar.gz 07:09:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:09:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:09:15 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 07:09:15 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 07:09:15 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 07:09:15 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 07:09:15 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 07:09:15 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 07:09:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:09:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:09:15 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 07:09:15 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 07:09:15 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 07:09:15 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 07:09:15 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 07:09:15 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 07:09:16 INFO - Downloading docopt-0.6.1.tar.gz 07:09:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:09:16 INFO - Installing collected packages: blobuploader, requests, docopt 07:09:16 INFO - Running setup.py install for blobuploader 07:09:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:09:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:09:16 INFO - Running setup.py install for requests 07:09:16 INFO - Running setup.py install for docopt 07:09:16 INFO - Successfully installed blobuploader requests docopt 07:09:16 INFO - Cleaning up... 07:09:16 INFO - Return code: 0 07:09:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:09:16 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')]} 07:09:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:09:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:16 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')]} 07:09:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:09:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:16 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 0x236d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x262e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x262c3b0>, '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 0x262d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x262d740>, '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': '7fc86f70bae03e018da0b1d8000001c4-1467295255.553932-1238479860', '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 07:09:16 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 07:09:16 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 07:09:16 INFO - Using env: {'DISPLAY': ':0', 07:09:16 INFO - 'HOME': '/home/cltbld', 07:09:16 INFO - 'LANG': 'en_US.UTF-8', 07:09:16 INFO - 'LANGUAGE': 'en_US:en', 07:09:16 INFO - 'LOGNAME': 'cltbld', 07:09:16 INFO - 'MAIL': '/var/mail/cltbld', 07:09:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:16 INFO - 'MOZ_NO_REMOTE': '1', 07:09:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:16 INFO - 'NO_EM_RESTART': '1', 07:09:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:09:16 INFO - 'PWD': '/builds/slave/test', 07:09:16 INFO - 'SHELL': '/bin/bash', 07:09:16 INFO - 'SHLVL': '1', 07:09:16 INFO - 'TERM': 'linux', 07:09:16 INFO - 'TMOUT': '86400', 07:09:16 INFO - 'USER': 'cltbld', 07:09:16 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1467295255.553932-1238479860', 07:09:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:16 INFO - '_': '/tools/buildbot/bin/python'} 07:09:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:09:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:09:17 INFO - Running setup.py (path:/tmp/pip-kK9Tuq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:09:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:09:17 INFO - Running setup.py (path:/tmp/pip-H6C2v4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:09:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:09:17 INFO - Running setup.py (path:/tmp/pip-A1ply2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:09:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:09:17 INFO - Running setup.py (path:/tmp/pip-2Z5fuF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:09:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:09:17 INFO - Running setup.py (path:/tmp/pip-3mvqtJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:09:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:09:17 INFO - Running setup.py (path:/tmp/pip-L2hiWK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:09:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:09:17 INFO - Running setup.py (path:/tmp/pip-b_yjM_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:09:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:09:17 INFO - Running setup.py (path:/tmp/pip-VtVXlh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:09:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:09:17 INFO - Running setup.py (path:/tmp/pip-XxcIZI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:09:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:09:17 INFO - Running setup.py (path:/tmp/pip-_F4TQa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:09:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:09:17 INFO - Running setup.py (path:/tmp/pip-YEfUqz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:09:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:09:17 INFO - Running setup.py (path:/tmp/pip-RdyGqv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:09:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:09:17 INFO - Running setup.py (path:/tmp/pip-wfio21-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:09:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:09:17 INFO - Running setup.py (path:/tmp/pip-Gt260j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:09:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:09:18 INFO - Running setup.py (path:/tmp/pip-y4y72e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:09:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:09:18 INFO - Running setup.py (path:/tmp/pip-NGoNM9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:09:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:09:18 INFO - Running setup.py (path:/tmp/pip-4kQV6P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:09:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:09:18 INFO - Running setup.py install for manifestparser 07:09:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:09:18 INFO - Running setup.py install for mozcrash 07:09:18 INFO - Running setup.py install for mozdebug 07:09:18 INFO - Running setup.py install for mozdevice 07:09:18 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:09:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:09:18 INFO - Running setup.py install for mozfile 07:09:18 INFO - Running setup.py install for mozhttpd 07:09:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:09:18 INFO - Running setup.py install for mozinfo 07:09:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:09:18 INFO - Running setup.py install for mozInstall 07:09:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:09:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:09:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:09:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:09:19 INFO - Running setup.py install for mozleak 07:09:19 INFO - Running setup.py install for mozlog 07:09:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:09:19 INFO - Running setup.py install for moznetwork 07:09:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:09:19 INFO - Running setup.py install for mozprocess 07:09:19 INFO - Running setup.py install for mozprofile 07:09:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:09:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:09:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:09:19 INFO - Running setup.py install for mozrunner 07:09:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:09:19 INFO - Running setup.py install for mozscreenshot 07:09:19 INFO - Running setup.py install for moztest 07:09:19 INFO - Running setup.py install for mozversion 07:09:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:09:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:09:20 INFO - Cleaning up... 07:09:20 INFO - Return code: 0 07:09:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:09: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')]} 07:09:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:09:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09: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')]} 07:09:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:09:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:20 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 0x236d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x262e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x262c3b0>, '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 0x262d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x262d740>, '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': '7fc86f70bae03e018da0b1d8000001c4-1467295255.553932-1238479860', '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 07:09:20 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 07:09:20 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 07:09:20 INFO - Using env: {'DISPLAY': ':0', 07:09:20 INFO - 'HOME': '/home/cltbld', 07:09:20 INFO - 'LANG': 'en_US.UTF-8', 07:09:20 INFO - 'LANGUAGE': 'en_US:en', 07:09:20 INFO - 'LOGNAME': 'cltbld', 07:09:20 INFO - 'MAIL': '/var/mail/cltbld', 07:09:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:20 INFO - 'MOZ_NO_REMOTE': '1', 07:09:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:20 INFO - 'NO_EM_RESTART': '1', 07:09:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:09:20 INFO - 'PWD': '/builds/slave/test', 07:09:20 INFO - 'SHELL': '/bin/bash', 07:09:20 INFO - 'SHLVL': '1', 07:09:20 INFO - 'TERM': 'linux', 07:09:20 INFO - 'TMOUT': '86400', 07:09:20 INFO - 'USER': 'cltbld', 07:09:20 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1467295255.553932-1238479860', 07:09:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:20 INFO - '_': '/tools/buildbot/bin/python'} 07:09:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:09:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:09:20 INFO - Running setup.py (path:/tmp/pip-_YJ0FD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:09:20 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)) 07:09:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:09:20 INFO - Running setup.py (path:/tmp/pip-v7HrVZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:09:20 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)) 07:09:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:09:20 INFO - Running setup.py (path:/tmp/pip-7l7F5y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:09:20 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)) 07:09:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:09:20 INFO - Running setup.py (path:/tmp/pip-Z2mZj4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:09:20 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)) 07:09:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:09:20 INFO - Running setup.py (path:/tmp/pip-rrFGt_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:09:20 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)) 07:09:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:09:20 INFO - Running setup.py (path:/tmp/pip-KusPCz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:09:20 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)) 07:09:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:09:20 INFO - Running setup.py (path:/tmp/pip-teZzFQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:09:20 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)) 07:09:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:09:20 INFO - Running setup.py (path:/tmp/pip-opCCKj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:09:20 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)) 07:09:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:09:20 INFO - Running setup.py (path:/tmp/pip-npGtyw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:09:20 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)) 07:09:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:09:20 INFO - Running setup.py (path:/tmp/pip-HdYzsc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:09:20 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)) 07:09:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:09:20 INFO - Running setup.py (path:/tmp/pip-ZqhkJJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:09:21 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)) 07:09:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:09:21 INFO - Running setup.py (path:/tmp/pip-HLRl50-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:09:21 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)) 07:09:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:09:21 INFO - Running setup.py (path:/tmp/pip-qkKoYn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:09:21 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)) 07:09:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:09:21 INFO - Running setup.py (path:/tmp/pip-OmUfvL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:09:21 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)) 07:09:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:09:21 INFO - Running setup.py (path:/tmp/pip-Av28gM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:09:21 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)) 07:09:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:09:21 INFO - Running setup.py (path:/tmp/pip-lK82SV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:09:21 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)) 07:09:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:09:21 INFO - Running setup.py (path:/tmp/pip-TQLvIX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:09:21 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)) 07:09:21 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)) 07:09:21 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)) 07:09:21 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)) 07:09:21 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)) 07:09:21 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)) 07:09:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:09:21 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 07:09:21 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 07:09:21 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 07:09:21 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 07:09:21 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 07:09:21 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 07:09:23 INFO - Downloading blessings-1.6.tar.gz 07:09:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:09:23 INFO - Installing collected packages: blessings 07:09:23 INFO - Running setup.py install for blessings 07:09:23 INFO - Successfully installed blessings 07:09:23 INFO - Cleaning up... 07:09:23 INFO - Return code: 0 07:09:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:09:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:09:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:09:24 INFO - Reading from file tmpfile_stdout 07:09:24 INFO - Current package versions: 07:09:24 INFO - argparse == 1.2.1 07:09:24 INFO - blessings == 1.6 07:09:24 INFO - blobuploader == 1.2.4 07:09:24 INFO - docopt == 0.6.1 07:09:24 INFO - functools32 == 3.2.3-2 07:09:24 INFO - jsonschema == 2.5.1 07:09:24 INFO - manifestparser == 1.1 07:09:24 INFO - mozInstall == 1.12 07:09:24 INFO - mozcrash == 0.17 07:09:24 INFO - mozdebug == 0.1 07:09:24 INFO - mozdevice == 0.48 07:09:24 INFO - mozfile == 1.2 07:09:24 INFO - mozhttpd == 0.7 07:09:24 INFO - mozinfo == 0.9 07:09:24 INFO - mozleak == 0.1 07:09:24 INFO - mozlog == 3.2 07:09:24 INFO - moznetwork == 0.27 07:09:24 INFO - mozprocess == 0.22 07:09:24 INFO - mozprofile == 0.28 07:09:24 INFO - mozrunner == 6.11 07:09:24 INFO - mozscreenshot == 0.1 07:09:24 INFO - mozsystemmonitor == 0.3 07:09:24 INFO - moztest == 0.7 07:09:24 INFO - mozversion == 1.4 07:09:24 INFO - psutil == 3.1.1 07:09:24 INFO - requests == 1.2.3 07:09:24 INFO - wsgiref == 0.1.2 07:09:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:09:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:09:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:09:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:24 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 0x236d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x262e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x262c3b0>, '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 0x262d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x262d740>, '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': '7fc86f70bae03e018da0b1d8000001c4-1467295255.553932-1238479860', '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 07:09:24 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 07:09:24 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 07:09:24 INFO - Using env: {'DISPLAY': ':0', 07:09:24 INFO - 'HOME': '/home/cltbld', 07:09:24 INFO - 'LANG': 'en_US.UTF-8', 07:09:24 INFO - 'LANGUAGE': 'en_US:en', 07:09:24 INFO - 'LOGNAME': 'cltbld', 07:09:24 INFO - 'MAIL': '/var/mail/cltbld', 07:09:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:24 INFO - 'MOZ_NO_REMOTE': '1', 07:09:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:24 INFO - 'NO_EM_RESTART': '1', 07:09:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:09:24 INFO - 'PWD': '/builds/slave/test', 07:09:24 INFO - 'SHELL': '/bin/bash', 07:09:24 INFO - 'SHLVL': '1', 07:09:24 INFO - 'TERM': 'linux', 07:09:24 INFO - 'TMOUT': '86400', 07:09:24 INFO - 'USER': 'cltbld', 07:09:24 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1467295255.553932-1238479860', 07:09:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:24 INFO - '_': '/tools/buildbot/bin/python'} 07:09:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:09:24 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)) 07:09:24 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)) 07:09:24 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)) 07:09:24 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)) 07:09:24 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)) 07:09:24 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)) 07:09:24 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)) 07:09:24 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)) 07:09:24 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)) 07:09:24 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)) 07:09:24 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)) 07:09:24 INFO - Cleaning up... 07:09:24 INFO - Return code: 0 07:09:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:09:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:09:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:09:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:24 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 0x236d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x262e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x262c3b0>, '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 0x262d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x262d740>, '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': '7fc86f70bae03e018da0b1d8000001c4-1467295255.553932-1238479860', '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 07:09:24 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 07:09:24 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 07:09:24 INFO - Using env: {'DISPLAY': ':0', 07:09:24 INFO - 'HOME': '/home/cltbld', 07:09:24 INFO - 'LANG': 'en_US.UTF-8', 07:09:24 INFO - 'LANGUAGE': 'en_US:en', 07:09:24 INFO - 'LOGNAME': 'cltbld', 07:09:24 INFO - 'MAIL': '/var/mail/cltbld', 07:09:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:24 INFO - 'MOZ_NO_REMOTE': '1', 07:09:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:24 INFO - 'NO_EM_RESTART': '1', 07:09:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:09:24 INFO - 'PWD': '/builds/slave/test', 07:09:24 INFO - 'SHELL': '/bin/bash', 07:09:24 INFO - 'SHLVL': '1', 07:09:24 INFO - 'TERM': 'linux', 07:09:24 INFO - 'TMOUT': '86400', 07:09:24 INFO - 'USER': 'cltbld', 07:09:24 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1467295255.553932-1238479860', 07:09:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:24 INFO - '_': '/tools/buildbot/bin/python'} 07:09:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:09:24 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:09:24 INFO - Cleaning up... 07:09:24 INFO - Return code: 0 07:09:24 INFO - Running post-action listener: _resource_record_post_action 07:09:24 INFO - Running post-action listener: _start_resource_monitoring 07:09:24 INFO - Starting resource monitoring. 07:09:24 INFO - ##### 07:09:24 INFO - ##### Finished create-virtualenv step (success) 07:09:24 INFO - ##### 07:09:24 INFO - ##### 07:09:24 INFO - ##### Running install step. 07:09:24 INFO - ##### 07:09:24 INFO - Running pre-action listener: _resource_record_pre_action 07:09:24 INFO - Running main action method: install 07:09:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:09:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:09:24 INFO - Reading from file tmpfile_stdout 07:09:24 INFO - Detecting whether we're running mozinstall >=1.0... 07:09:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:09:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:09:24 INFO - Reading from file tmpfile_stdout 07:09:24 INFO - Output received: 07:09:24 INFO - Usage: mozinstall [options] installer 07:09:24 INFO - Options: 07:09:24 INFO - -h, --help show this help message and exit 07:09:24 INFO - -d DEST, --destination=DEST 07:09:24 INFO - Directory to install application into. [default: 07:09:24 INFO - "/builds/slave/test"] 07:09:24 INFO - --app=APP Application being installed. [default: firefox] 07:09:24 INFO - mkdir: /builds/slave/test/build/application 07:09:24 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'] 07:09:24 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 07:09:42 INFO - Reading from file tmpfile_stdout 07:09:42 INFO - Output received: 07:09:42 INFO - /builds/slave/test/build/application/firefox/firefox 07:09:42 INFO - Running post-action listener: _resource_record_post_action 07:09:42 INFO - ##### 07:09:42 INFO - ##### Finished install step (success) 07:09:42 INFO - ##### 07:09:42 INFO - ##### 07:09:42 INFO - ##### Running run-tests step. 07:09:42 INFO - ##### 07:09:42 INFO - Running pre-action listener: _resource_record_pre_action 07:09:42 INFO - Running main action method: run_tests 07:09:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:09:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:09:42 INFO - Python 2.7.3 07:09:42 INFO - Return code: 0 07:09:42 INFO - grabbing minidump binary from tooltool 07:09:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:42 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 0x262c3b0>, '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 0x262d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x262d740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:09:42 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 07:09:42 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 07:09:42 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 07:09:42 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:09:42 INFO - Return code: 0 07:09:42 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:09:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:09:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:09:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:09:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:09:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/S9HeRt61Q8SUOKu3uvFxQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--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 07:09:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/S9HeRt61Q8SUOKu3uvFxQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-005 --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 07:09:42 INFO - Using env: {'DISPLAY': ':0', 07:09:42 INFO - 'HOME': '/home/cltbld', 07:09:42 INFO - 'LANG': 'en_US.UTF-8', 07:09:42 INFO - 'LANGUAGE': 'en_US:en', 07:09:42 INFO - 'LOGNAME': 'cltbld', 07:09:42 INFO - 'MAIL': '/var/mail/cltbld', 07:09:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:09:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:09:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:42 INFO - 'MOZ_NO_REMOTE': '1', 07:09:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:09:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:42 INFO - 'NO_EM_RESTART': '1', 07:09:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:09:42 INFO - 'PWD': '/builds/slave/test', 07:09:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:09:42 INFO - 'SHELL': '/bin/bash', 07:09:42 INFO - 'SHLVL': '1', 07:09:42 INFO - 'TERM': 'linux', 07:09:42 INFO - 'TMOUT': '86400', 07:09:42 INFO - 'USER': 'cltbld', 07:09:42 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1467295255.553932-1238479860', 07:09:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:42 INFO - '_': '/tools/buildbot/bin/python'} 07:09:42 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/S9HeRt61Q8SUOKu3uvFxQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--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 07:09:42 INFO - mozversion application_buildid: 20160630043019 07:09:42 INFO - mozversion application_changeset: bcf4ff0c3eef498cd853a88270c75c161e524549 07:09:42 INFO - mozversion application_display_name: Nightly 07:09:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:09:42 INFO - mozversion application_name: Firefox 07:09:42 INFO - mozversion application_remotingname: firefox 07:09:42 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:09:42 INFO - mozversion application_vendor: Mozilla 07:09:42 INFO - mozversion application_version: 50.0a1 07:09:42 INFO - mozversion platform_buildid: 20160630043019 07:09:42 INFO - mozversion platform_changeset: bcf4ff0c3eef498cd853a88270c75c161e524549 07:09:42 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:09:42 INFO - mozversion platform_version: 50.0a1 07:09:42 INFO - using testdate: 1467295782 07:09:42 INFO - actual date: 1467295782 07:09:42 INFO - starting webserver on 'localhost:56749' 07:09:42 INFO - SUITE-START | Running 2 tests 07:09:42 INFO - TEST-START | dromaeo_css 07:09:42 INFO - operating with platform_type : linux_ 07:09:42 INFO - Initialising browser for dromaeo_css test... 07:09:42 INFO - TEST-INFO | started process 10401 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbgaijz/profile http://localhost:56749/getInfo.html) 07:09:46 INFO - PROCESS | 10401 | __metrics Screen width/height:1600/1200 07:09:46 INFO - PROCESS | 10401 | colorDepth:24 07:09:46 INFO - PROCESS | 10401 | Browser inner width/height: 1024/697 07:09:46 INFO - PROCESS | 10401 | __metrics 07:09:47 INFO - PROCESS | 10401 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:09:48 INFO - TEST-INFO | 10401: exit 0 07:09:48 INFO - Browser initialized. 07:09:48 INFO - Running cycle 1/1 for dromaeo_css test... 07:09:48 INFO - TEST-INFO | started process 10484 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbgaijz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:09:59 INFO - PROCESS | 10484 | RSS: Main: 157216768 07:09:59 INFO - PROCESS | 10484 | 07:10:51 INFO - PROCESS | 10484 | 1467295851564 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] 07:12:59 INFO - PROCESS | 10484 | Cycle 1(1): loaded http://localhost:56749/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56749/tests/dromaeo/cssquery-ext.html) 07:13:00 INFO - PROCESS | 10484 | RSS: Main: 251871232 07:13:00 INFO - PROCESS | 10484 | 07:16:02 INFO - PROCESS | 10484 | Cycle 1(1): loaded http://localhost:56749/tests/dromaeo/cssquery-ext.html (next: http://localhost:56749/tests/dromaeo/cssquery-jquery.html) 07:16:03 INFO - PROCESS | 10484 | RSS: Main: 243691520 07:16:03 INFO - PROCESS | 10484 | 07:19:05 INFO - PROCESS | 10484 | Cycle 1(1): loaded http://localhost:56749/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56749/tests/dromaeo/cssquery-mootools.html) 07:19:05 INFO - PROCESS | 10484 | RSS: Main: 250089472 07:19:05 INFO - PROCESS | 10484 | 07:22:07 INFO - PROCESS | 10484 | Cycle 1(1): loaded http://localhost:56749/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56749/tests/dromaeo/cssquery-prototype.html) 07:22:08 INFO - PROCESS | 10484 | RSS: Main: 234340352 07:22:08 INFO - PROCESS | 10484 | 07:25:11 INFO - PROCESS | 10484 | Cycle 1(1): loaded http://localhost:56749/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56749/tests/dromaeo/cssquery-yui.html) 07:25:11 INFO - PROCESS | 10484 | RSS: Main: 223801344 07:25:11 INFO - PROCESS | 10484 | 07:28:15 INFO - PROCESS | 10484 | Cycle 1(1): loaded http://localhost:56749/tests/dromaeo/cssquery-yui.html (next: http://localhost:56749/tests/dromaeo/cssquery-dojo.html) 07:28:15 INFO - PROCESS | 10484 | RSS: Main: 272027648 07:28:15 INFO - PROCESS | 10484 | 07:28:15 INFO - PROCESS | 10484 | __start_tp_report 07:28:15 INFO - PROCESS | 10484 | _x_x_mozilla_page_load 07:28:15 INFO - PROCESS | 10484 | _x_x_mozilla_page_load_details 07:28:15 INFO - PROCESS | 10484 | |i|pagename|runs| 07:28:15 INFO - PROCESS | 10484 | |0;dojo.html;3103.3638104188644;3134.279115803365;3136.9686303136978;3173.444647186742;3193.792403493773;5195.974020129894;5276.604254680905;5289.444608316129;5403.567714582829;5411.621186516945;5292.576593872491;5327.307450031501;5342.626016178869;5366.034113859504;5423.755930983105;4835.371401717772;4839.540243676845;4844.563989240967;4856.97571512142;5017.874553136183;4920.557149856512;4949.208126699728;4966.428860681031;4986.4514903360605;4989;4651.162790697673;4772.976135119302;4820.180569303227;4839.491853355382;4861.708297502161;4790.904181916342;4818.542238487338;4820.927686084711;4891.657583969088;4914.655974081816;4871.342368780205;4875.58557522611;4881.096997055521;4886.242632391985;4887.340209071801;5126.359205099363;5213.00952818967;5288.048151332759;5365.570754339644;5372.274742909696;5690.918725442153;5695.943040569583;5724.227229324071;5725.341585717654;5725.570582206351;5468.207109969032;5784.652920824764;5785.479306862402;5790.623609465371;5795.913061304083;5253.343332083489;5303.257543943851;5304.310439642822;5333.146696528537;5337.599680024014;5840.123981402823;5895.380984996514;5897.262842144732;5899.616524925866;5903.557233207526;5327.600429967768;5520.282363292827;5675.716214189274;5679.630823996427;5683.062294721407;5616.634918730269;5721.199032135504;5724.313082430135;5724.771009159587;5725.6850873202375;5665;5673.716314184357;5677.943220567824;5679.346875109415;5682.971585142131;5379.462053794668;5593.524550413179;5639.859003524863;5677.432256774289;5679.488846003879;4367.257566213688;4375.256206444912;4384;4419.447569053868;4429.269170586882;3889.7277190596387;3929.0766669832565;3934.744241624285;3949.3681011038097;3968.1270120573427;5196.324477817935;5198.81804136861;5312.628116031918;5368.8389348319615;5457.972710136424;5650.406707295757;5680.687562184037;5680.857978550569;5695.515881150149;5710.600257981984;5404.540614047772;5416.322959630046;5418.512333889968;5424.213489044146;5435.266239057677;4601.677882548256;4655.580997710223;4662.230731929194;4689.249720044776;4736.550027747358;5798.536117110621;5799.710014499258;5801.448862357985;5804.2744656917885;5806;5443.755031023535;5562.944370556243;5579.330480342385;5585.916211256916;5643.943560564342;5747.051736463604;5761.942380576141;5791.507721843691;5855;5869.148973398748;5509.559235261249;5512.944870551403;5513.724313784214;5518.724063796874;5519.3652729936575;5496.917546236729;5613.410591887956;5615.241942337732;5622.269105016322;5632.9436705632415;5393.40672526014;5433.293671822637;5448.673079615236;5481.945180548143;5497.312835895513;5467.917981230205;5468.097763868917;5468.125099983983;5470.972645136749;5478.945210547843;5283.392409872914;5360.646105739;5363.892722145457;5399.05516534597;5471.452854714496;5485.862853428696;5543.334799824047;5565.443455654402;5604.495595396434;5618.381977982337;5480.780768769364;5487.725613719378;5495.2856128703015;5495.890082198413;5498.422665620053 07:28:15 INFO - PROCESS | 10484 | |1;ext.html;598.5480961873785;625.9436650701437;631.9557630965832;632.1813251838871;647.604960973806;33429.83285083577;42561.14877702448;43406.78296608521;43431.56568434315;43537.564624353785;44256.778716106375;44751;44788.55211447884;44923.32615010769;44931.10137797242;7991.440599158062;8973.416727912681;9086;9108.089191080871;9117.407368521059;8202.794930126765;8260.421770476069;10538.209634277422;10779.08377787889;10784.73038174044;10873.238873278873;10919.727006824813;10927.180461465383;10935.070519005894;10939;10762.946185269062;10807.729806754816;10832.350058996486;10853.674389768319;10858.23992320538;10683.732906677318;10741.140708743282;10754.139668826476;10758;10763.031327180592;41431.171376572296;41693;41754.37368439446;41797.37303940443;41846.37230441546;3382.6955573998457;3430.588329400463;3523.0663874073134;3955.5846636103083;4103.220388126247;31883.202919926956;31996.520052199237;32039.679603203902;32075;33663.32673346519;4389.231884420214;4438.526409232139;4475.597196252353;4501.27979523278;4568.132054909556;341877;345565;346545;347595;348871;37687;56922;57019.42980570141;57159.42840571541;57330.71334643383;38315.425268620995;38518.42222366667;38619;38620;38646.806765965994;14013.649658758613;14059.437622494986;14160.150390976574;14161.504347347793;14164.079334843202;10928.453577321103;11811.291322520676;11866.88133118675;11879.643610691694;11883.584074557522;8680.913190868137;8891.422057566237;8904.688335908211;8924.419912705653;9013.414128081653;3455.06713187438;3463.41122009259;3486.5118883355844;3489.685928266468;3508.52634894286;1024.7847951930178;1048.3267667448129;1056.75166335911;1060.316096118015;1122.9831552526718;32538.349233015208;32634.510482342783;32687;32833.835830820695;32960;1118.072000239799;1126.7070561653866;1150.3385553306882;1220.365409986802;1287.716702325487;16998.490045298662;16999.40502082421;17115;17140.742888856676;17315.220815063352;510296;511621;517042;520159;520886;56777.432225677214;57217.42782572204;57368.426315737146;57372.71313643488;57384.71307643435;1238.3065483329365;1334.1461464662623;1349.7570437321376;1356.4574170331748;1405.0796728142877;31919.36161276715;33206.667933321325;33585.49621755627;33712.49431258582;33801.661983379854;48570;49011;49032.75483622559;49055.26417103818;49160;393013;394072;394823;395923;396154;25257.621135682613;26802.59796103099;29122.27194320159;30205;30317.787288508214;47605.28592071052;47767.522324776306;48541;48702;48720.26919596138;40744.79627601843;41171.58828411678;41655.7917210412;41820;42298;41342.37986430266;41350.37974430326;41564.79217603893;42102.578974209864;42200.36699449572;41122;41338;41563.1687366257;43691.78154109209;44388.334174986754;35075.649243507236;37282.81358593189;37625.79174436187;37761.81119094387;38416.23167536578;28103.859480702467;28204.71795282021;28451.288717781394;28458.85770571134;28525.28686782847 07:28:15 INFO - PROCESS | 10484 | |2;jquery.html;399.4367941202905;400.4453831443451;401.9115794525204;405.6166922258465;418.8054593927819;13215.669608259774;17942.820571794276;19592.314269000588;19600.31398901039;19939.800601993975;14547.199904005276;18498.445046648587;18831.90584047078;18983.81016189838;19795;5641.210230567714;5997.100434934773;6001.579889407743;6030.065339872327;6031.668258245794;5969.432903874147;6008.8497787555225;6014.578979471439;6015.037593984964;6016.518678505731;4282.97858510707;6285.874282514347;6583.80248592543;6585.802425927206;6674.232463266713;5559.8888022239325;5902.085176797603;6723.495737819659;6727.932720672804;6736.898946515782;5667.801626943037;5737.655740655574;5776.480116789509;5784.537237021071;5786.450287222707;14558.199299038548;14612.926935365362;21629.567408651896;23992.28023159308;24691.38271543208;2230.208276062007;2261.7738226177416;2283.3492454650345;2318.3392733070996;2351.8824058797163;10624.521896514676;10660.253782235246;10757.892421075767;13136.211827290394;13493.2578708171;1885.7265696474071;1973.7730161031523;1987.3441764217773;1999.8500112491622;2191.2659259148204;80948;83554.58222708908;83716.16283837205;88312.55843720805;90951;11036.448177591248;11100.777984440267;11407.828882566768;11412.201145919871;11836.822447663291;16095.114768687834;16184.433544825875;16206.594835129215;16265.268062937197;16282.348706051625;8043.83912321762;8215.507069575844;8256.628451719567;8349.749507514784;8355.623996920152;7697.653605587762;7711.460197786213;7720.575368354682;7895.9210407896335;7939.6256590948615;4473;4688.226442636927;5016.921361907207;5023.447420783711;5119.564836988823;2027.513396784761;2116.2698868890207;2136;2139.893005349726;2147.2055339524163;939.4645052320249;1012.2357619996856;1034.730969947819;1047;1049.2602715085845;19476.707849381986;19606.901965490368;19974.901380423926;20382.69425958612;20518;938.1697197979701;981.3719219699398;1000.2198285337303;1017.1201910347496;1109.046220250584;10384.065434110966;10856.782864342827;10891.945540272249;10986.073641273397;12185.207961482476;478917;484679;493568;503082;511818;93649.5317523408;96260;96915;97002.51498742461;97386.5130674342;1005.6027868991707;1018.7453136715822;1036.9948150259352;1046.795874804406;1055.1400608504198;17452.21465034102;17763.11184440747;17840;18625.72061419107;18695.626087477904;40991;41884;44127;44147.337789933816;44618.553814462735;50430.747846260536;50763.23855142102;59183;60137;60279.69860150671;9084.591193396445;9116.27069834425;9249.213816825646;9479.38384005065;9501.382410143318;10489.47552622381;14102.576922692335;14456.783148252574;14699.779503307673;15064.096154230781;11658;11888.702782430508;12625.368731563201;12701;12757.617271481871;11899.345535995604;12113.576024839089;12185.939070304592;12520.937395312965;12644.747105058032;12435.316057616918;12496.687582810502;12659.367031648197;12675;12688.365581721062;8920.55397230123;9187;9187.632494700138;9299.814003720023;9395.765105872135;9451.480168590793;12236.694082648006;12500.062495312706;12502.187357822077;12519.374031298217 07:28:15 INFO - PROCESS | 10484 | |3;mootools.html;1500.5798376454593;1530.1278271385308;1658.8009438867339;1784.3843873863514;1801.6756983742937;8557.871631925525;9021.548922553879;9118.133777291156;9123.77190570236;9148.954255228722;7836.960815195916;8485.193906578881;8711.30309575234;8736.388452808305;8982.461052336848;2292.025888997178;2311.6648086027517;2318.7449380568123;2319.083961835074;2319.257837492003;2299.275728145637;2302.8503147295373;2347.612643913752;2353.6116540770754;2363.1492662641435;1989.333573252962;2211.4803021289986;2311.0640190722784;2311.630139177732;2326.6161083421216;2311.6879221305076;2315.918942837001;2335.964960525585;2336.5210131922913;2336.894839732216;2312.1329501436962;2323.9070437182663;2328.336424119118;2331.801796847253;2338.088145623208;8908.331875109392;8975;8984;8990.505522196276;8995.910040899573;5065.645404821664;5127.820526281562;5172.612054095958;5177.741112944338;5177.76700048495;3395.7792743471596;3469.462233353834;3476.513288139637;3513.5959364672876;3542.5394698689265;1175.4240422193063;1178.9233699809486;1203.6328919679495;1207.4928530017414;2186.191109289557;11910.702232444171;12443.875561244362;12447.502099915993;12470.189437686611;12479.126461147724;4144.606262405066;4283.528811830696;4337.631301339358;4339.7613131278085;4504.887377815581;9507.619695212114;9585.137337639646;9603.231741460666;9632.711018669452;9646.614135434644;5105.923411148836;5117.718525481134;5120.513551212629;5130.897382052338;5143.5113664201845;4730.95269047312;4809.5430934061205;4813.566778989908;4827.034593081397;4831.396075490564;3702.500162478085;3709.666130048309;3720.2187540616233;3782.867599634;3817.389217725206;1057.9365238085738;1087.7606926476162;1118.8881111888745;1123.2474242257706;1137.192593258779;914.7164379042385;917.7934964632905;938.2259635800492;941.1811723800338;971.2036130373026;5663.377028526858;5680.176374425768;5694.817715878531;5756.7121643917635;5935.73289201987;957.5403806173076;978.471625322318;980.5391466010964;987.4420952162005;1001.3191030099457;3740.1958578905123;3784.3566593679143;3814.48504451901;3845.4616353710503;3896.1428485733095;10918.454077296263;11407.08743300534;11425.885741142481;11432.31406115619;11441.141914356456;10481.37111773296;10914.017738403423;10924.2899211551;11297.039751621205;11299.20905536621;8126.10612832588;8170.673173073011;8278.130796266425;8286.627101780314;8336.291415229773;5715.971420142872;5798.391168927202;5895.29256489224;5903.822885313448;6156.907646385397;9887.55506002246;9893.455859927773;9996.700098997042;10177.694669159937;10178.440185789852;10382.42896640692;10415.53130109162;10534.051935325857;10925.125989920945;10933.343999360064;7781.572013539309;7989.800254993672;8030.87953680707;8073.35413166957;8147.877781833158;8794.91205087941;8864.113588641085;8889;8921.464712117035;8926.68756593516;7667.156612772702;7793.1427542969095;7813.3749300057;7932.325752310888;8232.053313868742;7802.531848089133;7878.054633444023;7913.208679132041;7989.560574168477;8033.598320084089;6510.0885875976455;6831.11195544576;6868.210155831944;6870.45036397097;6880.380765731108;4911.165101932752;4969.850904472872;5019.347484826949;5038.823641172541;5067.645264831426;4972.154733695208;5052.69683818972;5061.31672224245;5061.746912654279;5147.871303217449 07:28:15 INFO - PROCESS | 10484 | |4;prototype.html;318.22670909689447;329.22796043278504;331.5275732081784;332.4896284203748;339.1216748621071;5426.972865135674;5465.726713664316;5473.452654734535;5483.341998960131;5519.613627046108;5297.152455607104;5316.574674026078;5367.919481207785;5416.377116631588;5416.458354164582;3996.780177090259;4114.8148333324925;4135.27632664284;4187.455630768011;4206.179794939988;4158.792060396983;4183.937240941388;4197.328427451608;4204.117135401554;4211.263028969934;4168.729032612886;4177.895552611194;4179.247735407625;4180.686448516358;4209.34755112958;3983.7211395202203;3994.3409337459284;4205.789710514462;4208.137331846964;4212.7682977436225;3680.871169509054;3714.6255885322335;3721.925561488782;3732.9440058399146;3735.972607532923;5271.130263506517;5287.206918962148;5287.524122828925;5293.788248470057;5299;4739.4075740532435;4796.585007422818;4805.327254184417;4827.662063655511;4854.878628034292;5555.555555555546;5584.682356821914;5597.608167428281;5606.831795046155;5635.380108188096;4067.572904845008;4102.097538541516;4103.363978583325;4117.526484454296;4127.772972486512;5553.972230138824;5833.32916714579;5842.24050873388;5852.6488410695065;5901.3803550627;4017.5781542938157;4021.5120405449584;4049.8987525311513;4056.2495938250927;4065.166640838621;4094.6314831665295;4101.610347017028;4116.423700681847;4128.307393968458;4136.200752672597;4572.908541829212;4786.44955830077;4786.832460863853;4799.544043315879;4807.927881081787;5610.382857885711;5670.092785154356;5675.2054712340305;5679.744411501492;5688.772449102073;1430.5493769462587;1434.7202295552268;1447.0811034992855;1447.1461837515917;1447.9565613031625;902.2902079482043;907.5099446299057;916.619602864817;948.2935213266161;967.7677357434305;5376.1398176291605;5400.297961265089;5406.378086574091;5417.566594672417;5440.836774896759;5675.659460432387;5700.6888415664625;5711.914321285184;5724.255846739898;5747.798827041117;5173.198154286091;5421.457854214547;5428.4028756836715;5432.864178395572;5449.811860061829;3016.577679124924;3026.6065411496807;3036.620422447194;3059.72462478378;3061.3724186541704;5651.745671444794;5929.37741537141;5943.31651860033;5952.9107063394085;5959.046552551571;5779.133130030529;5784.623999440023;5830.300363956268;5834.533237341087;5839.861227060767;5863.384344643836;5868.295804503487;5872.853178670567;5884.6469211847425;5889.469947704727;5361.383440904346;5625.128105143709;5641.915371269352;5653.717314134195;5657.2928383952;5587.413321601336;5639.436056394327;5645.294338207724;5670.688112153871;5674.971625141848;5750.7987220447085;5830.038043722908;5830.941690583039;5842.474177324061;5858.9121163181735;3886.96113038866;4127.442795222607;4139.254934111888;4142.420061191376;4157.168566286694;5841.773227622247;5868.354481007001;5893.410658934244;5914.201582786269;5915.822525324247;5448.264484294569;5688.146777983336;5697.943020569741;5748.856278593069;5761.48146666802;5613.915791263053;5620.915686264628;5664.178694089416;5675.971620141873;5677.261955945701;5369.758360873692;5422.864428389322;5536.200734761138;5555.250041244381;5631.774729010794;5582.218489411567;5602.187682786055;5620.747066382104;5640.266765320482;5648.943510564842;5519.503244707996;5545.500904918576;5560.555155587463;5577.637453565505;5584.804531841366 07:28:15 INFO - PROCESS | 10484 | |5;yui.html;698.8776964031297;706.7491040680558;737.5464089584904;759.1952530317867;790.537535541708;14978.400863965442;15687.29407176677;15730.37078516858;15806.762898556517;15810.972286801365;14262.215578143197;14367.209803460806;14377.209253491053;14396.28018599071;14396.928015359934;650.4146268358492;775.7246177606938;783.7217787685375;806.1092492795465;809.7449303469418;797.09927781607;800.8798680197958;802.9718959836407;803.8352137811735;804.191787253812;849.362977766675;850.2942557677113;850.3579797253096;850.3962186847345;850.6597361055566;686.6806934775328;823.5347028928666;836.1680128272347;836.481381543447;839.0015881101469;623.0996210475864;623.7847942459844;623.7941479311817;624.048326302388;625.1529177963885;15022.09867407959;15064.623384415368;15087.39650413982;15115.31981060855;15120.621984450367;14775.70448591033;14831.925840370837;14838.480653177086;14897.70204595902;15159.545213643609;11300.717482062932;11508;11535;11576.305421674642;12159.392030398445;4556.749378784166;4556.863294101149;4731.172044892164;4841.080194762983;4841.15279826029;77591.61204194;77674.6116269415;77706.6114669423;77815;77858.6107069461;9958;10048.799024019625;10165.186785057178;10213.314803057412;10263.7434064149;22126.88936555339;22148.778512214994;22156.556868862855;22162.667559986614;22342.21802236914;8254.339652827759;8471.152884711602;8642.913570864212;8727.345449091217;8937;4565.246734288871;4591.908161836812;4598.471175814757;4607.3319368691355;4942.728149951715;3529.294141171776;3631.94552081719;3632.56409230894;3637.5816781069984;3639.454081887685;607.3228350389284;610.4932905688268;610.6610830988844;611.9571629985948;635.4757325206723;581.354696287121;673.192169396716;677.5607811877203;678.1116737074449;678.9898151527731;9506;9523.761905952268;9651.227901767841;9721.951390243144;10092.899071009342;609.6646844235653;642.9776655118291;650.7494614573424;658.6278752504819;694.5797792335565;4370.606645401929;4440.311751678495;4452;4465.866024019285;4548.113117942035;113276;116006;116158;118405.40797295958;119748;60734;102384.48807756063;103464.48267758613;103486;104981;82006;90795;96457.51771240958;97206.51396742971;97427.05145897043;9875.209983201183;10469.9476502617;10694.518746656264;10720.142388609049;10788.136949044214;55732;57968;58044.41955580559;58634.7068264656;59111;78987.21012790028;79666.6016669936;86560.13439865521;86688.5665571668;87914;11176.273542220055;11314.886851131383;11614.941925290319;12073.939630302144;14272.928635356757;12450.190737602026;12838.743225135631;13415.396307166397;14119.788203177166;14877.47928822486;12597.307148106942;13207.219457002439;13476.595702128952;13514.72970540564;14426.783598246244;14002.439449381263;14829.555113346616;15136.697266054838;15174.24128793578;15370.769438458208;13274.535391261259;13545.729085418434;13615.115017523829;13892;13964.720705586034;12049.277043377426;12215.26708397499;12293.323867187391;12348.814767778671;12621.81067283973;12075.57735479254;12287.93856030714;12391.799091658835;12468.875311247135;12548.749025019632 07:28:15 INFO - PROCESS | 10484 | __end_tp_report 07:28:15 INFO - PROCESS | 10484 | __start_cc_report 07:28:15 INFO - PROCESS | 10484 | _x_x_mozilla_cycle_collect,868 07:28:15 INFO - PROCESS | 10484 | __end_cc_report 07:28:15 INFO - PROCESS | 10484 | __startTimestamp1467296895334__endTimestamp 07:28:15 INFO - PROCESS | 10484 | 07:28:15 INFO - PROCESS | 10484 | ------- Summary: start ------- 07:28:15 INFO - PROCESS | 10484 | Number of tests: 6 07:28:15 INFO - PROCESS | 10484 | 07:28:15 INFO - PROCESS | 10484 | [#0] dojo.html Cycles:165 Average:5262.67 Median:5443.76 stddev:576.85 (10.6%) stddev-sans-first:553.19 07:28:15 INFO - PROCESS | 10484 | Values: 3103.4 3134.3 3137.0 3173.4 3193.8 5196.0 5276.6 5289.4 5403.6 5411.6 5292.6 5327.3 5342.6 5366.0 5423.8 4835.4 4839.5 4844.6 4857.0 5017.9 4920.6 4949.2 4966.4 4986.5 4989.0 4651.2 4773.0 4820.2 4839.5 4861.7 4790.9 4818.5 4820.9 4891.7 4914.7 4871.3 4875.6 4881.1 4886.2 4887.3 5126.4 5213.0 5288.0 5365.6 5372.3 5690.9 5695.9 5724.2 5725.3 5725.6 5468.2 5784.7 5785.5 5790.6 5795.9 5253.3 5303.3 5304.3 5333.1 5337.6 5840.1 5895.4 5897.3 5899.6 5903.6 5327.6 5520.3 5675.7 5679.6 5683.1 5616.6 5721.2 5724.3 5724.8 5725.7 5665.0 5673.7 5677.9 5679.3 5683.0 5379.5 5593.5 5639.9 5677.4 5679.5 4367.3 4375.3 4384.0 4419.4 4429.3 3889.7 3929.1 3934.7 3949.4 3968.1 5196.3 5198.8 5312.6 5368.8 5458.0 5650.4 5680.7 5680.9 5695.5 5710.6 5404.5 5416.3 5418.5 5424.2 5435.3 4601.7 4655.6 4662.2 4689.2 4736.6 5798.5 5799.7 5801.4 5804.3 5806.0 5443.8 5562.9 5579.3 5585.9 5643.9 5747.1 5761.9 5791.5 5855.0 5869.1 5509.6 5512.9 5513.7 5518.7 5519.4 5496.9 5613.4 5615.2 5622.3 5632.9 5393.4 5433.3 5448.7 5481.9 5497.3 5467.9 5468.1 5468.1 5471.0 5478.9 5283.4 5360.6 5363.9 5399.1 5471.5 5485.9 5543.3 5565.4 5604.5 5618.4 5480.8 5487.7 5495.3 5495.9 5498.4 07:28:15 INFO - PROCESS | 10484 | 07:28:15 INFO - PROCESS | 10484 | [#1] ext.html Cycles:180 Average:57427.66 Median:37724.41 stddev:112589.23 (298.5%) stddev-sans-first:112824.22 07:28:15 INFO - PROCESS | 10484 | Values: 598.5 625.9 632.0 632.2 647.6 33429.8 42561.1 43406.8 43431.6 43537.6 44256.8 44751.0 44788.6 44923.3 44931.1 7991.4 8973.4 9086.0 9108.1 9117.4 8202.8 8260.4 10538.2 10779.1 10784.7 10873.2 10919.7 10927.2 10935.1 10939.0 10762.9 10807.7 10832.4 10853.7 10858.2 10683.7 10741.1 10754.1 10758.0 10763.0 41431.2 41693.0 41754.4 41797.4 41846.4 3382.7 3430.6 3523.1 3955.6 4103.2 31883.2 31996.5 32039.7 32075.0 33663.3 4389.2 4438.5 4475.6 4501.3 4568.1 341877.0 345565.0 346545.0 347595.0 348871.0 37687.0 56922.0 57019.4 57159.4 57330.7 38315.4 38518.4 38619.0 38620.0 38646.8 14013.6 14059.4 14160.2 14161.5 14164.1 10928.5 11811.3 11866.9 11879.6 11883.6 8680.9 8891.4 8904.7 8924.4 9013.4 3455.1 3463.4 3486.5 3489.7 3508.5 1024.8 1048.3 1056.8 1060.3 1123.0 32538.3 32634.5 32687.0 32833.8 32960.0 1118.1 1126.7 1150.3 1220.4 1287.7 16998.5 16999.4 17115.0 17140.7 17315.2 510296.0 511621.0 517042.0 520159.0 520886.0 56777.4 57217.4 57368.4 57372.7 57384.7 1238.3 1334.1 1349.8 1356.5 1405.1 31919.4 33206.7 33585.5 33712.5 33801.7 48570.0 49011.0 49032.8 49055.3 49160.0 393013.0 394072.0 394823.0 395923.0 396154.0 25257.6 26802.6 29122.3 30205.0 30317.8 47605.3 47767.5 48541.0 48702.0 48720.3 40744.8 41171.6 41655.8 41820.0 42298.0 41342.4 41350.4 41564.8 42102.6 42200.4 41122.0 41338.0 41563.2 43691.8 44388.3 35075.6 37282.8 37625.8 37761.8 38416.2 28103.9 28204.7 28451.3 28458.9 28525.3 07:28:15 INFO - PROCESS | 10484 | 07:28:15 INFO - PROCESS | 10484 | [#2] jquery.html Cycles:180 Average:29503.92 Median:2272.56 stddev:81647.60 (3592.8%) stddev-sans-first:81847.40 07:28:15 INFO - PROCESS | 10484 | Values: 399.4 400.4 401.9 405.6 418.8 13215.7 17942.8 19592.3 19600.3 19939.8 14547.2 18498.4 18831.9 18983.8 19795.0 5641.2 5997.1 6001.6 6030.1 6031.7 5969.4 6008.8 6014.6 6015.0 6016.5 4283.0 6285.9 6583.8 6585.8 6674.2 5559.9 5902.1 6723.5 6727.9 6736.9 5667.8 5737.7 5776.5 5784.5 5786.5 14558.2 14612.9 21629.6 23992.3 24691.4 2230.2 2261.8 2283.3 2318.3 2351.9 10624.5 10660.3 10757.9 13136.2 13493.3 1885.7 1973.8 1987.3 1999.9 2191.3 80948.0 83554.6 83716.2 88312.6 90951.0 11036.4 11100.8 11407.8 11412.2 11836.8 16095.1 16184.4 16206.6 16265.3 16282.3 8043.8 8215.5 8256.6 8349.7 8355.6 7697.7 7711.5 7720.6 7895.9 7939.6 4473.0 4688.2 5016.9 5023.4 5119.6 2027.5 2116.3 2136.0 2139.9 2147.2 939.5 1012.2 1034.7 1047.0 1049.3 19476.7 19606.9 19974.9 20382.7 20518.0 938.2 981.4 1000.2 1017.1 1109.0 10384.1 10856.8 10891.9 10986.1 12185.2 478917.0 484679.0 493568.0 503082.0 511818.0 93649.5 96260.0 96915.0 97002.5 97386.5 1005.6 1018.7 1037.0 1046.8 1055.1 17452.2 17763.1 17840.0 18625.7 18695.6 40991.0 41884.0 44127.0 44147.3 44618.6 50430.7 50763.2 59183.0 60137.0 60279.7 9084.6 9116.3 9249.2 9479.4 9501.4 10489.5 14102.6 14456.8 14699.8 15064.1 11658.0 11888.7 12625.4 12701.0 12757.6 11899.3 12113.6 12185.9 12520.9 12644.7 12435.3 12496.7 12659.4 12675.0 12688.4 8920.6 9187.0 9187.6 9299.8 9395.8 9451.5 12236.7 12500.1 12502.2 12519.4 07:28:15 INFO - PROCESS | 10484 | 07:28:15 INFO - PROCESS | 10484 | [#3] mootools.html Cycles:180 Average:5802.60 Median:4995.75 stddev:3343.20 (66.9%) stddev-sans-first:3336.95 07:28:15 INFO - PROCESS | 10484 | Values: 1500.6 1530.1 1658.8 1784.4 1801.7 8557.9 9021.5 9118.1 9123.8 9149.0 7837.0 8485.2 8711.3 8736.4 8982.5 2292.0 2311.7 2318.7 2319.1 2319.3 2299.3 2302.9 2347.6 2353.6 2363.1 1989.3 2211.5 2311.1 2311.6 2326.6 2311.7 2315.9 2336.0 2336.5 2336.9 2312.1 2323.9 2328.3 2331.8 2338.1 8908.3 8975.0 8984.0 8990.5 8995.9 5065.6 5127.8 5172.6 5177.7 5177.8 3395.8 3469.5 3476.5 3513.6 3542.5 1175.4 1178.9 1203.6 1207.5 2186.2 11910.7 12443.9 12447.5 12470.2 12479.1 4144.6 4283.5 4337.6 4339.8 4504.9 9507.6 9585.1 9603.2 9632.7 9646.6 5105.9 5117.7 5120.5 5130.9 5143.5 4731.0 4809.5 4813.6 4827.0 4831.4 3702.5 3709.7 3720.2 3782.9 3817.4 1057.9 1087.8 1118.9 1123.2 1137.2 914.7 917.8 938.2 941.2 971.2 5663.4 5680.2 5694.8 5756.7 5935.7 957.5 978.5 980.5 987.4 1001.3 3740.2 3784.4 3814.5 3845.5 3896.1 10918.5 11407.1 11425.9 11432.3 11441.1 10481.4 10914.0 10924.3 11297.0 11299.2 8126.1 8170.7 8278.1 8286.6 8336.3 5716.0 5798.4 5895.3 5903.8 6156.9 9887.6 9893.5 9996.7 10177.7 10178.4 10382.4 10415.5 10534.1 10925.1 10933.3 7781.6 7989.8 8030.9 8073.4 8147.9 8794.9 8864.1 8889.0 8921.5 8926.7 7667.2 7793.1 7813.4 7932.3 8232.1 7802.5 7878.1 7913.2 7989.6 8033.6 6510.1 6831.1 6868.2 6870.5 6880.4 4911.2 4969.9 5019.3 5038.8 5067.6 4972.2 5052.7 5061.3 5061.7 5147.9 07:28:15 INFO - PROCESS | 10484 | 07:28:15 INFO - PROCESS | 10484 | [#4] prototype.html Cycles:180 Average:4727.45 Median:5430.63 stddev:1390.50 (25.6%) stddev-sans-first:1354.44 07:28:15 INFO - PROCESS | 10484 | Values: 318.2 329.2 331.5 332.5 339.1 5427.0 5465.7 5473.5 5483.3 5519.6 5297.2 5316.6 5367.9 5416.4 5416.5 3996.8 4114.8 4135.3 4187.5 4206.2 4158.8 4183.9 4197.3 4204.1 4211.3 4168.7 4177.9 4179.2 4180.7 4209.3 3983.7 3994.3 4205.8 4208.1 4212.8 3680.9 3714.6 3721.9 3732.9 3736.0 5271.1 5287.2 5287.5 5293.8 5299.0 4739.4 4796.6 4805.3 4827.7 4854.9 5555.6 5584.7 5597.6 5606.8 5635.4 4067.6 4102.1 4103.4 4117.5 4127.8 5554.0 5833.3 5842.2 5852.6 5901.4 4017.6 4021.5 4049.9 4056.2 4065.2 4094.6 4101.6 4116.4 4128.3 4136.2 4572.9 4786.4 4786.8 4799.5 4807.9 5610.4 5670.1 5675.2 5679.7 5688.8 1430.5 1434.7 1447.1 1447.1 1448.0 902.3 907.5 916.6 948.3 967.8 5376.1 5400.3 5406.4 5417.6 5440.8 5675.7 5700.7 5711.9 5724.3 5747.8 5173.2 5421.5 5428.4 5432.9 5449.8 3016.6 3026.6 3036.6 3059.7 3061.4 5651.7 5929.4 5943.3 5952.9 5959.0 5779.1 5784.6 5830.3 5834.5 5839.9 5863.4 5868.3 5872.9 5884.6 5889.5 5361.4 5625.1 5641.9 5653.7 5657.3 5587.4 5639.4 5645.3 5670.7 5675.0 5750.8 5830.0 5830.9 5842.5 5858.9 3887.0 4127.4 4139.3 4142.4 4157.2 5841.8 5868.4 5893.4 5914.2 5915.8 5448.3 5688.1 5697.9 5748.9 5761.5 5613.9 5620.9 5664.2 5676.0 5677.3 5369.8 5422.9 5536.2 5555.3 5631.8 5582.2 5602.2 5620.7 5640.3 5648.9 5519.5 5545.5 5560.6 5577.6 5584.8 07:28:15 INFO - PROCESS | 10484 | 07:28:15 INFO - PROCESS | 10484 | [#5] yui.html Cycles:180 Average:21473.14 Median:4458.93 stddev:31118.80 (697.9%) stddev-sans-first:31167.00 07:28:15 INFO - PROCESS | 10484 | Values: 698.9 706.7 737.5 759.2 790.5 14978.4 15687.3 15730.4 15806.8 15811.0 14262.2 14367.2 14377.2 14396.3 14396.9 650.4 775.7 783.7 806.1 809.7 797.1 800.9 803.0 803.8 804.2 849.4 850.3 850.4 850.4 850.7 686.7 823.5 836.2 836.5 839.0 623.1 623.8 623.8 624.0 625.2 15022.1 15064.6 15087.4 15115.3 15120.6 14775.7 14831.9 14838.5 14897.7 15159.5 11300.7 11508.0 11535.0 11576.3 12159.4 4556.7 4556.9 4731.2 4841.1 4841.2 77591.6 77674.6 77706.6 77815.0 77858.6 9958.0 10048.8 10165.2 10213.3 10263.7 22126.9 22148.8 22156.6 22162.7 22342.2 8254.3 8471.2 8642.9 8727.3 8937.0 4565.2 4591.9 4598.5 4607.3 4942.7 3529.3 3631.9 3632.6 3637.6 3639.5 607.3 610.5 610.7 612.0 635.5 581.4 673.2 677.6 678.1 679.0 9506.0 9523.8 9651.2 9722.0 10092.9 609.7 643.0 650.7 658.6 694.6 4370.6 4440.3 4452.0 4465.9 4548.1 113276.0 116006.0 116158.0 118405.4 119748.0 60734.0 102384.5 103464.5 103486.0 104981.0 82006.0 90795.0 96457.5 97206.5 97427.1 9875.2 10469.9 10694.5 10720.1 10788.1 55732.0 57968.0 58044.4 58634.7 59111.0 78987.2 79666.6 86560.1 86688.6 87914.0 11176.3 11314.9 11614.9 12073.9 14272.9 12450.2 12838.7 13415.4 14119.8 14877.5 12597.3 13207.2 13476.6 13514.7 14426.8 14002.4 14829.6 15136.7 15174.2 15370.8 13274.5 13545.7 13615.1 13892.0 13964.7 12049.3 12215.3 12293.3 12348.8 12621.8 12075.6 12287.9 12391.8 12468.9 12548.7 07:28:15 INFO - PROCESS | 10484 | -------- Summary: end -------- 07:28:15 INFO - PROCESS | 10484 | 07:28:15 INFO - TEST-INFO | 10484: exit 0 07:28:15 INFO - TEST-OK | dromaeo_css | took 1113676ms 07:28:15 INFO - TEST-START | kraken 07:28:15 INFO - operating with platform_type : linux_ 07:28:15 INFO - Initialising browser for kraken test... 07:28:15 INFO - TEST-INFO | started process 10676 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAaHjo_/profile http://localhost:56749/getInfo.html) 07:28:19 INFO - PROCESS | 10676 | __metrics Screen width/height:1600/1200 07:28:19 INFO - PROCESS | 10676 | colorDepth:24 07:28:19 INFO - PROCESS | 10676 | Browser inner width/height: 1024/697 07:28:19 INFO - PROCESS | 10676 | __metrics 07:28:20 INFO - PROCESS | 10676 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:28:21 INFO - TEST-INFO | 10676: exit 0 07:28:21 INFO - Browser initialized. 07:28:21 INFO - Running cycle 1/1 for kraken test... 07:28:21 INFO - TEST-INFO | started process 10757 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAaHjo_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:28:33 INFO - PROCESS | 10757 | RSS: Main: 158003200 07:28:33 INFO - PROCESS | 10757 | 07:28:35 INFO - PROCESS | 10757 | Cycle 1(1): loaded http://localhost:56749/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56749/tests/kraken/driver.html?testName=audio-beat-detection) 07:28:36 INFO - PROCESS | 10757 | RSS: Main: 215670784 07:28:36 INFO - PROCESS | 10757 | 07:28:39 INFO - PROCESS | 10757 | Cycle 1(1): loaded http://localhost:56749/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56749/tests/kraken/driver.html?testName=audio-dft) 07:28:39 INFO - PROCESS | 10757 | RSS: Main: 202919936 07:28:39 INFO - PROCESS | 10757 | 07:28:42 INFO - PROCESS | 10757 | Cycle 1(1): loaded http://localhost:56749/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56749/tests/kraken/driver.html?testName=audio-fft) 07:28:43 INFO - PROCESS | 10757 | RSS: Main: 268972032 07:28:43 INFO - PROCESS | 10757 | 07:28:45 INFO - PROCESS | 10757 | Cycle 1(1): loaded http://localhost:56749/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56749/tests/kraken/driver.html?testName=audio-oscillator) 07:28:46 INFO - PROCESS | 10757 | RSS: Main: 180068352 07:28:46 INFO - PROCESS | 10757 | 07:28:48 INFO - PROCESS | 10757 | Cycle 1(1): loaded http://localhost:56749/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56749/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:28:48 INFO - PROCESS | 10757 | RSS: Main: 184856576 07:28:48 INFO - PROCESS | 10757 | 07:28:51 INFO - PROCESS | 10757 | Cycle 1(1): loaded http://localhost:56749/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56749/tests/kraken/driver.html?testName=imaging-darkroom) 07:28:52 INFO - PROCESS | 10757 | RSS: Main: 218791936 07:28:52 INFO - PROCESS | 10757 | 07:28:55 INFO - PROCESS | 10757 | Cycle 1(1): loaded http://localhost:56749/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56749/tests/kraken/driver.html?testName=imaging-desaturate) 07:28:56 INFO - PROCESS | 10757 | RSS: Main: 220323840 07:28:56 INFO - PROCESS | 10757 | 07:28:59 INFO - PROCESS | 10757 | Cycle 1(1): loaded http://localhost:56749/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56749/tests/kraken/driver.html?testName=json-parse-financial) 07:28:59 INFO - PROCESS | 10757 | RSS: Main: 221020160 07:28:59 INFO - PROCESS | 10757 | 07:29:01 INFO - PROCESS | 10757 | Cycle 1(1): loaded http://localhost:56749/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56749/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:29:01 INFO - PROCESS | 10757 | RSS: Main: 208879616 07:29:01 INFO - PROCESS | 10757 | 07:29:03 INFO - PROCESS | 10757 | Cycle 1(1): loaded http://localhost:56749/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56749/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:29:04 INFO - PROCESS | 10757 | RSS: Main: 210894848 07:29:04 INFO - PROCESS | 10757 | 07:29:06 INFO - PROCESS | 10757 | Cycle 1(1): loaded http://localhost:56749/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56749/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:29:06 INFO - PROCESS | 10757 | RSS: Main: 209215488 07:29:06 INFO - PROCESS | 10757 | 07:29:09 INFO - PROCESS | 10757 | Cycle 1(1): loaded http://localhost:56749/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56749/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:29:10 INFO - PROCESS | 10757 | RSS: Main: 223834112 07:29:10 INFO - PROCESS | 10757 | 07:29:12 INFO - PROCESS | 10757 | Cycle 1(1): loaded http://localhost:56749/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56749/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:29:13 INFO - PROCESS | 10757 | RSS: Main: 226484224 07:29:13 INFO - PROCESS | 10757 | 07:29:15 INFO - PROCESS | 10757 | Cycle 1(1): loaded http://localhost:56749/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56749/tests/kraken/driver.html?testName=ai-astar) 07:29:15 INFO - PROCESS | 10757 | RSS: Main: 269193216 07:29:15 INFO - PROCESS | 10757 | 07:29:15 INFO - PROCESS | 10757 | __start_tp_report 07:29:15 INFO - PROCESS | 10757 | _x_x_mozilla_page_load 07:29:15 INFO - PROCESS | 10757 | _x_x_mozilla_page_load_details 07:29:15 INFO - PROCESS | 10757 | |i|pagename|runs| 07:29:15 INFO - PROCESS | 10757 | |0;ai-astar;103;111;111;110;111;111;110;110;110;109 07:29:15 INFO - PROCESS | 10757 | |1;audio-beat-detection;155;118;118;167;122;118;144;116;158;123 07:29:15 INFO - PROCESS | 10757 | |2;audio-dft;161;165;162;161;160;161;160;160;161;160 07:29:15 INFO - PROCESS | 10757 | |3;audio-fft;74;75;77;117;77;75;79;74;96;75 07:29:15 INFO - PROCESS | 10757 | |4;audio-oscillator;83;83;117;83;83;83;118;83;83;135 07:29:15 INFO - PROCESS | 10757 | |5;imaging-gaussian-blur;117;116;117;117;117;117;116;117;117;117 07:29:15 INFO - PROCESS | 10757 | |6;imaging-darkroom;146;146;145;146;146;146;147;146;146;145 07:29:15 INFO - PROCESS | 10757 | |7;imaging-desaturate;96;95;95;95;94;95;94;95;95;95 07:29:15 INFO - PROCESS | 10757 | |8;json-parse-financial;52;53;54;53;54;52;53;53;52;53 07:29:15 INFO - PROCESS | 10757 | |9;json-stringify-tinderbox;60;59;59;60;60;60;60;60;60;60 07:29:15 INFO - PROCESS | 10757 | |10;stanford-crypto-aes;81;75;74;79;74;75;74;81;74;79 07:29:15 INFO - PROCESS | 10757 | |11;stanford-crypto-ccm;121;122;126;118;120;145;117;126;193;120 07:29:15 INFO - PROCESS | 10757 | |12;stanford-crypto-pbkdf2;160;156;157;156;155;162;155;157;158;163 07:29:15 INFO - PROCESS | 10757 | |13;stanford-crypto-sha256-iterative;66;63;62;61;62;68;64;62;59;60 07:29:15 INFO - PROCESS | 10757 | __end_tp_report 07:29:15 INFO - PROCESS | 10757 | __start_cc_report 07:29:15 INFO - PROCESS | 10757 | _x_x_mozilla_cycle_collect,1656 07:29:15 INFO - PROCESS | 10757 | __end_cc_report 07:29:15 INFO - PROCESS | 10757 | __startTimestamp1467296955386__endTimestamp 07:29:15 INFO - PROCESS | 10757 | 07:29:15 INFO - PROCESS | 10757 | ------- Summary: start ------- 07:29:15 INFO - PROCESS | 10757 | Number of tests: 14 07:29:15 INFO - PROCESS | 10757 | 07:29:15 INFO - PROCESS | 10757 | [#0] ai-astar Cycles:10 Average:109.60 Median:110.50 stddev:2.41 (2.2%) stddev-sans-first:0.71 07:29:15 INFO - PROCESS | 10757 | Values: 103.0 111.0 111.0 110.0 111.0 111.0 110.0 110.0 110.0 109.0 07:29:15 INFO - PROCESS | 10757 | 07:29:15 INFO - PROCESS | 10757 | [#1] audio-beat-detection Cycles:10 Average:133.90 Median:133.50 stddev:19.90 (14.9%) stddev-sans-first:19.58 07:29:15 INFO - PROCESS | 10757 | Values: 155.0 118.0 118.0 167.0 122.0 118.0 144.0 116.0 158.0 123.0 07:29:15 INFO - PROCESS | 10757 | 07:29:15 INFO - PROCESS | 10757 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.00 stddev:1.52 (0.9%) stddev-sans-first:1.62 07:29:15 INFO - PROCESS | 10757 | Values: 161.0 165.0 162.0 161.0 160.0 161.0 160.0 160.0 161.0 160.0 07:29:15 INFO - PROCESS | 10757 | 07:29:15 INFO - PROCESS | 10757 | [#3] audio-fft Cycles:10 Average:81.90 Median:76.00 stddev:13.96 (18.4%) stddev-sans-first:14.52 07:29:15 INFO - PROCESS | 10757 | Values: 74.0 75.0 77.0 117.0 77.0 75.0 79.0 74.0 96.0 75.0 07:29:15 INFO - PROCESS | 10757 | 07:29:15 INFO - PROCESS | 10757 | [#4] audio-oscillator Cycles:10 Average:95.10 Median:83.00 stddev:20.06 (24.2%) stddev-sans-first:20.79 07:29:15 INFO - PROCESS | 10757 | Values: 83.0 83.0 117.0 83.0 83.0 83.0 118.0 83.0 83.0 135.0 07:29:15 INFO - PROCESS | 10757 | 07:29:15 INFO - PROCESS | 10757 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 07:29:15 INFO - PROCESS | 10757 | Values: 117.0 116.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 07:29:15 INFO - PROCESS | 10757 | 07:29:15 INFO - PROCESS | 10757 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 07:29:15 INFO - PROCESS | 10757 | Values: 146.0 146.0 145.0 146.0 146.0 146.0 147.0 146.0 146.0 145.0 07:29:15 INFO - PROCESS | 10757 | 07:29:15 INFO - PROCESS | 10757 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.44 07:29:15 INFO - PROCESS | 10757 | Values: 96.0 95.0 95.0 95.0 94.0 95.0 94.0 95.0 95.0 95.0 07:29:15 INFO - PROCESS | 10757 | 07:29:15 INFO - PROCESS | 10757 | [#8] json-parse-financial Cycles:10 Average:52.90 Median:53.00 stddev:0.74 (1.4%) stddev-sans-first:0.71 07:29:15 INFO - PROCESS | 10757 | Values: 52.0 53.0 54.0 53.0 54.0 52.0 53.0 53.0 52.0 53.0 07:29:15 INFO - PROCESS | 10757 | 07:29:15 INFO - PROCESS | 10757 | [#9] json-stringify-tinderbox Cycles:10 Average:59.80 Median:60.00 stddev:0.42 (0.7%) stddev-sans-first:0.44 07:29:15 INFO - PROCESS | 10757 | Values: 60.0 59.0 59.0 60.0 60.0 60.0 60.0 60.0 60.0 60.0 07:29:15 INFO - PROCESS | 10757 | 07:29:15 INFO - PROCESS | 10757 | [#10] stanford-crypto-aes Cycles:10 Average:76.60 Median:77.00 stddev:3.03 (3.9%) stddev-sans-first:2.76 07:29:15 INFO - PROCESS | 10757 | Values: 81.0 75.0 74.0 79.0 74.0 75.0 74.0 81.0 74.0 79.0 07:29:15 INFO - PROCESS | 10757 | 07:29:15 INFO - PROCESS | 10757 | [#11] stanford-crypto-ccm Cycles:10 Average:130.80 Median:124.00 stddev:23.28 (18.8%) stddev-sans-first:24.42 07:29:15 INFO - PROCESS | 10757 | Values: 121.0 122.0 126.0 118.0 120.0 145.0 117.0 126.0 193.0 120.0 07:29:15 INFO - PROCESS | 10757 | 07:29:15 INFO - PROCESS | 10757 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.90 Median:157.50 stddev:2.85 (1.8%) stddev-sans-first:2.92 07:29:15 INFO - PROCESS | 10757 | Values: 160.0 156.0 157.0 156.0 155.0 162.0 155.0 157.0 158.0 163.0 07:29:15 INFO - PROCESS | 10757 | 07:29:15 INFO - PROCESS | 10757 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.70 Median:62.50 stddev:2.71 (4.3%) stddev-sans-first:2.60 07:29:15 INFO - PROCESS | 10757 | Values: 66.0 63.0 62.0 61.0 62.0 68.0 64.0 62.0 59.0 60.0 07:29:15 INFO - PROCESS | 10757 | -------- Summary: end -------- 07:29:15 INFO - PROCESS | 10757 | 07:29:16 INFO - TEST-INFO | 10757: exit 0 07:29:16 INFO - TEST-OK | kraken | took 60262ms 07:29:16 INFO - SUITE-END | took 1173s 07:29:16 INFO - Completed test suite (00:19:34) 07:29:16 INFO - javascript benchmark 07:29:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3103.3638104188644, 3134.279115803365, 3136.9686303136978, 3173.444647186742, 3193.792403493773, 5195.974020129894, 5276.604254680905, 5289.444608316129, 5403.567714582829, 5411.621186516945, 5292.576593872491, 5327.307450031501, 5342.626016178869, 5366.034113859504, 5423.755930983105, 4835.371401717772, 4839.540243676845, 4844.563989240967, 4856.97571512142, 5017.874553136183, 4920.557149856512, 4949.208126699728, 4966.428860681031, 4986.4514903360605, 4989.0, 4651.162790697673, 4772.976135119302, 4820.180569303227, 4839.491853355382, 4861.708297502161, 4790.904181916342, 4818.542238487338, 4820.927686084711, 4891.657583969088, 4914.655974081816, 4871.342368780205, 4875.58557522611, 4881.096997055521, 4886.242632391985, 4887.340209071801, 5126.359205099363, 5213.00952818967, 5288.048151332759, 5365.570754339644, 5372.274742909696, 5690.918725442153, 5695.943040569583, 5724.227229324071, 5725.341585717654, 5725.570582206351, 5468.207109969032, 5784.652920824764, 5785.479306862402, 5790.623609465371, 5795.913061304083, 5253.343332083489, 5303.257543943851, 5304.310439642822, 5333.146696528537, 5337.599680024014, 5840.123981402823, 5895.380984996514, 5897.262842144732, 5899.616524925866, 5903.557233207526, 5327.600429967768, 5520.282363292827, 5675.716214189274, 5679.630823996427, 5683.062294721407, 5616.634918730269, 5721.199032135504, 5724.313082430135, 5724.771009159587, 5725.6850873202375, 5665.0, 5673.716314184357, 5677.943220567824, 5679.346875109415, 5682.971585142131, 5379.462053794668, 5593.524550413179, 5639.859003524863, 5677.432256774289, 5679.488846003879, 4367.257566213688, 4375.256206444912, 4384.0, 4419.447569053868, 4429.269170586882, 3889.7277190596387, 3929.0766669832565, 3934.744241624285, 3949.3681011038097, 3968.1270120573427, 5196.324477817935, 5198.81804136861, 5312.628116031918, 5368.8389348319615, 5457.972710136424, 5650.406707295757, 5680.687562184037, 5680.857978550569, 5695.515881150149, 5710.600257981984, 5404.540614047772, 5416.322959630046, 5418.512333889968, 5424.213489044146, 5435.266239057677, 4601.677882548256, 4655.580997710223, 4662.230731929194, 4689.249720044776, 4736.550027747358, 5798.536117110621, 5799.710014499258, 5801.448862357985, 5804.2744656917885, 5806.0, 5443.755031023535, 5562.944370556243, 5579.330480342385, 5585.916211256916, 5643.943560564342, 5747.051736463604, 5761.942380576141, 5791.507721843691, 5855.0, 5869.148973398748, 5509.559235261249, 5512.944870551403, 5513.724313784214, 5518.724063796874, 5519.3652729936575, 5496.917546236729, 5613.410591887956, 5615.241942337732, 5622.269105016322, 5632.9436705632415, 5393.40672526014, 5433.293671822637, 5448.673079615236, 5481.945180548143, 5497.312835895513, 5467.917981230205, 5468.097763868917, 5468.125099983983, 5470.972645136749, 5478.945210547843, 5283.392409872914, 5360.646105739, 5363.892722145457, 5399.05516534597, 5471.452854714496, 5485.862853428696, 5543.334799824047, 5565.443455654402, 5604.495595396434, 5618.381977982337, 5480.780768769364, 5487.725613719378, 5495.2856128703015, 5495.890082198413, 5498.422665620053], "value": 5225.589628737187, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [598.5480961873785, 625.9436650701437, 631.9557630965832, 632.1813251838871, 647.604960973806, 33429.83285083577, 42561.14877702448, 43406.78296608521, 43431.56568434315, 43537.564624353785, 44256.778716106375, 44751.0, 44788.55211447884, 44923.32615010769, 44931.10137797242, 7991.440599158062, 8973.416727912681, 9086.0, 9108.089191080871, 9117.407368521059, 8202.794930126765, 8260.421770476069, 10538.209634277422, 10779.08377787889, 10784.73038174044, 10873.238873278873, 10919.727006824813, 10927.180461465383, 10935.070519005894, 10939.0, 10762.946185269062, 10807.729806754816, 10832.350058996486, 10853.674389768319, 10858.23992320538, 10683.732906677318, 10741.140708743282, 10754.139668826476, 10758.0, 10763.031327180592, 41431.171376572296, 41693.0, 41754.37368439446, 41797.37303940443, 41846.37230441546, 3382.6955573998457, 3430.588329400463, 3523.0663874073134, 3955.5846636103083, 4103.220388126247, 31883.202919926956, 31996.520052199237, 32039.679603203902, 32075.0, 33663.32673346519, 4389.231884420214, 4438.526409232139, 4475.597196252353, 4501.27979523278, 4568.132054909556, 341877.0, 345565.0, 346545.0, 347595.0, 348871.0, 37687.0, 56922.0, 57019.42980570141, 57159.42840571541, 57330.71334643383, 38315.425268620995, 38518.42222366667, 38619.0, 38620.0, 38646.806765965994, 14013.649658758613, 14059.437622494986, 14160.150390976574, 14161.504347347793, 14164.079334843202, 10928.453577321103, 11811.291322520676, 11866.88133118675, 11879.643610691694, 11883.584074557522, 8680.913190868137, 8891.422057566237, 8904.688335908211, 8924.419912705653, 9013.414128081653, 3455.06713187438, 3463.41122009259, 3486.5118883355844, 3489.685928266468, 3508.52634894286, 1024.7847951930178, 1048.3267667448129, 1056.75166335911, 1060.316096118015, 1122.9831552526718, 32538.349233015208, 32634.510482342783, 32687.0, 32833.835830820695, 32960.0, 1118.072000239799, 1126.7070561653866, 1150.3385553306882, 1220.365409986802, 1287.716702325487, 16998.490045298662, 16999.40502082421, 17115.0, 17140.742888856676, 17315.220815063352, 510296.0, 511621.0, 517042.0, 520159.0, 520886.0, 56777.432225677214, 57217.42782572204, 57368.426315737146, 57372.71313643488, 57384.71307643435, 1238.3065483329365, 1334.1461464662623, 1349.7570437321376, 1356.4574170331748, 1405.0796728142877, 31919.36161276715, 33206.667933321325, 33585.49621755627, 33712.49431258582, 33801.661983379854, 48570.0, 49011.0, 49032.75483622559, 49055.26417103818, 49160.0, 393013.0, 394072.0, 394823.0, 395923.0, 396154.0, 25257.621135682613, 26802.59796103099, 29122.27194320159, 30205.0, 30317.787288508214, 47605.28592071052, 47767.522324776306, 48541.0, 48702.0, 48720.26919596138, 40744.79627601843, 41171.58828411678, 41655.7917210412, 41820.0, 42298.0, 41342.37986430266, 41350.37974430326, 41564.79217603893, 42102.578974209864, 42200.36699449572, 41122.0, 41338.0, 41563.1687366257, 43691.78154109209, 44388.334174986754, 35075.649243507236, 37282.81358593189, 37625.79174436187, 37761.81119094387, 38416.23167536578, 28103.859480702467, 28204.71795282021, 28451.288717781394, 28458.85770571134, 28525.28686782847], "value": 19306.2346414087, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [399.4367941202905, 400.4453831443451, 401.9115794525204, 405.6166922258465, 418.8054593927819, 13215.669608259774, 17942.820571794276, 19592.314269000588, 19600.31398901039, 19939.800601993975, 14547.199904005276, 18498.445046648587, 18831.90584047078, 18983.81016189838, 19795.0, 5641.210230567714, 5997.100434934773, 6001.579889407743, 6030.065339872327, 6031.668258245794, 5969.432903874147, 6008.8497787555225, 6014.578979471439, 6015.037593984964, 6016.518678505731, 4282.97858510707, 6285.874282514347, 6583.80248592543, 6585.802425927206, 6674.232463266713, 5559.8888022239325, 5902.085176797603, 6723.495737819659, 6727.932720672804, 6736.898946515782, 5667.801626943037, 5737.655740655574, 5776.480116789509, 5784.537237021071, 5786.450287222707, 14558.199299038548, 14612.926935365362, 21629.567408651896, 23992.28023159308, 24691.38271543208, 2230.208276062007, 2261.7738226177416, 2283.3492454650345, 2318.3392733070996, 2351.8824058797163, 10624.521896514676, 10660.253782235246, 10757.892421075767, 13136.211827290394, 13493.2578708171, 1885.7265696474071, 1973.7730161031523, 1987.3441764217773, 1999.8500112491622, 2191.2659259148204, 80948.0, 83554.58222708908, 83716.16283837205, 88312.55843720805, 90951.0, 11036.448177591248, 11100.777984440267, 11407.828882566768, 11412.201145919871, 11836.822447663291, 16095.114768687834, 16184.433544825875, 16206.594835129215, 16265.268062937197, 16282.348706051625, 8043.83912321762, 8215.507069575844, 8256.628451719567, 8349.749507514784, 8355.623996920152, 7697.653605587762, 7711.460197786213, 7720.575368354682, 7895.9210407896335, 7939.6256590948615, 4473.0, 4688.226442636927, 5016.921361907207, 5023.447420783711, 5119.564836988823, 2027.513396784761, 2116.2698868890207, 2136.0, 2139.893005349726, 2147.2055339524163, 939.4645052320249, 1012.2357619996856, 1034.730969947819, 1047.0, 1049.2602715085845, 19476.707849381986, 19606.901965490368, 19974.901380423926, 20382.69425958612, 20518.0, 938.1697197979701, 981.3719219699398, 1000.2198285337303, 1017.1201910347496, 1109.046220250584, 10384.065434110966, 10856.782864342827, 10891.945540272249, 10986.073641273397, 12185.207961482476, 478917.0, 484679.0, 493568.0, 503082.0, 511818.0, 93649.5317523408, 96260.0, 96915.0, 97002.51498742461, 97386.5130674342, 1005.6027868991707, 1018.7453136715822, 1036.9948150259352, 1046.795874804406, 1055.1400608504198, 17452.21465034102, 17763.11184440747, 17840.0, 18625.72061419107, 18695.626087477904, 40991.0, 41884.0, 44127.0, 44147.337789933816, 44618.553814462735, 50430.747846260536, 50763.23855142102, 59183.0, 60137.0, 60279.69860150671, 9084.591193396445, 9116.27069834425, 9249.213816825646, 9479.38384005065, 9501.382410143318, 10489.47552622381, 14102.576922692335, 14456.783148252574, 14699.779503307673, 15064.096154230781, 11658.0, 11888.702782430508, 12625.368731563201, 12701.0, 12757.617271481871, 11899.345535995604, 12113.576024839089, 12185.939070304592, 12520.937395312965, 12644.747105058032, 12435.316057616918, 12496.687582810502, 12659.367031648197, 12675.0, 12688.365581721062, 8920.55397230123, 9187.0, 9187.632494700138, 9299.814003720023, 9395.765105872135, 9451.480168590793, 12236.694082648006, 12500.062495312706, 12502.187357822077, 12519.374031298217], "value": 9490.457892001672, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1500.5798376454593, 1530.1278271385308, 1658.8009438867339, 1784.3843873863514, 1801.6756983742937, 8557.871631925525, 9021.548922553879, 9118.133777291156, 9123.77190570236, 9148.954255228722, 7836.960815195916, 8485.193906578881, 8711.30309575234, 8736.388452808305, 8982.461052336848, 2292.025888997178, 2311.6648086027517, 2318.7449380568123, 2319.083961835074, 2319.257837492003, 2299.275728145637, 2302.8503147295373, 2347.612643913752, 2353.6116540770754, 2363.1492662641435, 1989.333573252962, 2211.4803021289986, 2311.0640190722784, 2311.630139177732, 2326.6161083421216, 2311.6879221305076, 2315.918942837001, 2335.964960525585, 2336.5210131922913, 2336.894839732216, 2312.1329501436962, 2323.9070437182663, 2328.336424119118, 2331.801796847253, 2338.088145623208, 8908.331875109392, 8975.0, 8984.0, 8990.505522196276, 8995.910040899573, 5065.645404821664, 5127.820526281562, 5172.612054095958, 5177.741112944338, 5177.76700048495, 3395.7792743471596, 3469.462233353834, 3476.513288139637, 3513.5959364672876, 3542.5394698689265, 1175.4240422193063, 1178.9233699809486, 1203.6328919679495, 1207.4928530017414, 2186.191109289557, 11910.702232444171, 12443.875561244362, 12447.502099915993, 12470.189437686611, 12479.126461147724, 4144.606262405066, 4283.528811830696, 4337.631301339358, 4339.7613131278085, 4504.887377815581, 9507.619695212114, 9585.137337639646, 9603.231741460666, 9632.711018669452, 9646.614135434644, 5105.923411148836, 5117.718525481134, 5120.513551212629, 5130.897382052338, 5143.5113664201845, 4730.95269047312, 4809.5430934061205, 4813.566778989908, 4827.034593081397, 4831.396075490564, 3702.500162478085, 3709.666130048309, 3720.2187540616233, 3782.867599634, 3817.389217725206, 1057.9365238085738, 1087.7606926476162, 1118.8881111888745, 1123.2474242257706, 1137.192593258779, 914.7164379042385, 917.7934964632905, 938.2259635800492, 941.1811723800338, 971.2036130373026, 5663.377028526858, 5680.176374425768, 5694.817715878531, 5756.7121643917635, 5935.73289201987, 957.5403806173076, 978.471625322318, 980.5391466010964, 987.4420952162005, 1001.3191030099457, 3740.1958578905123, 3784.3566593679143, 3814.48504451901, 3845.4616353710503, 3896.1428485733095, 10918.454077296263, 11407.08743300534, 11425.885741142481, 11432.31406115619, 11441.141914356456, 10481.37111773296, 10914.017738403423, 10924.2899211551, 11297.039751621205, 11299.20905536621, 8126.10612832588, 8170.673173073011, 8278.130796266425, 8286.627101780314, 8336.291415229773, 5715.971420142872, 5798.391168927202, 5895.29256489224, 5903.822885313448, 6156.907646385397, 9887.55506002246, 9893.455859927773, 9996.700098997042, 10177.694669159937, 10178.440185789852, 10382.42896640692, 10415.53130109162, 10534.051935325857, 10925.125989920945, 10933.343999360064, 7781.572013539309, 7989.800254993672, 8030.87953680707, 8073.35413166957, 8147.877781833158, 8794.91205087941, 8864.113588641085, 8889.0, 8921.464712117035, 8926.68756593516, 7667.156612772702, 7793.1427542969095, 7813.3749300057, 7932.325752310888, 8232.053313868742, 7802.531848089133, 7878.054633444023, 7913.208679132041, 7989.560574168477, 8033.598320084089, 6510.0885875976455, 6831.11195544576, 6868.210155831944, 6870.45036397097, 6880.380765731108, 4911.165101932752, 4969.850904472872, 5019.347484826949, 5038.823641172541, 5067.645264831426, 4972.154733695208, 5052.69683818972, 5061.31672224245, 5061.746912654279, 5147.871303217449], "value": 4636.334761168297, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [318.22670909689447, 329.22796043278504, 331.5275732081784, 332.4896284203748, 339.1216748621071, 5426.972865135674, 5465.726713664316, 5473.452654734535, 5483.341998960131, 5519.613627046108, 5297.152455607104, 5316.574674026078, 5367.919481207785, 5416.377116631588, 5416.458354164582, 3996.780177090259, 4114.8148333324925, 4135.27632664284, 4187.455630768011, 4206.179794939988, 4158.792060396983, 4183.937240941388, 4197.328427451608, 4204.117135401554, 4211.263028969934, 4168.729032612886, 4177.895552611194, 4179.247735407625, 4180.686448516358, 4209.34755112958, 3983.7211395202203, 3994.3409337459284, 4205.789710514462, 4208.137331846964, 4212.7682977436225, 3680.871169509054, 3714.6255885322335, 3721.925561488782, 3732.9440058399146, 3735.972607532923, 5271.130263506517, 5287.206918962148, 5287.524122828925, 5293.788248470057, 5299.0, 4739.4075740532435, 4796.585007422818, 4805.327254184417, 4827.662063655511, 4854.878628034292, 5555.555555555546, 5584.682356821914, 5597.608167428281, 5606.831795046155, 5635.380108188096, 4067.572904845008, 4102.097538541516, 4103.363978583325, 4117.526484454296, 4127.772972486512, 5553.972230138824, 5833.32916714579, 5842.24050873388, 5852.6488410695065, 5901.3803550627, 4017.5781542938157, 4021.5120405449584, 4049.8987525311513, 4056.2495938250927, 4065.166640838621, 4094.6314831665295, 4101.610347017028, 4116.423700681847, 4128.307393968458, 4136.200752672597, 4572.908541829212, 4786.44955830077, 4786.832460863853, 4799.544043315879, 4807.927881081787, 5610.382857885711, 5670.092785154356, 5675.2054712340305, 5679.744411501492, 5688.772449102073, 1430.5493769462587, 1434.7202295552268, 1447.0811034992855, 1447.1461837515917, 1447.9565613031625, 902.2902079482043, 907.5099446299057, 916.619602864817, 948.2935213266161, 967.7677357434305, 5376.1398176291605, 5400.297961265089, 5406.378086574091, 5417.566594672417, 5440.836774896759, 5675.659460432387, 5700.6888415664625, 5711.914321285184, 5724.255846739898, 5747.798827041117, 5173.198154286091, 5421.457854214547, 5428.4028756836715, 5432.864178395572, 5449.811860061829, 3016.577679124924, 3026.6065411496807, 3036.620422447194, 3059.72462478378, 3061.3724186541704, 5651.745671444794, 5929.37741537141, 5943.31651860033, 5952.9107063394085, 5959.046552551571, 5779.133130030529, 5784.623999440023, 5830.300363956268, 5834.533237341087, 5839.861227060767, 5863.384344643836, 5868.295804503487, 5872.853178670567, 5884.6469211847425, 5889.469947704727, 5361.383440904346, 5625.128105143709, 5641.915371269352, 5653.717314134195, 5657.2928383952, 5587.413321601336, 5639.436056394327, 5645.294338207724, 5670.688112153871, 5674.971625141848, 5750.7987220447085, 5830.038043722908, 5830.941690583039, 5842.474177324061, 5858.9121163181735, 3886.96113038866, 4127.442795222607, 4139.254934111888, 4142.420061191376, 4157.168566286694, 5841.773227622247, 5868.354481007001, 5893.410658934244, 5914.201582786269, 5915.822525324247, 5448.264484294569, 5688.146777983336, 5697.943020569741, 5748.856278593069, 5761.48146666802, 5613.915791263053, 5620.915686264628, 5664.178694089416, 5675.971620141873, 5677.261955945701, 5369.758360873692, 5422.864428389322, 5536.200734761138, 5555.250041244381, 5631.774729010794, 5582.218489411567, 5602.187682786055, 5620.747066382104, 5640.266765320482, 5648.943510564842, 5519.503244707996, 5545.500904918576, 5560.555155587463, 5577.637453565505, 5584.804531841366], "value": 4280.173141441783, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [698.8776964031297, 706.7491040680558, 737.5464089584904, 759.1952530317867, 790.537535541708, 14978.400863965442, 15687.29407176677, 15730.37078516858, 15806.762898556517, 15810.972286801365, 14262.215578143197, 14367.209803460806, 14377.209253491053, 14396.28018599071, 14396.928015359934, 650.4146268358492, 775.7246177606938, 783.7217787685375, 806.1092492795465, 809.7449303469418, 797.09927781607, 800.8798680197958, 802.9718959836407, 803.8352137811735, 804.191787253812, 849.362977766675, 850.2942557677113, 850.3579797253096, 850.3962186847345, 850.6597361055566, 686.6806934775328, 823.5347028928666, 836.1680128272347, 836.481381543447, 839.0015881101469, 623.0996210475864, 623.7847942459844, 623.7941479311817, 624.048326302388, 625.1529177963885, 15022.09867407959, 15064.623384415368, 15087.39650413982, 15115.31981060855, 15120.621984450367, 14775.70448591033, 14831.925840370837, 14838.480653177086, 14897.70204595902, 15159.545213643609, 11300.717482062932, 11508.0, 11535.0, 11576.305421674642, 12159.392030398445, 4556.749378784166, 4556.863294101149, 4731.172044892164, 4841.080194762983, 4841.15279826029, 77591.61204194, 77674.6116269415, 77706.6114669423, 77815.0, 77858.6107069461, 9958.0, 10048.799024019625, 10165.186785057178, 10213.314803057412, 10263.7434064149, 22126.88936555339, 22148.778512214994, 22156.556868862855, 22162.667559986614, 22342.21802236914, 8254.339652827759, 8471.152884711602, 8642.913570864212, 8727.345449091217, 8937.0, 4565.246734288871, 4591.908161836812, 4598.471175814757, 4607.3319368691355, 4942.728149951715, 3529.294141171776, 3631.94552081719, 3632.56409230894, 3637.5816781069984, 3639.454081887685, 607.3228350389284, 610.4932905688268, 610.6610830988844, 611.9571629985948, 635.4757325206723, 581.354696287121, 673.192169396716, 677.5607811877203, 678.1116737074449, 678.9898151527731, 9506.0, 9523.761905952268, 9651.227901767841, 9721.951390243144, 10092.899071009342, 609.6646844235653, 642.9776655118291, 650.7494614573424, 658.6278752504819, 694.5797792335565, 4370.606645401929, 4440.311751678495, 4452.0, 4465.866024019285, 4548.113117942035, 113276.0, 116006.0, 116158.0, 118405.40797295958, 119748.0, 60734.0, 102384.48807756063, 103464.48267758613, 103486.0, 104981.0, 82006.0, 90795.0, 96457.51771240958, 97206.51396742971, 97427.05145897043, 9875.209983201183, 10469.9476502617, 10694.518746656264, 10720.142388609049, 10788.136949044214, 55732.0, 57968.0, 58044.41955580559, 58634.7068264656, 59111.0, 78987.21012790028, 79666.6016669936, 86560.13439865521, 86688.5665571668, 87914.0, 11176.273542220055, 11314.886851131383, 11614.941925290319, 12073.939630302144, 14272.928635356757, 12450.190737602026, 12838.743225135631, 13415.396307166397, 14119.788203177166, 14877.47928822486, 12597.307148106942, 13207.219457002439, 13476.595702128952, 13514.72970540564, 14426.783598246244, 14002.439449381263, 14829.555113346616, 15136.697266054838, 15174.24128793578, 15370.769438458208, 13274.535391261259, 13545.729085418434, 13615.115017523829, 13892.0, 13964.720705586034, 12049.277043377426, 12215.26708397499, 12293.323867187391, 12348.814767778671, 12621.81067283973, 12075.57735479254, 12287.93856030714, 12391.799091658835, 12468.875311247135, 12548.749025019632], "value": 7617.157787940439, "unit": "score"}], "name": "dromaeo_css", "value": 7246.008449443228, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 111.0, 111.0, 110.0, 111.0, 111.0, 110.0, 110.0, 110.0, 109.0], "value": 109.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 118.0, 118.0, 167.0, 122.0, 118.0, 144.0, 116.0, 158.0, 123.0], "value": 133.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 165.0, 162.0, 161.0, 160.0, 161.0, 160.0, 160.0, 161.0, 160.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 77.0, 117.0, 77.0, 75.0, 79.0, 74.0, 96.0, 75.0], "value": 81.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 117.0, 83.0, 83.0, 83.0, 118.0, 83.0, 83.0, 135.0], "value": 95.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 145.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 94.0, 95.0, 94.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 53.0, 54.0, 53.0, 54.0, 52.0, 53.0, 53.0, 52.0, 53.0], "value": 52.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 59.0, 59.0, 60.0, 60.0, 60.0, 60.0, 60.0, 60.0, 60.0], "value": 59.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 75.0, 74.0, 79.0, 74.0, 75.0, 74.0, 81.0, 74.0, 79.0], "value": 76.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 122.0, 126.0, 118.0, 120.0, 145.0, 117.0, 126.0, 193.0, 120.0], "value": 130.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 156.0, 157.0, 156.0, 155.0, 162.0, 155.0, 157.0, 158.0, 163.0], "value": 157.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 63.0, 62.0, 61.0, 62.0, 68.0, 64.0, 62.0, 59.0, 60.0], "value": 62.7, "unit": "score"}], "name": "kraken", "value": 1479.8999999999999, "alertThreshold": 2.0}]} 07:29:16 INFO - Return code: 0 07:29:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:29:16 INFO - # TBPL SUCCESS # 07:29:16 INFO - Running post-action listener: _resource_record_post_action 07:29:16 INFO - ##### 07:29:16 INFO - ##### Finished run-tests step (success) 07:29:16 INFO - ##### 07:29:16 INFO - Running post-run listener: _resource_record_post_run 07:29:16 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 555188224; Read time: 16; Write time: 374492 07:29:16 INFO - TinderboxPrint: CPU usage
13.0% 07:29:16 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 07:29:16 INFO - TinderboxPrint: I/O write bytes / time
555,188,224 / 374,492 07:29:16 INFO - TinderboxPrint: CPU idle
8,278.4 (87.0%) 07:29:16 INFO - TinderboxPrint: CPU user
1,196.2 (12.6%) 07:29:16 INFO - TinderboxPrint: Swap in / out
0 / 0 07:29:16 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 256462848; Read time: 0; Write time: 203916 07:29:16 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 298725376; Read time: 0; Write time: 170576 07:29:17 INFO - Running post-run listener: _upload_blobber_files 07:29:17 INFO - Blob upload gear active. 07:29:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:29:17 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 07:29:17 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:29:17 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:29:17 INFO - (blobuploader) - INFO - Open directory for files ... 07:29:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:29:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:29:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:29:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:29:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:29:18 INFO - (blobuploader) - INFO - Done attempting. 07:29:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:29:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:29:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:29:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:29:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:29:19 INFO - (blobuploader) - INFO - Done attempting. 07:29:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:29:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:29:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:29:23 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:29:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:29:23 INFO - (blobuploader) - INFO - Done attempting. 07:29:23 INFO - (blobuploader) - INFO - Iteration through files over. 07:29:23 INFO - Return code: 0 07:29:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:29:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:29:23 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f9906be80651e57992f8f016f5495b0a6d53209eabcb30467b17b60a18dbbc3fbe9183c6716a6d6037322309b184a2cccaa0d3024e3531c112213a4f35eea82f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/255bf4080b715809255875ab1125b2d370b5bd4fbbcc7b58c4ee0562edbdd48ce3c966aea87aed03625e55628b95c4bc28324604e3c64e1e244f24cbae151eaf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/37f7e90462af7253a7ddd9d9f9fab4c35d91f735e9486a32dbb268deecd15c7b85faaee14ca1b940dc1e5c1e2e181f8ed88fe8c88e646fe9c8a30c7a21f07d8b"} 07:29:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:29:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:29:23 INFO - Contents: 07:29:23 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f9906be80651e57992f8f016f5495b0a6d53209eabcb30467b17b60a18dbbc3fbe9183c6716a6d6037322309b184a2cccaa0d3024e3531c112213a4f35eea82f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/255bf4080b715809255875ab1125b2d370b5bd4fbbcc7b58c4ee0562edbdd48ce3c966aea87aed03625e55628b95c4bc28324604e3c64e1e244f24cbae151eaf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/37f7e90462af7253a7ddd9d9f9fab4c35d91f735e9486a32dbb268deecd15c7b85faaee14ca1b940dc1e5c1e2e181f8ed88fe8c88e646fe9c8a30c7a21f07d8b"} 07:29:23 INFO - Running post-run listener: copy_logs_to_upload_dir 07:29:23 INFO - Copying logs to upload dir... 07:29:23 INFO - mkdir: /builds/slave/test/build/upload/logs 07:29:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.430318 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-06-30 07:29:22.531520) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-30 07:29:22.534798) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1467295255.553932-1238479860 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f9906be80651e57992f8f016f5495b0a6d53209eabcb30467b17b60a18dbbc3fbe9183c6716a6d6037322309b184a2cccaa0d3024e3531c112213a4f35eea82f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/255bf4080b715809255875ab1125b2d370b5bd4fbbcc7b58c4ee0562edbdd48ce3c966aea87aed03625e55628b95c4bc28324604e3c64e1e244f24cbae151eaf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/37f7e90462af7253a7ddd9d9f9fab4c35d91f735e9486a32dbb268deecd15c7b85faaee14ca1b940dc1e5c1e2e181f8ed88fe8c88e646fe9c8a30c7a21f07d8b"} build_url:https://queue.taskcluster.net/v1/task/S9HeRt61Q8SUOKu3uvFxQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011261 build_url: 'https://queue.taskcluster.net/v1/task/S9HeRt61Q8SUOKu3uvFxQA/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/Firefox/sha512/f9906be80651e57992f8f016f5495b0a6d53209eabcb30467b17b60a18dbbc3fbe9183c6716a6d6037322309b184a2cccaa0d3024e3531c112213a4f35eea82f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/255bf4080b715809255875ab1125b2d370b5bd4fbbcc7b58c4ee0562edbdd48ce3c966aea87aed03625e55628b95c4bc28324604e3c64e1e244f24cbae151eaf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/37f7e90462af7253a7ddd9d9f9fab4c35d91f735e9486a32dbb268deecd15c7b85faaee14ca1b940dc1e5c1e2e181f8ed88fe8c88e646fe9c8a30c7a21f07d8b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-30 07:29:22.562740) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 07:29:22.563351) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1467295255.553932-1238479860 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004547 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 07:29:22.644582) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-30 07:29:22.644942) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-30 07:29:22.645317) ========= ========= Total master_lag: 0.23 =========