builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-027 starttime: 1468839187.2 results: success (0) buildid: 20160718011211 builduid: b7e8073145fc4093ad0808e17bb0816b revision: 6bcb97503de4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-18 03:53:07.203718) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-18 03:53:07.204213) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-18 03:53:07.204742) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-18 03:53:07.220286) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 03:53:07.220709) ========= 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=1f5564757af27664ca02d71f000001b0-1468839010.207572-1911851818 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-18 03:53:07-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2016-07-18 03:53:08 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.083553 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 03:53:07.318329) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 03:53:07.318634) ========= 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=1f5564757af27664ca02d71f000001b0-1468839010.207572-1911851818 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019483 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 03:53:07.368231) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-18 03:53:07.368609) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 6bcb97503de4 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 6bcb97503de4 --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=1f5564757af27664ca02d71f000001b0-1468839010.207572-1911851818 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-18 03:53:08,123 Setting DEBUG logging. 2016-07-18 03:53:08,124 attempt 1/10 2016-07-18 03:53:08,124 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/6bcb97503de4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-18 03:53:08,732 unpacking tar archive at: mozilla-inbound-6bcb97503de4/testing/mozharness/ program finished with exit code 0 elapsedTime=1.040112 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-18 03:53:08.422989) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-18 03:53:08.423543) ========= script_repo_revision: 6bcb97503de4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-18 03:53:08.424060) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-18 03:53:08.424438) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-18 03:53:08.434396) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-07-18 03:53:08.434684) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 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', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=1f5564757af27664ca02d71f000001b0-1468839010.207572-1911851818 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:53:09 INFO - MultiFileLogger online at 20160718 03:53:09 in /builds/slave/test 03:53:09 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 03:53:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:53:09 INFO - {'append_to_log': False, 03:53:09 INFO - 'base_work_dir': '/builds/slave/test', 03:53:09 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 03:53:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:53:09 INFO - 'branch': 'Mozilla-Inbound', 03:53:09 INFO - 'buildbot_json_path': 'buildprops.json', 03:53:09 INFO - 'config_files': ('talos/linux_config.py',), 03:53:09 INFO - 'default_actions': ('clobber', 03:53:09 INFO - 'read-buildbot-config', 03:53:09 INFO - 'download-and-extract', 03:53:09 INFO - 'populate-webroot', 03:53:09 INFO - 'create-virtualenv', 03:53:09 INFO - 'install', 03:53:09 INFO - 'run-tests'), 03:53:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:53:09 INFO - 'download_minidump_stackwalk': True, 03:53:09 INFO - 'download_symbols': 'ondemand', 03:53:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:53:09 INFO - 'tooltool.py': '/tools/tooltool.py', 03:53:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:53:09 INFO - '/tools/misc-python/virtualenv.py')}, 03:53:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:53:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:53:09 INFO - 'installer_path': 'installer.exe', 03:53:09 INFO - 'log_level': 'info', 03:53:09 INFO - 'log_name': 'talos', 03:53:09 INFO - 'log_to_console': True, 03:53:09 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:53:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:53:09 INFO - 'opt_config_files': (), 03:53:09 INFO - 'pip_index': False, 03:53:09 INFO - 'sps_profile': False, 03:53:09 INFO - 'sps_profile_interval': 0, 03:53:09 INFO - 'suite': 'dromaeojs', 03:53:09 INFO - 'system_bits': '32', 03:53:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:53:09 INFO - 'title': 'talos-linux64-ix-027', 03:53:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:53:09 INFO - 'use_talos_json': True, 03:53:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:53:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:53:09 INFO - 'work_dir': 'build'} 03:53:09 INFO - ##### 03:53:09 INFO - ##### Running clobber step. 03:53:09 INFO - ##### 03:53:09 INFO - Running pre-action listener: _resource_record_pre_action 03:53:09 INFO - Running main action method: clobber 03:53:09 INFO - rmtree: /builds/slave/test/build 03:53:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:53:10 INFO - Running post-action listener: _resource_record_post_action 03:53:10 INFO - ##### 03:53:10 INFO - ##### Finished clobber step (success) 03:53:10 INFO - ##### 03:53:10 INFO - ##### 03:53:10 INFO - ##### Running read-buildbot-config step. 03:53:10 INFO - ##### 03:53:10 INFO - Running pre-action listener: _resource_record_pre_action 03:53:10 INFO - Running main action method: read_buildbot_config 03:53:10 INFO - Using buildbot properties: 03:53:10 INFO - { 03:53:10 INFO - "project": "", 03:53:10 INFO - "product": "firefox", 03:53:10 INFO - "script_repo_revision": "production", 03:53:10 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 03:53:10 INFO - "repository": "", 03:53:10 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 03:53:10 INFO - "buildid": "20160718011211", 03:53:10 INFO - "pgo_build": "True", 03:53:10 INFO - "basedir": "/builds/slave/test", 03:53:10 INFO - "buildnumber": 2080, 03:53:10 INFO - "slavename": "talos-linux64-ix-027", 03:53:10 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:53:10 INFO - "platform": "ubuntu64_hw", 03:53:10 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 03:53:10 INFO - "branch": "mozilla-inbound", 03:53:10 INFO - "repo_path": "integration/mozilla-inbound", 03:53:10 INFO - "revision": "6bcb97503de4", 03:53:10 INFO - "stage_platform": "linux64-pgo", 03:53:10 INFO - "builduid": "b7e8073145fc4093ad0808e17bb0816b", 03:53:10 INFO - "slavebuilddir": "test" 03:53:10 INFO - } 03:53:10 INFO - Found installer url https://queue.taskcluster.net/v1/task/cinzP-tsRKeCi3CD0qBtyQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 03:53:10 INFO - Running post-action listener: _resource_record_post_action 03:53:10 INFO - ##### 03:53:10 INFO - ##### Finished read-buildbot-config step (success) 03:53:10 INFO - ##### 03:53:10 INFO - ##### 03:53:10 INFO - ##### Running download-and-extract step. 03:53:10 INFO - ##### 03:53:10 INFO - Running pre-action listener: _resource_record_pre_action 03:53:10 INFO - Running main action method: download_and_extract 03:53:10 INFO - mkdir: /builds/slave/test/build/tests 03:53:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:53:10 INFO - https://queue.taskcluster.net/v1/task/cinzP-tsRKeCi3CD0qBtyQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:53:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cinzP-tsRKeCi3CD0qBtyQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 03:53:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cinzP-tsRKeCi3CD0qBtyQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 03:53:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cinzP-tsRKeCi3CD0qBtyQ/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 03:53:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cinzP-tsRKeCi3CD0qBtyQ/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 03:53:10 INFO - Downloaded 1361 bytes. 03:53:10 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 03:53:10 INFO - Using the following test package requirements: 03:53:10 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 03:53:10 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:53:10 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:53:10 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:53:10 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 03:53:10 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:53:10 INFO - u'jsshell-linux-x86_64.zip'], 03:53:10 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:53:10 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:53:10 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 03:53:10 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:53:10 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:53:10 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:53:10 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:53:10 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:53:10 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:53:10 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:53:10 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:53:10 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:53:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:53:10 INFO - https://queue.taskcluster.net/v1/task/cinzP-tsRKeCi3CD0qBtyQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:53:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cinzP-tsRKeCi3CD0qBtyQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:53:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cinzP-tsRKeCi3CD0qBtyQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:53:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cinzP-tsRKeCi3CD0qBtyQ/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 03:53:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cinzP-tsRKeCi3CD0qBtyQ/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 03:53:13 INFO - Downloaded 24334461 bytes. 03:53:13 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'] 03:53:13 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 03:53:14 INFO - Return code: 0 03:53:14 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 03:53:14 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')]} 03:53:14 INFO - https://queue.taskcluster.net/v1/task/cinzP-tsRKeCi3CD0qBtyQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:53:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cinzP-tsRKeCi3CD0qBtyQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:53:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cinzP-tsRKeCi3CD0qBtyQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:53:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cinzP-tsRKeCi3CD0qBtyQ/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 03:53:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cinzP-tsRKeCi3CD0qBtyQ/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 03:53:20 INFO - Downloaded 24334461 bytes. 03:53:20 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'] 03:53:20 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 03:53:22 INFO - Return code: 0 03:53:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:53:22 INFO - https://queue.taskcluster.net/v1/task/cinzP-tsRKeCi3CD0qBtyQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:53:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cinzP-tsRKeCi3CD0qBtyQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 03:53:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cinzP-tsRKeCi3CD0qBtyQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 03:53:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cinzP-tsRKeCi3CD0qBtyQ/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 03:53:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cinzP-tsRKeCi3CD0qBtyQ/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 03:53:23 INFO - Downloaded 14403317 bytes. 03:53:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:53:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 03:53:23 INFO - Return code: 0 03:53:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:53:23 INFO - https://queue.taskcluster.net/v1/task/cinzP-tsRKeCi3CD0qBtyQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:53:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cinzP-tsRKeCi3CD0qBtyQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:53:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cinzP-tsRKeCi3CD0qBtyQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:53:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cinzP-tsRKeCi3CD0qBtyQ/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 03:53:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cinzP-tsRKeCi3CD0qBtyQ/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 03:53:24 INFO - Downloaded 60812671 bytes. 03:53:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cinzP-tsRKeCi3CD0qBtyQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:53:24 INFO - mkdir: /builds/slave/test/properties 03:53:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:53:24 INFO - Writing to file /builds/slave/test/properties/build_url 03:53:24 INFO - Contents: 03:53:24 INFO - build_url:https://queue.taskcluster.net/v1/task/cinzP-tsRKeCi3CD0qBtyQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:53:25 INFO - Running post-action listener: _resource_record_post_action 03:53:25 INFO - Running post-action listener: set_extra_try_arguments 03:53:25 INFO - ##### 03:53:25 INFO - ##### Finished download-and-extract step (success) 03:53:25 INFO - ##### 03:53:25 INFO - ##### 03:53:25 INFO - ##### Running populate-webroot step. 03:53:25 INFO - ##### 03:53:25 INFO - Running pre-action listener: _resource_record_pre_action 03:53:25 INFO - Running main action method: populate_webroot 03:53:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:53:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:53:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:53:25 INFO - '--tppagecycles', 03:53:25 INFO - '7'], 03:53:25 INFO - 'tests': ['tsvgm']}}, 03:53:25 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:53:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:53:25 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:53:25 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:53:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:53:25 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:53:25 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:53:25 INFO - 'talos_options': ['--disable-e10s'], 03:53:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:53:25 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:53:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:53:25 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:53:25 INFO - 'talos_options': ['--disable-e10s'], 03:53:25 INFO - 'tests': ['damp', 'tps']}, 03:53:25 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:53:25 INFO - 'tests': ['damp', 'tps']}, 03:53:25 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:53:25 INFO - 'tests': ['dromaeo_dom']}, 03:53:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:53:25 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:53:25 INFO - 'tests': ['basic_compositor_video']}, 03:53:25 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:53:25 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:53:25 INFO - 'tests': ['a11yr', 03:53:25 INFO - 'ts_paint', 03:53:25 INFO - 'tpaint', 03:53:25 INFO - 'sessionrestore', 03:53:25 INFO - 'sessionrestore_no_auto_restore', 03:53:25 INFO - 'tabpaint']}, 03:53:25 INFO - 'other-e10s': {'tests': ['a11yr', 03:53:25 INFO - 'ts_paint', 03:53:25 INFO - 'tpaint', 03:53:25 INFO - 'sessionrestore', 03:53:25 INFO - 'sessionrestore_no_auto_restore', 03:53:25 INFO - 'tabpaint']}, 03:53:25 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:53:25 INFO - 'ts_paint', 03:53:25 INFO - 'tpaint', 03:53:25 INFO - 'sessionrestore', 03:53:25 INFO - 'sessionrestore_no_auto_restore', 03:53:25 INFO - 'tabpaint']}, 03:53:25 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:53:25 INFO - 'ts_paint', 03:53:25 INFO - 'tpaint', 03:53:25 INFO - 'sessionrestore', 03:53:25 INFO - 'sessionrestore_no_auto_restore', 03:53:25 INFO - 'tabpaint']}, 03:53:25 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:53:25 INFO - 'tests': ['a11yr', 03:53:25 INFO - 'ts_paint', 03:53:25 INFO - 'tpaint', 03:53:25 INFO - 'sessionrestore', 03:53:25 INFO - 'sessionrestore_no_auto_restore', 03:53:25 INFO - 'tabpaint']}, 03:53:25 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:53:25 INFO - 'tests': ['a11yr', 03:53:25 INFO - 'ts_paint', 03:53:25 INFO - 'tpaint', 03:53:25 INFO - 'sessionrestore', 03:53:25 INFO - 'sessionrestore_no_auto_restore', 03:53:25 INFO - 'tabpaint']}, 03:53:25 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:53:25 INFO - 'tests': ['tsvgx', 03:53:25 INFO - 'tsvgr_opacity', 03:53:25 INFO - 'tart', 03:53:25 INFO - 'tscrollx', 03:53:25 INFO - 'cart']}, 03:53:25 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:53:25 INFO - 'tsvgr_opacity', 03:53:25 INFO - 'tart', 03:53:25 INFO - 'tscrollx', 03:53:25 INFO - 'cart']}, 03:53:25 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:53:25 INFO - 'talos_options': ['--disable-e10s'], 03:53:25 INFO - 'tests': ['tp5o']}, 03:53:25 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:53:25 INFO - 'tests': ['tp5o']}, 03:53:25 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:53:25 INFO - 'talos_options': ['--disable-e10s', 03:53:25 INFO - '--xperf_path', 03:53:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:53:25 INFO - 'tests': ['tp5n']}, 03:53:25 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:53:25 INFO - 'talos_options': ['--xperf_path', 03:53:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:53:25 INFO - 'tests': ['tp5n']}}, 03:53:25 INFO - 'talos.zip': {'path': '', 03:53:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:53:25 INFO - Running post-action listener: _resource_record_post_action 03:53:25 INFO - ##### 03:53:25 INFO - ##### Finished populate-webroot step (success) 03:53:25 INFO - ##### 03:53:25 INFO - ##### 03:53:25 INFO - ##### Running create-virtualenv step. 03:53:25 INFO - ##### 03:53:25 INFO - Running pre-action listener: _resource_record_pre_action 03:53:25 INFO - Running main action method: create_virtualenv 03:53:25 INFO - Creating virtualenv /builds/slave/test/build/venv 03:53:25 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 03:53:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:53:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:53:25 INFO - Using real prefix '/usr' 03:53:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:53:26 INFO - Installing distribute.............................................................................................................................................................................................done. 03:53:28 INFO - Installing pip.................done. 03:53:28 INFO - Return code: 0 03:53:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:53:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:53:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:53:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:53:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:53:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:53:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:53:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xb47030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcaa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe08180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe063b0>, '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 0xe072b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe07740>, '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': '1f5564757af27664ca02d71f000001b0-1468839010.207572-1911851818', '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 03:53:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:53:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:53:28 INFO - Using env: {'DISPLAY': ':0', 03:53:28 INFO - 'HOME': '/home/cltbld', 03:53:28 INFO - 'LANG': 'en_US.UTF-8', 03:53:28 INFO - 'LANGUAGE': 'en_US:en', 03:53:28 INFO - 'LOGNAME': 'cltbld', 03:53:28 INFO - 'MAIL': '/var/mail/cltbld', 03:53:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:53:28 INFO - 'MOZ_NO_REMOTE': '1', 03:53:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:53:28 INFO - 'NO_EM_RESTART': '1', 03:53:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:53:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:53:28 INFO - 'PWD': '/builds/slave/test', 03:53:28 INFO - 'SHELL': '/bin/bash', 03:53:28 INFO - 'SHLVL': '1', 03:53:28 INFO - 'TERM': 'linux', 03:53:28 INFO - 'TMOUT': '86400', 03:53:28 INFO - 'USER': 'cltbld', 03:53:28 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1468839010.207572-1911851818', 03:53:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:53:28 INFO - '_': '/tools/buildbot/bin/python'} 03:53:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:53:28 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 03:53:28 INFO - Cleaning up... 03:53:28 INFO - Return code: 0 03:53:28 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:53:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:53:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:53:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:53:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:53:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:53:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:53:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xb47030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcaa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe08180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe063b0>, '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 0xe072b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe07740>, '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': '1f5564757af27664ca02d71f000001b0-1468839010.207572-1911851818', '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 03:53:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:53:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:53:28 INFO - Using env: {'DISPLAY': ':0', 03:53:28 INFO - 'HOME': '/home/cltbld', 03:53:28 INFO - 'LANG': 'en_US.UTF-8', 03:53:28 INFO - 'LANGUAGE': 'en_US:en', 03:53:28 INFO - 'LOGNAME': 'cltbld', 03:53:28 INFO - 'MAIL': '/var/mail/cltbld', 03:53:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:53:28 INFO - 'MOZ_NO_REMOTE': '1', 03:53:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:53:28 INFO - 'NO_EM_RESTART': '1', 03:53:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:53:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:53:28 INFO - 'PWD': '/builds/slave/test', 03:53:28 INFO - 'SHELL': '/bin/bash', 03:53:28 INFO - 'SHLVL': '1', 03:53:28 INFO - 'TERM': 'linux', 03:53:28 INFO - 'TMOUT': '86400', 03:53:28 INFO - 'USER': 'cltbld', 03:53:28 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1468839010.207572-1911851818', 03:53:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:53:28 INFO - '_': '/tools/buildbot/bin/python'} 03:53:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:53:28 INFO - Downloading/unpacking psutil>=3.1.1 03:53:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:53:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:53:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:53:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:53:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:53:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:53:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:53:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:53:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:53:30 INFO - Installing collected packages: psutil 03:53:30 INFO - Running setup.py install for psutil 03:53:30 INFO - building 'psutil._psutil_linux' extension 03:53:30 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 03:53:30 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 03:53:30 INFO - building 'psutil._psutil_posix' extension 03:53:30 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 03:53:31 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:53:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:53:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:53:31 INFO - Successfully installed psutil 03:53:31 INFO - Cleaning up... 03:53:31 INFO - Return code: 0 03:53:31 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:53:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:53:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:53:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:53:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:53:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:53:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:53:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xb47030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcaa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe08180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe063b0>, '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 0xe072b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe07740>, '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': '1f5564757af27664ca02d71f000001b0-1468839010.207572-1911851818', '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 03:53:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:53:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:53:31 INFO - Using env: {'DISPLAY': ':0', 03:53:31 INFO - 'HOME': '/home/cltbld', 03:53:31 INFO - 'LANG': 'en_US.UTF-8', 03:53:31 INFO - 'LANGUAGE': 'en_US:en', 03:53:31 INFO - 'LOGNAME': 'cltbld', 03:53:31 INFO - 'MAIL': '/var/mail/cltbld', 03:53:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:53:31 INFO - 'MOZ_NO_REMOTE': '1', 03:53:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:53:31 INFO - 'NO_EM_RESTART': '1', 03:53:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:53:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:53:31 INFO - 'PWD': '/builds/slave/test', 03:53:31 INFO - 'SHELL': '/bin/bash', 03:53:31 INFO - 'SHLVL': '1', 03:53:31 INFO - 'TERM': 'linux', 03:53:31 INFO - 'TMOUT': '86400', 03:53:31 INFO - 'USER': 'cltbld', 03:53:31 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1468839010.207572-1911851818', 03:53:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:53:31 INFO - '_': '/tools/buildbot/bin/python'} 03:53:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:53:31 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:53:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:53:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:53:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:53:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:53:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:53:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:53:33 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:53:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:53:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:53:33 INFO - Installing collected packages: mozsystemmonitor 03:53:33 INFO - Running setup.py install for mozsystemmonitor 03:53:33 INFO - Successfully installed mozsystemmonitor 03:53:33 INFO - Cleaning up... 03:53:33 INFO - Return code: 0 03:53:33 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:53:33 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')]} 03:53:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:53:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:53:33 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')]} 03:53:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:53:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:53:33 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 0xb47030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcaa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe08180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe063b0>, '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 0xe072b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe07740>, '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': '1f5564757af27664ca02d71f000001b0-1468839010.207572-1911851818', '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 03:53:33 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 03:53:33 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 03:53:33 INFO - Using env: {'DISPLAY': ':0', 03:53:33 INFO - 'HOME': '/home/cltbld', 03:53:33 INFO - 'LANG': 'en_US.UTF-8', 03:53:33 INFO - 'LANGUAGE': 'en_US:en', 03:53:33 INFO - 'LOGNAME': 'cltbld', 03:53:33 INFO - 'MAIL': '/var/mail/cltbld', 03:53:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:53:33 INFO - 'MOZ_NO_REMOTE': '1', 03:53:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:53:33 INFO - 'NO_EM_RESTART': '1', 03:53:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:53:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:53:33 INFO - 'PWD': '/builds/slave/test', 03:53:33 INFO - 'SHELL': '/bin/bash', 03:53:33 INFO - 'SHLVL': '1', 03:53:33 INFO - 'TERM': 'linux', 03:53:33 INFO - 'TMOUT': '86400', 03:53:33 INFO - 'USER': 'cltbld', 03:53:33 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1468839010.207572-1911851818', 03:53:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:53:33 INFO - '_': '/tools/buildbot/bin/python'} 03:53:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:53:33 INFO - Downloading/unpacking jsonschema==2.5.1 03:53:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:53:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:53:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:53:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:53:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:53:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:53:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:53:35 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:53:35 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 03:53:35 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 03:53:35 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 03:53:35 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 03:53:35 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 03:53:35 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 03:53:35 INFO - Downloading functools32-3.2.3-2.tar.gz 03:53:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:53:35 INFO - warning: no files found matching '*.txt' 03:53:35 INFO - no previously-included directories found matching 'build' 03:53:35 INFO - no previously-included directories found matching 'dist' 03:53:35 INFO - no previously-included directories found matching '.git*' 03:53:35 INFO - Installing collected packages: jsonschema, functools32 03:53:35 INFO - Running setup.py install for functools32 03:53:36 INFO - warning: no files found matching '*.txt' 03:53:36 INFO - no previously-included directories found matching 'build' 03:53:36 INFO - no previously-included directories found matching 'dist' 03:53:36 INFO - no previously-included directories found matching '.git*' 03:53:36 INFO - Successfully installed jsonschema functools32 03:53:36 INFO - Cleaning up... 03:53:36 INFO - Return code: 0 03:53:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:53: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')]} 03:53:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:53:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:53: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')]} 03:53:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:53:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:53:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xb47030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcaa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe08180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe063b0>, '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 0xe072b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe07740>, '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': '1f5564757af27664ca02d71f000001b0-1468839010.207572-1911851818', '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 03:53:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:53:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:53:36 INFO - Using env: {'DISPLAY': ':0', 03:53:36 INFO - 'HOME': '/home/cltbld', 03:53:36 INFO - 'LANG': 'en_US.UTF-8', 03:53:36 INFO - 'LANGUAGE': 'en_US:en', 03:53:36 INFO - 'LOGNAME': 'cltbld', 03:53:36 INFO - 'MAIL': '/var/mail/cltbld', 03:53:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:53:36 INFO - 'MOZ_NO_REMOTE': '1', 03:53:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:53:36 INFO - 'NO_EM_RESTART': '1', 03:53:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:53:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:53:36 INFO - 'PWD': '/builds/slave/test', 03:53:36 INFO - 'SHELL': '/bin/bash', 03:53:36 INFO - 'SHLVL': '1', 03:53:36 INFO - 'TERM': 'linux', 03:53:36 INFO - 'TMOUT': '86400', 03:53:36 INFO - 'USER': 'cltbld', 03:53:36 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1468839010.207572-1911851818', 03:53:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:53:36 INFO - '_': '/tools/buildbot/bin/python'} 03:53:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:53:36 INFO - Downloading/unpacking blobuploader==1.2.4 03:53:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:53:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:53:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:53:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:53:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:53:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:53:38 INFO - Downloading blobuploader-1.2.4.tar.gz 03:53:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:53:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:53:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:53:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:53:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:53:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:53:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:53:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:53:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:53:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:53:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:53:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:53:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:53:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:53:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:53:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:53:38 INFO - Downloading docopt-0.6.1.tar.gz 03:53:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:53:39 INFO - Installing collected packages: blobuploader, requests, docopt 03:53:39 INFO - Running setup.py install for blobuploader 03:53:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:53:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:53:39 INFO - Running setup.py install for requests 03:53:39 INFO - Running setup.py install for docopt 03:53:39 INFO - Successfully installed blobuploader requests docopt 03:53:39 INFO - Cleaning up... 03:53:39 INFO - Return code: 0 03:53:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:53:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:53:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:53:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:53:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:53:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:53:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:53:39 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 0xb47030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcaa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe08180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe063b0>, '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 0xe072b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe07740>, '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': '1f5564757af27664ca02d71f000001b0-1468839010.207572-1911851818', '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 03:53:39 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 03:53:39 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 03:53:39 INFO - Using env: {'DISPLAY': ':0', 03:53:39 INFO - 'HOME': '/home/cltbld', 03:53:39 INFO - 'LANG': 'en_US.UTF-8', 03:53:39 INFO - 'LANGUAGE': 'en_US:en', 03:53:39 INFO - 'LOGNAME': 'cltbld', 03:53:39 INFO - 'MAIL': '/var/mail/cltbld', 03:53:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:53:39 INFO - 'MOZ_NO_REMOTE': '1', 03:53:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:53:39 INFO - 'NO_EM_RESTART': '1', 03:53:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:53:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:53:39 INFO - 'PWD': '/builds/slave/test', 03:53:39 INFO - 'SHELL': '/bin/bash', 03:53:39 INFO - 'SHLVL': '1', 03:53:39 INFO - 'TERM': 'linux', 03:53:39 INFO - 'TMOUT': '86400', 03:53:39 INFO - 'USER': 'cltbld', 03:53:39 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1468839010.207572-1911851818', 03:53:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:53:39 INFO - '_': '/tools/buildbot/bin/python'} 03:53:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:53:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:53:39 INFO - Running setup.py (path:/tmp/pip-Ro_SIu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:53:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:53:39 INFO - Running setup.py (path:/tmp/pip-IsdYv_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:53:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:53:39 INFO - Running setup.py (path:/tmp/pip-Dj6eRl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:53:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:53:40 INFO - Running setup.py (path:/tmp/pip-Tfdq6G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:53:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:53:40 INFO - Running setup.py (path:/tmp/pip-bxP6xK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:53:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:53:40 INFO - Running setup.py (path:/tmp/pip-09elLU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:53:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:53:40 INFO - Running setup.py (path:/tmp/pip-foDA8H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:53:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:53:40 INFO - Running setup.py (path:/tmp/pip-CKU63R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:53:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:53:40 INFO - Running setup.py (path:/tmp/pip-kuAd17-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:53:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:53:40 INFO - Running setup.py (path:/tmp/pip-B4O8ZU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:53:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:53:40 INFO - Running setup.py (path:/tmp/pip-ihJNu9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:53:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:53:40 INFO - Running setup.py (path:/tmp/pip-dlwTAB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:53:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:53:40 INFO - Running setup.py (path:/tmp/pip-MIG_jt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:53:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:53:40 INFO - Running setup.py (path:/tmp/pip-x3bXab-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:53:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:53:40 INFO - Running setup.py (path:/tmp/pip-MfLqQS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:53:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:53:40 INFO - Running setup.py (path:/tmp/pip-d3Nftk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:53:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:53:40 INFO - Running setup.py (path:/tmp/pip-mkCcYy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:53:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:53:41 INFO - Running setup.py install for manifestparser 03:53:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:53:41 INFO - Running setup.py install for mozcrash 03:53:41 INFO - Running setup.py install for mozdebug 03:53:41 INFO - Running setup.py install for mozdevice 03:53:41 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:53:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:53:41 INFO - Running setup.py install for mozfile 03:53:41 INFO - Running setup.py install for mozhttpd 03:53:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:53:41 INFO - Running setup.py install for mozinfo 03:53:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:53:41 INFO - Running setup.py install for mozInstall 03:53:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:53:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:53:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:53:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:53:41 INFO - Running setup.py install for mozleak 03:53:41 INFO - Running setup.py install for mozlog 03:53:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:53:42 INFO - Running setup.py install for moznetwork 03:53:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:53:42 INFO - Running setup.py install for mozprocess 03:53:42 INFO - Running setup.py install for mozprofile 03:53:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:53:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:53:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:53:42 INFO - Running setup.py install for mozrunner 03:53:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:53:42 INFO - Running setup.py install for mozscreenshot 03:53:42 INFO - Running setup.py install for moztest 03:53:42 INFO - Running setup.py install for mozversion 03:53:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:53:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:53:42 INFO - Cleaning up... 03:53:42 INFO - Return code: 0 03:53:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:53: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')]} 03:53:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:53:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:53: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')]} 03:53:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:53:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:53:42 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 0xb47030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcaa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe08180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe063b0>, '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 0xe072b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe07740>, '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': '1f5564757af27664ca02d71f000001b0-1468839010.207572-1911851818', '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 03:53:42 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 03:53:42 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 03:53:42 INFO - Using env: {'DISPLAY': ':0', 03:53:42 INFO - 'HOME': '/home/cltbld', 03:53:42 INFO - 'LANG': 'en_US.UTF-8', 03:53:42 INFO - 'LANGUAGE': 'en_US:en', 03:53:42 INFO - 'LOGNAME': 'cltbld', 03:53:42 INFO - 'MAIL': '/var/mail/cltbld', 03:53:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:53:42 INFO - 'MOZ_NO_REMOTE': '1', 03:53:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:53:42 INFO - 'NO_EM_RESTART': '1', 03:53:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:53:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:53:42 INFO - 'PWD': '/builds/slave/test', 03:53:42 INFO - 'SHELL': '/bin/bash', 03:53:42 INFO - 'SHLVL': '1', 03:53:42 INFO - 'TERM': 'linux', 03:53:42 INFO - 'TMOUT': '86400', 03:53:42 INFO - 'USER': 'cltbld', 03:53:42 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1468839010.207572-1911851818', 03:53:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:53:42 INFO - '_': '/tools/buildbot/bin/python'} 03:53:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:53:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:53:43 INFO - Running setup.py (path:/tmp/pip-CBGdXq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:53:43 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:53:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:53:43 INFO - Running setup.py (path:/tmp/pip-EzU082-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:53:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:53:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:53:43 INFO - Running setup.py (path:/tmp/pip-Luzb5E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:53:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:53:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:53:43 INFO - Running setup.py (path:/tmp/pip-LYuBAH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:53:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:53:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:53:43 INFO - Running setup.py (path:/tmp/pip-qiAdKv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:53:43 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)) 03:53:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:53:43 INFO - Running setup.py (path:/tmp/pip-mDLX0n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:53:43 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)) 03:53:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:53:43 INFO - Running setup.py (path:/tmp/pip-Z7NhE3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:53:43 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)) 03:53:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:53:43 INFO - Running setup.py (path:/tmp/pip-feZmN9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:53:43 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)) 03:53:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:53:43 INFO - Running setup.py (path:/tmp/pip-zBSL3Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:53:43 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)) 03:53:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:53:43 INFO - Running setup.py (path:/tmp/pip-AceGm9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:53:43 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)) 03:53:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:53:43 INFO - Running setup.py (path:/tmp/pip-BXGfbP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:53:43 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)) 03:53:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:53:43 INFO - Running setup.py (path:/tmp/pip-H3a9Ut-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:53:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 03:53:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:53:43 INFO - Running setup.py (path:/tmp/pip-vKtWwN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:53:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:53:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:53:44 INFO - Running setup.py (path:/tmp/pip-2zJpg5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:53:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 03:53:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:53:44 INFO - Running setup.py (path:/tmp/pip-r3tt5L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:53:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:53:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:53:44 INFO - Running setup.py (path:/tmp/pip-GpTb4x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:53:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:53:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:53:44 INFO - Running setup.py (path:/tmp/pip-_6YMqX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:53:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:53:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:53:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:53:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:53:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:53:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:53:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:53:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:53:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:53:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:53:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:53:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:53:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:53:46 INFO - Downloading blessings-1.6.tar.gz 03:53:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:53:46 INFO - Installing collected packages: blessings 03:53:46 INFO - Running setup.py install for blessings 03:53:46 INFO - Successfully installed blessings 03:53:46 INFO - Cleaning up... 03:53:46 INFO - Return code: 0 03:53:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:53:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:53:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:53:46 INFO - Reading from file tmpfile_stdout 03:53:46 INFO - Current package versions: 03:53:46 INFO - argparse == 1.2.1 03:53:46 INFO - blessings == 1.6 03:53:46 INFO - blobuploader == 1.2.4 03:53:46 INFO - docopt == 0.6.1 03:53:46 INFO - functools32 == 3.2.3-2 03:53:46 INFO - jsonschema == 2.5.1 03:53:46 INFO - manifestparser == 1.1 03:53:46 INFO - mozInstall == 1.12 03:53:46 INFO - mozcrash == 0.17 03:53:46 INFO - mozdebug == 0.1 03:53:46 INFO - mozdevice == 0.48 03:53:46 INFO - mozfile == 1.2 03:53:46 INFO - mozhttpd == 0.7 03:53:46 INFO - mozinfo == 0.9 03:53:46 INFO - mozleak == 0.1 03:53:46 INFO - mozlog == 3.2 03:53:46 INFO - moznetwork == 0.27 03:53:46 INFO - mozprocess == 0.23 03:53:46 INFO - mozprofile == 0.28 03:53:46 INFO - mozrunner == 6.12 03:53:46 INFO - mozscreenshot == 0.1 03:53:46 INFO - mozsystemmonitor == 0.3 03:53:46 INFO - moztest == 0.7 03:53:46 INFO - mozversion == 1.4 03:53:46 INFO - psutil == 3.1.1 03:53:46 INFO - requests == 1.2.3 03:53:46 INFO - wsgiref == 0.1.2 03:53:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:53:46 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')]} 03:53:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:53:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:53:46 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')]} 03:53:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:53:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:53:46 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 0xb47030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcaa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe08180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe063b0>, '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 0xe072b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe07740>, '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': '1f5564757af27664ca02d71f000001b0-1468839010.207572-1911851818', '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 03:53:46 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 03:53:46 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 03:53:46 INFO - Using env: {'DISPLAY': ':0', 03:53:46 INFO - 'HOME': '/home/cltbld', 03:53:46 INFO - 'LANG': 'en_US.UTF-8', 03:53:46 INFO - 'LANGUAGE': 'en_US:en', 03:53:46 INFO - 'LOGNAME': 'cltbld', 03:53:46 INFO - 'MAIL': '/var/mail/cltbld', 03:53:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:53:46 INFO - 'MOZ_NO_REMOTE': '1', 03:53:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:53:46 INFO - 'NO_EM_RESTART': '1', 03:53:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:53:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:53:46 INFO - 'PWD': '/builds/slave/test', 03:53:46 INFO - 'SHELL': '/bin/bash', 03:53:46 INFO - 'SHLVL': '1', 03:53:46 INFO - 'TERM': 'linux', 03:53:46 INFO - 'TMOUT': '86400', 03:53:46 INFO - 'USER': 'cltbld', 03:53:46 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1468839010.207572-1911851818', 03:53:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:53:46 INFO - '_': '/tools/buildbot/bin/python'} 03:53:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:53:46 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)) 03:53:46 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)) 03:53:46 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)) 03:53:46 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)) 03:53:46 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)) 03:53:46 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)) 03:53:46 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)) 03:53:46 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)) 03:53:46 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)) 03:53:46 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)) 03:53:46 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)) 03:53:46 INFO - Cleaning up... 03:53:46 INFO - Return code: 0 03:53:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:53:46 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')]} 03:53:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:53:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:53:46 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')]} 03:53:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:53:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:53:46 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 0xb47030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcaa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe08180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe063b0>, '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 0xe072b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe07740>, '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': '1f5564757af27664ca02d71f000001b0-1468839010.207572-1911851818', '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 03:53:46 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 03:53:46 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 03:53:46 INFO - Using env: {'DISPLAY': ':0', 03:53:46 INFO - 'HOME': '/home/cltbld', 03:53:46 INFO - 'LANG': 'en_US.UTF-8', 03:53:46 INFO - 'LANGUAGE': 'en_US:en', 03:53:46 INFO - 'LOGNAME': 'cltbld', 03:53:46 INFO - 'MAIL': '/var/mail/cltbld', 03:53:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:53:46 INFO - 'MOZ_NO_REMOTE': '1', 03:53:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:53:46 INFO - 'NO_EM_RESTART': '1', 03:53:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:53:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:53:46 INFO - 'PWD': '/builds/slave/test', 03:53:46 INFO - 'SHELL': '/bin/bash', 03:53:46 INFO - 'SHLVL': '1', 03:53:46 INFO - 'TERM': 'linux', 03:53:46 INFO - 'TMOUT': '86400', 03:53:46 INFO - 'USER': 'cltbld', 03:53:46 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1468839010.207572-1911851818', 03:53:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:53:46 INFO - '_': '/tools/buildbot/bin/python'} 03:53:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:53:47 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:53:47 INFO - Cleaning up... 03:53:47 INFO - Return code: 0 03:53:47 INFO - Running post-action listener: _resource_record_post_action 03:53:47 INFO - Running post-action listener: _start_resource_monitoring 03:53:47 INFO - Starting resource monitoring. 03:53:47 INFO - ##### 03:53:47 INFO - ##### Finished create-virtualenv step (success) 03:53:47 INFO - ##### 03:53:47 INFO - ##### 03:53:47 INFO - ##### Running install step. 03:53:47 INFO - ##### 03:53:47 INFO - Running pre-action listener: _resource_record_pre_action 03:53:47 INFO - Running main action method: install 03:53:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:53:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:53:47 INFO - Reading from file tmpfile_stdout 03:53:47 INFO - Detecting whether we're running mozinstall >=1.0... 03:53:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:53:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:53:47 INFO - Reading from file tmpfile_stdout 03:53:47 INFO - Output received: 03:53:47 INFO - Usage: mozinstall [options] installer 03:53:47 INFO - Options: 03:53:47 INFO - -h, --help show this help message and exit 03:53:47 INFO - -d DEST, --destination=DEST 03:53:47 INFO - Directory to install application into. [default: 03:53:47 INFO - "/builds/slave/test"] 03:53:47 INFO - --app=APP Application being installed. [default: firefox] 03:53:47 INFO - mkdir: /builds/slave/test/build/application 03:53:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:53:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:54:04 INFO - Reading from file tmpfile_stdout 03:54:04 INFO - Output received: 03:54:04 INFO - /builds/slave/test/build/application/firefox/firefox 03:54:04 INFO - Running post-action listener: _resource_record_post_action 03:54:04 INFO - ##### 03:54:04 INFO - ##### Finished install step (success) 03:54:04 INFO - ##### 03:54:04 INFO - ##### 03:54:04 INFO - ##### Running run-tests step. 03:54:04 INFO - ##### 03:54:04 INFO - Running pre-action listener: _resource_record_pre_action 03:54:04 INFO - Running main action method: run_tests 03:54:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:54:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:54:04 INFO - Python 2.7.3 03:54:04 INFO - Return code: 0 03:54:04 INFO - grabbing minidump binary from tooltool 03:54: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')]} 03:54:04 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe063b0>, '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 0xe072b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe07740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:54:04 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:54:04 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:54:04 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 03:54:04 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:54:04 INFO - Return code: 0 03:54:04 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:54:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:54:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:54:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:54:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:54:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cinzP-tsRKeCi3CD0qBtyQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--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 03:54:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/cinzP-tsRKeCi3CD0qBtyQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-027 --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 03:54:04 INFO - Using env: {'DISPLAY': ':0', 03:54:04 INFO - 'HOME': '/home/cltbld', 03:54:04 INFO - 'LANG': 'en_US.UTF-8', 03:54:04 INFO - 'LANGUAGE': 'en_US:en', 03:54:04 INFO - 'LOGNAME': 'cltbld', 03:54:04 INFO - 'MAIL': '/var/mail/cltbld', 03:54:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:54:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:54:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:54:04 INFO - 'MOZ_NO_REMOTE': '1', 03:54:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:54:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:54:04 INFO - 'NO_EM_RESTART': '1', 03:54:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:54:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:54:04 INFO - 'PWD': '/builds/slave/test', 03:54:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:54:04 INFO - 'SHELL': '/bin/bash', 03:54:04 INFO - 'SHLVL': '1', 03:54:04 INFO - 'TERM': 'linux', 03:54:04 INFO - 'TMOUT': '86400', 03:54:04 INFO - 'USER': 'cltbld', 03:54:04 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1468839010.207572-1911851818', 03:54:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:54:04 INFO - '_': '/tools/buildbot/bin/python'} 03:54:04 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cinzP-tsRKeCi3CD0qBtyQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--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 03:54:05 INFO - mozversion application_buildid: 20160718011211 03:54:05 INFO - mozversion application_changeset: 6bcb97503de4fe93f58b4930b368b6f86650076a 03:54:05 INFO - mozversion application_display_name: Nightly 03:54:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:54:05 INFO - mozversion application_name: Firefox 03:54:05 INFO - mozversion application_remotingname: firefox 03:54:05 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 03:54:05 INFO - mozversion application_vendor: Mozilla 03:54:05 INFO - mozversion application_version: 50.0a1 03:54:05 INFO - mozversion platform_buildid: 20160718011211 03:54:05 INFO - mozversion platform_changeset: 6bcb97503de4fe93f58b4930b368b6f86650076a 03:54:05 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 03:54:05 INFO - mozversion platform_version: 50.0a1 03:54:05 INFO - using testdate: 1468839245 03:54:05 INFO - actual date: 1468839245 03:54:05 INFO - starting webserver on 'localhost:40023' 03:54:05 INFO - SUITE-START | Running 2 tests 03:54:05 INFO - TEST-START | dromaeo_css 03:54:05 INFO - operating with platform_type : linux_ 03:54:05 INFO - Initialising browser for dromaeo_css test... 03:54:05 INFO - TEST-INFO | started process 25256 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOwFDeR/profile http://localhost:40023/getInfo.html) 03:54:08 INFO - PROCESS | 25256 | JavaScript error: , line 0: uncaught exception: undefined 03:54:08 INFO - PROCESS | 25256 | __metrics Screen width/height:1600/1200 03:54:08 INFO - PROCESS | 25256 | colorDepth:24 03:54:08 INFO - PROCESS | 25256 | Browser inner width/height: 1024/697 03:54:08 INFO - PROCESS | 25256 | __metrics 03:54:09 INFO - PROCESS | 25256 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:54:09 INFO - PROCESS | 25256 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 58: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:54:10 INFO - TEST-INFO | 25256: exit 0 03:54:10 INFO - Browser initialized. 03:54:10 INFO - Running cycle 1/1 for dromaeo_css test... 03:54:10 INFO - TEST-INFO | started process 25338 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOwFDeR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:54:22 INFO - PROCESS | 25338 | RSS: Main: 158109696 03:54:22 INFO - PROCESS | 25338 | 03:55:13 INFO - PROCESS | 25338 | 1468839313831 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] 03:57:21 INFO - PROCESS | 25338 | Cycle 1(1): loaded http://localhost:40023/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40023/tests/dromaeo/cssquery-ext.html) 03:57:22 INFO - PROCESS | 25338 | RSS: Main: 249040896 03:57:22 INFO - PROCESS | 25338 | 04:00:24 INFO - PROCESS | 25338 | Cycle 1(1): loaded http://localhost:40023/tests/dromaeo/cssquery-ext.html (next: http://localhost:40023/tests/dromaeo/cssquery-jquery.html) 04:00:25 INFO - PROCESS | 25338 | RSS: Main: 251297792 04:00:25 INFO - PROCESS | 25338 | 04:03:27 INFO - PROCESS | 25338 | Cycle 1(1): loaded http://localhost:40023/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40023/tests/dromaeo/cssquery-mootools.html) 04:03:27 INFO - PROCESS | 25338 | RSS: Main: 243544064 04:03:27 INFO - PROCESS | 25338 | 04:06:29 INFO - PROCESS | 25338 | Cycle 1(1): loaded http://localhost:40023/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40023/tests/dromaeo/cssquery-prototype.html) 04:06:30 INFO - PROCESS | 25338 | RSS: Main: 243527680 04:06:30 INFO - PROCESS | 25338 | 04:09:32 INFO - PROCESS | 25338 | Cycle 1(1): loaded http://localhost:40023/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40023/tests/dromaeo/cssquery-yui.html) 04:09:33 INFO - PROCESS | 25338 | RSS: Main: 231288832 04:09:33 INFO - PROCESS | 25338 | 04:12:36 INFO - PROCESS | 25338 | Cycle 1(1): loaded http://localhost:40023/tests/dromaeo/cssquery-yui.html (next: http://localhost:40023/tests/dromaeo/cssquery-dojo.html) 04:12:36 INFO - PROCESS | 25338 | RSS: Main: 283619328 04:12:36 INFO - PROCESS | 25338 | 04:12:36 INFO - PROCESS | 25338 | __start_tp_report 04:12:36 INFO - PROCESS | 25338 | _x_x_mozilla_page_load 04:12:36 INFO - PROCESS | 25338 | _x_x_mozilla_page_load_details 04:12:36 INFO - PROCESS | 25338 | |i|pagename|runs| 04:12:36 INFO - PROCESS | 25338 | |0;dojo.html;3052.359004609032;3061.770367222459;3087.583176271204;3091.149933768214;3102.689731026896;5276.788928442863;5289.153735402337;5352.812651557191;5381.408045115034;5398.082326004574;5325.360956685194;5338.466153384659;5355.223492593572;5395.892082158354;5434.130539113743;4769.546893045155;4858.368412106422;4858.635602329822;4879.804807807701;5076.36545431821;4939.28380384844;4981.950180498203;5018.723970181639;5035.244713292998;5043.268726034741;4771.570558649721;4816.83141090062;4838.298446725205;4900.926486102676;4934.728589927553;4830.033993201374;4844.903101937976;4856.635752318555;4911.042346742387;4937.851864444073;4836.854894353175;4860.902781944341;4861.270809378586;4876.390451193601;4904.901901961976;5280.445553216895;5291.656042357235;5348.037353276409;5362.91955620666;5388.191771234307;5725.112607545837;5770.8268751937085;5777.335606405275;5783.710814459302;5787.363390027093;5784.595078344518;5793.420657934215;5827.184194212814;5833.679147646878;5849.590528662953;5240.266362709223;5274.55166310864;5322.547583455411;5323.547498462635;5420.566354691694;5900;5900.350961394243;5907.970460147758;5909.409059094142;5910.172575839386;5436.075867102602;5664.971675141598;5665.206871038058;5670.177824215466;5674.602777805514;5616.438356164351;5663.348714897839;5674.886502270014;5757.971210143923;5760.452756988079;5680.5455563554815;5686.317641883001;5686.886262274731;5688.431156884279;5734.856628584319;5476.890462190813;5602.047651899187;5687.744051517609;5693.857653558612;5696.3164420269;4368.956310436918;4385.693001489865;4396.692231543825;4408.911821763547;4443.155800397914;3901.3367727486398;3919.235749028912;3921.1961547882615;3923.705722070856;3951.8221680024467;5320.600954928318;5416.377116631559;5439.755211015514;5470.124780035176;5512;5722.484976352148;5763;5787.247657804459;5788.247527821441;5838.970805145947;5461.726913654381;5481.451854814487;5486.259354987105;5499.422560631157;5505.146702261156;4881.633877459205;4892.584130348889;4908.92636610444;5008.12357837377;5063.87340316495;5903.439173278532;5904.350521442638;5905.261842269716;5910.8522286944035;5947.791827286024;5688.516476099578;5692.174634678031;5697.316322041382;5703.942960570507;5704.11586204139;5822.82531524055;5823.359430462561;5851.824445266649;5877.265341832271;5881.588288819741;5620.437956204347;5624.521915637217;5627.943720562742;5628.296462942132;5630.211770352072;5649.757053448235;5712.285964254468;5714.742836572281;5718.142278658068;5725.799597014085;5447.863803404946;5477.75350109254;5501.477359650827;5542.7782888684005;5580.302462192226;5550;5552.722363881709;5557.9717752215965;5559.193916881949;5563.193336966198;5441.863953401196;5443.8094666686475;5469.945300547103;5476.17857321405;5477.589180811535;5558.249636299048;5565.220869078414;5590.189422533791;5619.185218143428;5683.71581420919;5476.561875049907;5480.150576660624;5483.506484416422;5489.670619762827;5489.890202196014 04:12:36 INFO - PROCESS | 25338 | |1;ext.html;625.871696302258;638.6966191059246;642.1331202876115;644.8001119652905;651.475562172451;32414.18964525888;35200.471992920124;44190.999999999956;44425.77787111068;44734.552654473446;45410;45680.31479527801;45869.7706511467;45880.77059614706;45933;8952;8974.685885993991;9016;9120.954395228015;9122.77193070172;8928.107189281052;9008;9017.23353514952;9022.548872556346;9024;9040.367174297802;9095.181433670969;9099.363044586882;9100.499472529009;9101.544922753868;8964.238039766595;9007.324450666227;9010.14403631654;9013.36906416551;9017.819643607158;8864.246539044188;8908.242799362062;8918.420302680304;8923.107689231025;8925.687600934001;42412;42628.3605745914;42715;42753;42863.57136428658;3505.2113274513285;3586.6413358663926;3653.561572611277;3803;4087.1825634873144;33197.17415542144;33361.49957750636;33627.6637233627;33662.49506257408;35085.29829403398;4001.579834117434;4208.9789551052045;4254.149170165979;4276.23027854986;4345.283028300327;263366;263466;263512;264461;264611;57968.13047804286;57974.130388044214;58385.70807145937;58387.416125839045;58514;60116.69941650264;60411.39588604058;60492.39507604956;60638.39361606327;60660;17115.22981465837;17313.91343043302;17337.56656083583;17349;17360.13199340028;13128.540501082607;13142.60572182836;13146.737065258641;13152.736945261233;13153.145045572008;14520.564383068524;15947.681046379008;15994.120323382325;16066.75899861503;16075.437359692354;5397.9474002569905;6311.684415779193;6343.3339499351905;6400.23197216337;6488.610683359014;990.6631745206664;1015.8577799108131;1089.942666029623;1134.4711187118082;1193.7612477504533;32792.50811237833;33006;33010;33249.66750332514;33487.83256083753;1146.690393593725;1159.287038471334;1186.4127257007665;1190.7082764722697;1264.9430775614935;17393;17393.913030434767;17448.214830332665;17459.912700436416;17505.7374139388;538217;539652;540218;540864;543964;59642.403575964556;59690.10464843031;59735.701321493114;59828;59894.40105598975;1261.9369031548385;1368.7809950407886;1379.9448022079005;1384.3078460769616;1408.753468143071;33376;34276.14309642279;34510.82744586261;34542;34790;50341.74829125831;50495.74752126216;50992;51129;51190.48809511857;390824;391659;391663;393565;393813;27305.450291461984;28192;28192.15423537297;29431.11706648804;29491.705082949753;48945;48973.887531531764;49790.25314620356;50813.491865080876;50933.68931019472;41455.7927210362;42116.78941605272;42534;43931;43975.120497590506;42709.78645106879;42710.78644606757;42868.35697464603;43246.351304731084;44173.55826441823;42125.1574968505;42923.35614965716;42985.3552196711;43224;43412.565874342115;35627.64372356243;36655.81672091623;37500.24999500049;37642;38113.80943095267;27749.722502774715;27877.721222787513;28034.71965280321;28125;28239.43521129607 04:12:36 INFO - PROCESS | 25338 | |2;jquery.html;351.4763003125341;372.43204113726574;383.41529168018786;386.51685393258424;392.156862745098;14740.557783266506;15448.69102617947;18778.62442751146;18990;19347.22611095558;19200.807991920075;19238.32665856695;20092.598148037032;20155.395338139842;20294.289699860507;5677.347105082907;5707.77168913243;5764.74058667361;5855.707214639272;5859.970700146493;5583.637063590874;5651.40660230676;5698.0313346730945;5709.115087161496;5737.885242295151;5434.239206511072;5669.971650141743;5671.886562268752;5677.517411020068;5694.800681976131;5693.943060569382;5745.166950792132;5748.42515748426;5772.884542309131;5800.187973683687;5407.864803379907;5577.609567330289;5585.776568937237;5586.385497595261;5589.301337332833;14448.855511444855;21538.56922861534;22683.432914177112;22714.205002824987;22911.885440572856;2272.625016872214;2285.0859656137513;2749.3264150283308;2923.8099523530905;2928.575356573306;9606.135447809731;9995.25035622324;10019.148372388356;14434.36659025223;14478.782818257734;1830.8626852986079;1873.185164453467;1904.209752952523;1907.0845993922856;1956.9217231310731;78184.60907695425;78724;81600.59199703964;81747.5912620439;83082;10921;10926.562937482571;11037.11703063753;11289.927456891583;11828.34944078084;14746.336414861356;14762.114273143647;14842;14851.925740371229;14852.702945941237;8112.269895709414;8479.95760021196;8490.150984901584;8624.698135565224;8673.739787806377;8319.920019995001;8349.248567628943;8475.830483390298;8528.147185281423;8543.700970466003;4435.493945920544;4567;4570.131674981742;4605.424321959755;4740.881477963078;1866.552027513387;1906.8379187768917;1947.9254593857497;1970.6748386516065;1984.2757393551537;857.3698331726176;969.5103972493846;1039.7088815131776;1087.4127970895786;1102.7904698107334;19520.70718939217;19834.50413739639;20275.59448811045;20307.593848122953;20774.480637984172;971.50453268832;1007.6070332570157;1022.8312328465869;1040.7606250562262;1054.551815478434;10591.523381447852;11285.492152853141;11291.717707057389;11320.547178112947;11321.320720756616;528108;528668;530334;531554;532240;70155;89737;94251.52874235585;95076.52461737648;95231.52384238034;1020.8774947006258;1022.2435397805571;1057.9047885690325;1079.5465904320204;1087.0325410384764;17436.953782773075;17447;17967.640647186723;17971.281148753904;18302.450926472226;29150;29906.551401728557;31908.521372178973;44387.33418998653;44806.55193448024;60734.69632651808;62495.687521562104;63185.368146317946;63288.68355658192;64423.67788161029;8228.21831925966;8315.251627353568;8426.747197584082;8455.95772021136;8466.280366168945;13212.669683257995;13486.93256533711;13736;13793.655158621115;13984.790228146789;11714.941425292818;11819.349935753617;11931.224470409743;11971.461284242056;12024.617169025325;11488.712782180179;11595.768084638428;11610.883891161318;11634.88365116338;11751.823722643996;11890.28658280506;11957.222780519238;12013.399330033288;12025.518979240733;12168.634940951786;8332.916670833214;8374.37192210599;8402.621882015446;8437.470544754531;8439.409241353293;10737.409442480739;12075.879241207476;12078.879211207775;12083.154179207371;12243 04:12:36 INFO - PROCESS | 25338 | |3;mootools.html;1339.1161833190097;1453.2661006191872;1516.5298757385212;1594.8963317384369;1766.9823301766978;8296.419250652456;8561.486310821347;8609.913900860998;8846.11538846115;8847.955760221206;8748.912510874889;8770.736877893658;8821.558922053888;8834.24908882744;8835.116488351177;2295.2540424362105;2304.412374844421;2311.1910831209025;2313.34069790109;2319.6288593824993;2287.142321629389;2322.0247496051697;2382.868942208178;2384.225126833786;2384.821138414617;2255.052877791323;2263.1852533088077;2287.0965968442456;2309.8729569873735;2314.733805612351;2190.3538456155393;2210.071769856648;2211.1266049910278;2214.678871563622;2220.544788318391;2192.473806286496;2199;2199.846010779246;2199.912003519857;2200.8019278265033;8735.43219690718;8748.825023499558;8783.34124940632;8811.911880881173;8823.911760882373;5123.897522049539;5308.787648494055;5310.6813591184655;5312.362516498045;5313;3331.1672081979505;3355.1444381682513;3380.0535849961802;3380.7633465657414;3388.5933687957604;1060.0936199549428;1063.7659714862796;1072.892710728921;1081.5727787523963;1099.2415233488866;11454.312741235553;11497.31016139026;11506.884931150666;11520.654380368602;11529.769404611945;4187.20443115807;4245.280661332165;4406.361077643788;4418.138462999748;4421.38100665907;9238.260939124853;9267.25861931044;9357.953210233905;9362.578683959102;9377.578008989612;5019.824306149268;5020.623453241022;5024.371953505812;5024.422191447957;5028.270900719448;4299.849505267301;4664.720116793003;4698.7415692137265;4803.735794531264;4825.5174482551465;3717.7397582168987;3756.6619004289746;3801.904952376213;3844.8462061517225;3855.768653880776;1091.165258577189;1091.9727006824894;1104.1663544024211;1107.734143805497;1120.0871289898869;986.7089208683456;995.7311525887969;1001.2240513602017;1006.4917216805467;1008.0977525114981;6054.122152287981;6180.289266734293;6246.968765156145;6314.684265786692;6325.936740632626;392.39766957719763;401.4580316572662;402.84691817109314;404.6904118349465;406.40664629640463;4302.978485107555;4397.956020439755;4403;4436.401085853368;4446.399736035593;10522.842157367646;10848.728781780519;10870.782584348426;10934.726631834268;10983.176261780398;10737.677869663923;10787.946060269649;10799.406032668121;10802.945985270024;10860.076893464144;7646.732364367221;7909.762707118795;7937.761867143995;8089.797755056053;8097.352211823158;5984.281886173687;6306.936930630635;6336.556441049082;6336.778212762531;6438.581492202992;9744.220462362851;10105.696829095139;10264.127549158107;10294.948525257325;10347.534360953925;10298.330608510423;10314.742131446774;10377.688669339932;10403.271770975958;10420.478976051016;7894.423023412975;7912.525248485109;8054.677812887418;8102.513849169069;8111.269985701315;8542.18849209324;8570.100139485265;8581.871271931052;8624.65501379963;8673.826523469621;7676.309132178131;7918.168592297956;7937.960310198412;7960.363170946426;8017.278444939983;7639.701250787269;7659.119201291923;7706.253402388442;7802.21977802238;7903;7183.389411900047;7332.45006624516;7399.038125043925;7402.629868506446;7430.888536671846;5288.233206185005;5308.601854860978;5385.973070134624;5454.509094181542;5554.166874968787;5159.896802063862;5394.622376433612;5415.5938304626525;5452.100403433547;5487.506124448819 04:12:36 INFO - PROCESS | 25338 | |4;prototype.html;329.6094128457778;329.99835000824993;333.77136661386936;334.4131050007237;336.78950655840106;5332.600054995872;5342.919856202156;5351.49160829721;5380.515753582177;5382.950324686678;5322.2282768998475;5325.600579956509;5331.360236771583;5334.306540149775;5346.518813306801;3983.2830090583684;4059.4316795648633;4194.328907374806;4195.433616461784;4210.9578904210875;4188.371744238373;4196.895077623069;4204.2432362174795;4217.557156498569;4220.240356735786;3990.9201815963665;4150.522689890656;4161.065104726302;4173.497540885279;4175.394567787669;4034.213328400978;4038.454808600831;4078.9592104078874;4147.149834283965;4168.353905144708;3640.6177351377987;3653.30587188436;3658.725595580342;3686.152184997439;3690.464882592009;5056.216286475602;5125.077486052509;5126.846194614168;5131.589472842164;5133.486651334874;4691.601213896789;4765.547273009059;4783.665143439961;4787.976060119712;4802.735849528274;5426.810061647863;5476.205950137208;5476.698781567012;5486.177073438977;5506.5870059745275;4009.6190861868076;4017.1563971566006;4027.711132437621;4059.1272876331436;4059.640020593105;5553.806875808779;5673.517750991171;5676.2620859288445;5715.971420142872;5729.87994442055;4058.1072164123843;4076.7146299758733;4082.652974497201;4090.775007374623;4101.5488296287385;4147.4815648044;4160.583941605815;4181.958180418218;4188.979055104705;4195.580441955841;4547.795349209294;4711.644177911045;4718.457377401574;4753.904921901542;4770.642201834877;5564.415736347625;5584.748686309126;5601.047821870292;5603.411641777636;5609.074502707008;1434.4979257259874;1438.496526215837;1442.8773554247796;1451;1451.1728314860638;931.8602209668468;942.4345392764286;958.3339578992533;982.6413359124011;985.3644399362371;5375.81184658535;5384.757685904144;5388.73056347189;5401.783928642811;5437.374701909252;5637.943620563742;5646.632968857011;5663.546916246691;5688.715564221855;5694.686792226385;5208.73956302191;5291.417944026154;5314.70769107695;5316.494932981361;5387.138057910715;2954.320506283567;2984.6269216347955;2985.9552106718415;2991.641003079601;3003.654579723316;5508.228847961289;5772.9711351442975;5816.796412125555;5825.7378417971295;5828.562857785683;5651.491365777099;5711.400302968212;5726.570507211975;5731.226284451545;5731.455511726379;5737.540996720252;5755.65466072037;5780.277465316835;5852.561057920673;5855.970720146372;5374.381946076252;5603.691796951207;5655.773769049192;5743.770249189985;5756.3380211276235;5633.915411326755;5684.147377893184;5685.232493613475;5687.800926967537;5700;5803;5948.196993405835;5951.642901425928;6026.578139530191;6032.758689652364;4047.8178481967793;4055.1078762672164;4057.924649967702;4065.3698676705158;4076;5544.445555444423;5645.633033852787;5746.195532625352;5794.246747922743;5841.824745257649;5524.502794748492;5531.917021244604;5538.809156031472;5558.944410556004;5637.689927054052;5507.862303442446;5554.416786237549;5582.637128586629;5586.692731899784;5602.215689803512;5234.398044224963;5442.428545002717;5495.972520137374;5500.449955004628;5524.640898341595;5607.719614019201;5622.606417550732;5641.238432811518;5642.181883626933;5683.943160568341;5282.788688452572;5495.175723641486;5541.833744987657;5571.470710282517;5575.163725441216 04:12:36 INFO - PROCESS | 25338 | |5;yui.html;671.6507416143602;715.6922523314972;741.4142827166538;770.6647608290394;772.9149793522712;14800.77798833017;15822.367105315774;16244.431444899446;16263.34946602136;16270.186490675478;13967.441302347894;14003.229822359766;14023.649408764786;14028;14030.298485075757;666.6733300682655;804.3283857978595;813.5484805932705;820.0323618130603;827.4208054361941;821.3265122599471;824.6618886256636;824.9628766705482;825.154216927651;827.4580150001758;862.4523427623442;863.1670438027303;865.9610317535695;866.3718803867177;867.5835598912525;685.7359916432159;838.1869586501084;860.475110182788;861.2291998661194;863.1584205399748;625.9655718935456;629.3391938464594;630.2972186012609;630.4042679667716;630.4735545819246;15424.845751542452;15440.536783896501;15445.382184712598;15451.768223476656;15458.768118478232;14669.70660586793;14927.552173434815;15023.549293521102;15047.247637618184;15079.773803392958;13398.196108233537;13568.342186632924;13863.4454621815;13899.444022239099;14001.229932353717;4504.256797628387;4606.516315786861;4606.654500912445;4743.976280118612;4761.309610106549;70650;70668.29331706668;70841.29158708398;71057.2894271061;71695.64152179206;11247.606333778278;11543.76912461746;11797.88202117968;12070.215435996632;12385.380730963416;21848.89075554612;21924.123035078417;21953.341399758032;21955.560888782136;21975.340739777832;7878.251566101211;8151.633176507072;8157;8371.916280837235;8379.748607541784;3985.3822657488136;4131.194417088699;4205.137946720914;4320.071184695305;4449.221386257392;3452.3613131570237;3555.520004799319;3558.5195998540385;3563.1270338767167;3566.375884220251;536.2974503400558;588.3263663105805;591.6065816232158;591.6834493545932;608.9208402907682;584.2229834320344;585.5666806563113;594.625386006813;621.4344946099028;766.432839698619;10435.895641043644;10584.206184536191;10699.83950240747;10829.945850270698;11004.174686898514;553.9030669632798;615.6983078291605;616.6885722710002;700.2157583506404;703.2826516952782;5005.174146265826;5122.87192820175;5163.3545806774155;5206.140986737221;5267.868303292372;116449.41775291238;117440;119110;122239;122667;98456;105897.47051264849;108397;108673.45663271633;108787;59139.70430147822;59217.40782592205;84811.57594211989;92507;97116;9845.803083938425;9942.502874856373;9956.900430995598;10069.244806639677;10184.23618228621;46438.30342544932;55688.44311556833;56756.71621641865;56909.715451422475;58859.70570147122;61123.69438152781;81431.18568814236;82401.58799205965;83066;84531.5773421129;13285.933570332087;13359.332033398485;13467.528636497676;14012.439502420197;14282.57152285433;14212.289385530888;14311.785323219952;14513.160179603667;14914.477993270617;14985.550433487013;13478.561583511908;13577.389017494039;13743.725125497234;13764.518241861486;13928.373223204777;12715.80926286125;13351.065425420127;13493.190408575518;13516.25660588677;13766.65583360424;12797.55208567733;12968.157069790434;13465.461381544628;14151.929240354144;14347.35436905321;10904.39276485807;10905.672829815117;11055.281406708538;11409.942950285196;11612.361320127475;10994.780104398027;11077.224594278323;11183;11257.324560526395;11355.261907976286 04:12:36 INFO - PROCESS | 25338 | __end_tp_report 04:12:36 INFO - PROCESS | 25338 | __start_cc_report 04:12:36 INFO - PROCESS | 25338 | _x_x_mozilla_cycle_collect,811 04:12:36 INFO - PROCESS | 25338 | __end_cc_report 04:12:36 INFO - PROCESS | 25338 | __startTimestamp1468840356572__endTimestamp 04:12:36 INFO - PROCESS | 25338 | 04:12:36 INFO - PROCESS | 25338 | ------- Summary: start ------- 04:12:36 INFO - PROCESS | 25338 | Number of tests: 6 04:12:36 INFO - PROCESS | 25338 | 04:12:36 INFO - PROCESS | 25338 | [#0] dojo.html Cycles:165 Average:5316.56 Median:5483.51 stddev:596.74 (10.9%) stddev-sans-first:571.52 04:12:36 INFO - PROCESS | 25338 | Values: 3052.4 3061.8 3087.6 3091.1 3102.7 5276.8 5289.2 5352.8 5381.4 5398.1 5325.4 5338.5 5355.2 5395.9 5434.1 4769.5 4858.4 4858.6 4879.8 5076.4 4939.3 4982.0 5018.7 5035.2 5043.3 4771.6 4816.8 4838.3 4900.9 4934.7 4830.0 4844.9 4856.6 4911.0 4937.9 4836.9 4860.9 4861.3 4876.4 4904.9 5280.4 5291.7 5348.0 5362.9 5388.2 5725.1 5770.8 5777.3 5783.7 5787.4 5784.6 5793.4 5827.2 5833.7 5849.6 5240.3 5274.6 5322.5 5323.5 5420.6 5900.0 5900.4 5908.0 5909.4 5910.2 5436.1 5665.0 5665.2 5670.2 5674.6 5616.4 5663.3 5674.9 5758.0 5760.5 5680.5 5686.3 5686.9 5688.4 5734.9 5476.9 5602.0 5687.7 5693.9 5696.3 4369.0 4385.7 4396.7 4408.9 4443.2 3901.3 3919.2 3921.2 3923.7 3951.8 5320.6 5416.4 5439.8 5470.1 5512.0 5722.5 5763.0 5787.2 5788.2 5839.0 5461.7 5481.5 5486.3 5499.4 5505.1 4881.6 4892.6 4908.9 5008.1 5063.9 5903.4 5904.4 5905.3 5910.9 5947.8 5688.5 5692.2 5697.3 5703.9 5704.1 5822.8 5823.4 5851.8 5877.3 5881.6 5620.4 5624.5 5627.9 5628.3 5630.2 5649.8 5712.3 5714.7 5718.1 5725.8 5447.9 5477.8 5501.5 5542.8 5580.3 5550.0 5552.7 5558.0 5559.2 5563.2 5441.9 5443.8 5469.9 5476.2 5477.6 5558.2 5565.2 5590.2 5619.2 5683.7 5476.6 5480.2 5483.5 5489.7 5489.9 04:12:36 INFO - PROCESS | 25338 | 04:12:36 INFO - PROCESS | 25338 | [#1] ext.html Cycles:180 Average:57092.67 Median:42710.29 stddev:109991.50 (257.5%) stddev-sans-first:110218.35 04:12:36 INFO - PROCESS | 25338 | Values: 625.9 638.7 642.1 644.8 651.5 32414.2 35200.5 44191.0 44425.8 44734.6 45410.0 45680.3 45869.8 45880.8 45933.0 8952.0 8974.7 9016.0 9121.0 9122.8 8928.1 9008.0 9017.2 9022.5 9024.0 9040.4 9095.2 9099.4 9100.5 9101.5 8964.2 9007.3 9010.1 9013.4 9017.8 8864.2 8908.2 8918.4 8923.1 8925.7 42412.0 42628.4 42715.0 42753.0 42863.6 3505.2 3586.6 3653.6 3803.0 4087.2 33197.2 33361.5 33627.7 33662.5 35085.3 4001.6 4209.0 4254.1 4276.2 4345.3 263366.0 263466.0 263512.0 264461.0 264611.0 57968.1 57974.1 58385.7 58387.4 58514.0 60116.7 60411.4 60492.4 60638.4 60660.0 17115.2 17313.9 17337.6 17349.0 17360.1 13128.5 13142.6 13146.7 13152.7 13153.1 14520.6 15947.7 15994.1 16066.8 16075.4 5397.9 6311.7 6343.3 6400.2 6488.6 990.7 1015.9 1089.9 1134.5 1193.8 32792.5 33006.0 33010.0 33249.7 33487.8 1146.7 1159.3 1186.4 1190.7 1264.9 17393.0 17393.9 17448.2 17459.9 17505.7 538217.0 539652.0 540218.0 540864.0 543964.0 59642.4 59690.1 59735.7 59828.0 59894.4 1261.9 1368.8 1379.9 1384.3 1408.8 33376.0 34276.1 34510.8 34542.0 34790.0 50341.7 50495.7 50992.0 51129.0 51190.5 390824.0 391659.0 391663.0 393565.0 393813.0 27305.5 28192.0 28192.2 29431.1 29491.7 48945.0 48973.9 49790.3 50813.5 50933.7 41455.8 42116.8 42534.0 43931.0 43975.1 42709.8 42710.8 42868.4 43246.4 44173.6 42125.2 42923.4 42985.4 43224.0 43412.6 35627.6 36655.8 37500.2 37642.0 38113.8 27749.7 27877.7 28034.7 28125.0 28239.4 04:12:36 INFO - PROCESS | 25338 | 04:12:36 INFO - PROCESS | 25338 | [#2] jquery.html Cycles:180 Average:30031.94 Median:12598.49 stddev:87187.43 (692.0%) stddev-sans-first:87403.53 04:12:36 INFO - PROCESS | 25338 | Values: 351.5 372.4 383.4 386.5 392.2 14740.6 15448.7 18778.6 18990.0 19347.2 19200.8 19238.3 20092.6 20155.4 20294.3 5677.3 5707.8 5764.7 5855.7 5860.0 5583.6 5651.4 5698.0 5709.1 5737.9 5434.2 5670.0 5671.9 5677.5 5694.8 5693.9 5745.2 5748.4 5772.9 5800.2 5407.9 5577.6 5585.8 5586.4 5589.3 14448.9 21538.6 22683.4 22714.2 22911.9 2272.6 2285.1 2749.3 2923.8 2928.6 9606.1 9995.3 10019.1 14434.4 14478.8 1830.9 1873.2 1904.2 1907.1 1956.9 78184.6 78724.0 81600.6 81747.6 83082.0 10921.0 10926.6 11037.1 11289.9 11828.3 14746.3 14762.1 14842.0 14851.9 14852.7 8112.3 8480.0 8490.2 8624.7 8673.7 8319.9 8349.2 8475.8 8528.1 8543.7 4435.5 4567.0 4570.1 4605.4 4740.9 1866.6 1906.8 1947.9 1970.7 1984.3 857.4 969.5 1039.7 1087.4 1102.8 19520.7 19834.5 20275.6 20307.6 20774.5 971.5 1007.6 1022.8 1040.8 1054.6 10591.5 11285.5 11291.7 11320.5 11321.3 528108.0 528668.0 530334.0 531554.0 532240.0 70155.0 89737.0 94251.5 95076.5 95231.5 1020.9 1022.2 1057.9 1079.5 1087.0 17437.0 17447.0 17967.6 17971.3 18302.5 29150.0 29906.6 31908.5 44387.3 44806.6 60734.7 62495.7 63185.4 63288.7 64423.7 8228.2 8315.3 8426.7 8456.0 8466.3 13212.7 13486.9 13736.0 13793.7 13984.8 11714.9 11819.3 11931.2 11971.5 12024.6 11488.7 11595.8 11610.9 11634.9 11751.8 11890.3 11957.2 12013.4 12025.5 12168.6 8332.9 8374.4 8402.6 8437.5 8439.4 10737.4 12075.9 12078.9 12083.2 12243.0 04:12:36 INFO - PROCESS | 25338 | 04:12:36 INFO - PROCESS | 25338 | [#3] mootools.html Cycles:180 Average:5759.18 Median:4428.89 stddev:3271.16 (73.9%) stddev-sans-first:3263.47 04:12:36 INFO - PROCESS | 25338 | Values: 1339.1 1453.3 1516.5 1594.9 1767.0 8296.4 8561.5 8609.9 8846.1 8848.0 8748.9 8770.7 8821.6 8834.2 8835.1 2295.3 2304.4 2311.2 2313.3 2319.6 2287.1 2322.0 2382.9 2384.2 2384.8 2255.1 2263.2 2287.1 2309.9 2314.7 2190.4 2210.1 2211.1 2214.7 2220.5 2192.5 2199.0 2199.8 2199.9 2200.8 8735.4 8748.8 8783.3 8811.9 8823.9 5123.9 5308.8 5310.7 5312.4 5313.0 3331.2 3355.1 3380.1 3380.8 3388.6 1060.1 1063.8 1072.9 1081.6 1099.2 11454.3 11497.3 11506.9 11520.7 11529.8 4187.2 4245.3 4406.4 4418.1 4421.4 9238.3 9267.3 9358.0 9362.6 9377.6 5019.8 5020.6 5024.4 5024.4 5028.3 4299.8 4664.7 4698.7 4803.7 4825.5 3717.7 3756.7 3801.9 3844.8 3855.8 1091.2 1092.0 1104.2 1107.7 1120.1 986.7 995.7 1001.2 1006.5 1008.1 6054.1 6180.3 6247.0 6314.7 6325.9 392.4 401.5 402.8 404.7 406.4 4303.0 4398.0 4403.0 4436.4 4446.4 10522.8 10848.7 10870.8 10934.7 10983.2 10737.7 10787.9 10799.4 10802.9 10860.1 7646.7 7909.8 7937.8 8089.8 8097.4 5984.3 6306.9 6336.6 6336.8 6438.6 9744.2 10105.7 10264.1 10294.9 10347.5 10298.3 10314.7 10377.7 10403.3 10420.5 7894.4 7912.5 8054.7 8102.5 8111.3 8542.2 8570.1 8581.9 8624.7 8673.8 7676.3 7918.2 7938.0 7960.4 8017.3 7639.7 7659.1 7706.3 7802.2 7903.0 7183.4 7332.5 7399.0 7402.6 7430.9 5288.2 5308.6 5386.0 5454.5 5554.2 5159.9 5394.6 5415.6 5452.1 5487.5 04:12:36 INFO - PROCESS | 25338 | 04:12:36 INFO - PROCESS | 25338 | [#4] prototype.html Cycles:180 Average:4683.31 Median:5378.16 stddev:1367.80 (25.4%) stddev-sans-first:1332.03 04:12:36 INFO - PROCESS | 25338 | Values: 329.6 330.0 333.8 334.4 336.8 5332.6 5342.9 5351.5 5380.5 5383.0 5322.2 5325.6 5331.4 5334.3 5346.5 3983.3 4059.4 4194.3 4195.4 4211.0 4188.4 4196.9 4204.2 4217.6 4220.2 3990.9 4150.5 4161.1 4173.5 4175.4 4034.2 4038.5 4079.0 4147.1 4168.4 3640.6 3653.3 3658.7 3686.2 3690.5 5056.2 5125.1 5126.8 5131.6 5133.5 4691.6 4765.5 4783.7 4788.0 4802.7 5426.8 5476.2 5476.7 5486.2 5506.6 4009.6 4017.2 4027.7 4059.1 4059.6 5553.8 5673.5 5676.3 5716.0 5729.9 4058.1 4076.7 4082.7 4090.8 4101.5 4147.5 4160.6 4182.0 4189.0 4195.6 4547.8 4711.6 4718.5 4753.9 4770.6 5564.4 5584.7 5601.0 5603.4 5609.1 1434.5 1438.5 1442.9 1451.0 1451.2 931.9 942.4 958.3 982.6 985.4 5375.8 5384.8 5388.7 5401.8 5437.4 5637.9 5646.6 5663.5 5688.7 5694.7 5208.7 5291.4 5314.7 5316.5 5387.1 2954.3 2984.6 2986.0 2991.6 3003.7 5508.2 5773.0 5816.8 5825.7 5828.6 5651.5 5711.4 5726.6 5731.2 5731.5 5737.5 5755.7 5780.3 5852.6 5856.0 5374.4 5603.7 5655.8 5743.8 5756.3 5633.9 5684.1 5685.2 5687.8 5700.0 5803.0 5948.2 5951.6 6026.6 6032.8 4047.8 4055.1 4057.9 4065.4 4076.0 5544.4 5645.6 5746.2 5794.2 5841.8 5524.5 5531.9 5538.8 5558.9 5637.7 5507.9 5554.4 5582.6 5586.7 5602.2 5234.4 5442.4 5496.0 5500.4 5524.6 5607.7 5622.6 5641.2 5642.2 5683.9 5282.8 5495.2 5541.8 5571.5 5575.2 04:12:36 INFO - PROCESS | 25338 | 04:12:36 INFO - PROCESS | 25338 | [#5] yui.html Cycles:180 Average:21127.13 Median:3775.88 stddev:30606.78 (810.6%) stddev-sans-first:30654.10 04:12:36 INFO - PROCESS | 25338 | Values: 671.7 715.7 741.4 770.7 772.9 14800.8 15822.4 16244.4 16263.3 16270.2 13967.4 14003.2 14023.6 14028.0 14030.3 666.7 804.3 813.5 820.0 827.4 821.3 824.7 825.0 825.2 827.5 862.5 863.2 866.0 866.4 867.6 685.7 838.2 860.5 861.2 863.2 626.0 629.3 630.3 630.4 630.5 15424.8 15440.5 15445.4 15451.8 15458.8 14669.7 14927.6 15023.5 15047.2 15079.8 13398.2 13568.3 13863.4 13899.4 14001.2 4504.3 4606.5 4606.7 4744.0 4761.3 70650.0 70668.3 70841.3 71057.3 71695.6 11247.6 11543.8 11797.9 12070.2 12385.4 21848.9 21924.1 21953.3 21955.6 21975.3 7878.3 8151.6 8157.0 8371.9 8379.7 3985.4 4131.2 4205.1 4320.1 4449.2 3452.4 3555.5 3558.5 3563.1 3566.4 536.3 588.3 591.6 591.7 608.9 584.2 585.6 594.6 621.4 766.4 10435.9 10584.2 10699.8 10829.9 11004.2 553.9 615.7 616.7 700.2 703.3 5005.2 5122.9 5163.4 5206.1 5267.9 116449.4 117440.0 119110.0 122239.0 122667.0 98456.0 105897.5 108397.0 108673.5 108787.0 59139.7 59217.4 84811.6 92507.0 97116.0 9845.8 9942.5 9956.9 10069.2 10184.2 46438.3 55688.4 56756.7 56909.7 58859.7 61123.7 81431.2 82401.6 83066.0 84531.6 13285.9 13359.3 13467.5 14012.4 14282.6 14212.3 14311.8 14513.2 14914.5 14985.6 13478.6 13577.4 13743.7 13764.5 13928.4 12715.8 13351.1 13493.2 13516.3 13766.7 12797.6 12968.2 13465.5 14151.9 14347.4 10904.4 10905.7 11055.3 11409.9 11612.4 10994.8 11077.2 11183.0 11257.3 11355.3 04:12:36 INFO - PROCESS | 25338 | -------- Summary: end -------- 04:12:36 INFO - PROCESS | 25338 | 04:12:37 INFO - TEST-INFO | 25338: exit 0 04:12:37 INFO - TEST-OK | dromaeo_css | took 1112327ms 04:12:37 INFO - TEST-START | kraken 04:12:37 INFO - operating with platform_type : linux_ 04:12:37 INFO - Initialising browser for kraken test... 04:12:37 INFO - TEST-INFO | started process 25536 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBbBvuH/profile http://localhost:40023/getInfo.html) 04:12:40 INFO - PROCESS | 25536 | JavaScript error: , line 0: uncaught exception: undefined 04:12:41 INFO - PROCESS | 25536 | __metrics Screen width/height:1600/1200 04:12:41 INFO - PROCESS | 25536 | colorDepth:24 04:12:41 INFO - PROCESS | 25536 | Browser inner width/height: 1024/697 04:12:41 INFO - PROCESS | 25536 | __metrics 04:12:41 INFO - PROCESS | 25536 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:12:41 INFO - PROCESS | 25536 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 58: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:12:42 INFO - TEST-INFO | 25536: exit 0 04:12:42 INFO - Browser initialized. 04:12:42 INFO - Running cycle 1/1 for kraken test... 04:12:42 INFO - TEST-INFO | started process 25619 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBbBvuH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:12:54 INFO - PROCESS | 25619 | RSS: Main: 158183424 04:12:54 INFO - PROCESS | 25619 | 04:12:57 INFO - PROCESS | 25619 | Cycle 1(1): loaded http://localhost:40023/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40023/tests/kraken/driver.html?testName=audio-beat-detection) 04:12:57 INFO - PROCESS | 25619 | RSS: Main: 217452544 04:12:57 INFO - PROCESS | 25619 | 04:13:00 INFO - PROCESS | 25619 | Cycle 1(1): loaded http://localhost:40023/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40023/tests/kraken/driver.html?testName=audio-dft) 04:13:01 INFO - PROCESS | 25619 | RSS: Main: 205656064 04:13:01 INFO - PROCESS | 25619 | 04:13:03 INFO - PROCESS | 25619 | Cycle 1(1): loaded http://localhost:40023/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40023/tests/kraken/driver.html?testName=audio-fft) 04:13:04 INFO - PROCESS | 25619 | RSS: Main: 269590528 04:13:04 INFO - PROCESS | 25619 | 04:13:06 INFO - PROCESS | 25619 | Cycle 1(1): loaded http://localhost:40023/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40023/tests/kraken/driver.html?testName=audio-oscillator) 04:13:07 INFO - PROCESS | 25619 | RSS: Main: 181448704 04:13:07 INFO - PROCESS | 25619 | 04:13:09 INFO - PROCESS | 25619 | Cycle 1(1): loaded http://localhost:40023/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40023/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:13:09 INFO - PROCESS | 25619 | RSS: Main: 185516032 04:13:09 INFO - PROCESS | 25619 | 04:13:13 INFO - PROCESS | 25619 | Cycle 1(1): loaded http://localhost:40023/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40023/tests/kraken/driver.html?testName=imaging-darkroom) 04:13:13 INFO - PROCESS | 25619 | RSS: Main: 220155904 04:13:13 INFO - PROCESS | 25619 | 04:13:16 INFO - PROCESS | 25619 | Cycle 1(1): loaded http://localhost:40023/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40023/tests/kraken/driver.html?testName=imaging-desaturate) 04:13:17 INFO - PROCESS | 25619 | RSS: Main: 222085120 04:13:17 INFO - PROCESS | 25619 | 04:13:20 INFO - PROCESS | 25619 | Cycle 1(1): loaded http://localhost:40023/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40023/tests/kraken/driver.html?testName=json-parse-financial) 04:13:21 INFO - PROCESS | 25619 | RSS: Main: 221736960 04:13:21 INFO - PROCESS | 25619 | 04:13:22 INFO - PROCESS | 25619 | Cycle 1(1): loaded http://localhost:40023/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40023/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:13:23 INFO - PROCESS | 25619 | RSS: Main: 211501056 04:13:23 INFO - PROCESS | 25619 | 04:13:24 INFO - PROCESS | 25619 | Cycle 1(1): loaded http://localhost:40023/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40023/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:13:25 INFO - PROCESS | 25619 | RSS: Main: 214573056 04:13:25 INFO - PROCESS | 25619 | 04:13:27 INFO - PROCESS | 25619 | Cycle 1(1): loaded http://localhost:40023/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40023/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:13:28 INFO - PROCESS | 25619 | RSS: Main: 211668992 04:13:28 INFO - PROCESS | 25619 | 04:13:30 INFO - PROCESS | 25619 | Cycle 1(1): loaded http://localhost:40023/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40023/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:13:31 INFO - PROCESS | 25619 | RSS: Main: 221052928 04:13:31 INFO - PROCESS | 25619 | 04:13:33 INFO - PROCESS | 25619 | Cycle 1(1): loaded http://localhost:40023/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40023/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:13:34 INFO - PROCESS | 25619 | RSS: Main: 223838208 04:13:34 INFO - PROCESS | 25619 | 04:13:36 INFO - PROCESS | 25619 | Cycle 1(1): loaded http://localhost:40023/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40023/tests/kraken/driver.html?testName=ai-astar) 04:13:36 INFO - PROCESS | 25619 | RSS: Main: 266833920 04:13:36 INFO - PROCESS | 25619 | 04:13:36 INFO - PROCESS | 25619 | __start_tp_report 04:13:36 INFO - PROCESS | 25619 | _x_x_mozilla_page_load 04:13:36 INFO - PROCESS | 25619 | _x_x_mozilla_page_load_details 04:13:36 INFO - PROCESS | 25619 | |i|pagename|runs| 04:13:36 INFO - PROCESS | 25619 | |0;ai-astar;102;112;111;110;110;112;110;110;111;111 04:13:36 INFO - PROCESS | 25619 | |1;audio-beat-detection;147;120;119;169;118;122;144;119;164;119 04:13:36 INFO - PROCESS | 25619 | |2;audio-dft;160;160;162;160;161;162;162;162;161;162 04:13:36 INFO - PROCESS | 25619 | |3;audio-fft;74;75;74;125;75;76;74;75;99;76 04:13:36 INFO - PROCESS | 25619 | |4;audio-oscillator;85;84;112;85;84;85;119;85;85;136 04:13:36 INFO - PROCESS | 25619 | |5;imaging-gaussian-blur;117;117;117;116;117;116;116;117;117;116 04:13:36 INFO - PROCESS | 25619 | |6;imaging-darkroom;146;146;146;146;146;147;146;145;146;147 04:13:36 INFO - PROCESS | 25619 | |7;imaging-desaturate;94;95;95;95;94;95;95;95;94;95 04:13:36 INFO - PROCESS | 25619 | |8;json-parse-financial;51;51;50;51;51;52;51;52;51;52 04:13:36 INFO - PROCESS | 25619 | |9;json-stringify-tinderbox;61;62;62;62;62;62;61;62;62;62 04:13:36 INFO - PROCESS | 25619 | |10;stanford-crypto-aes;75;74;75;81;75;76;76;75;75;78 04:13:36 INFO - PROCESS | 25619 | |11;stanford-crypto-ccm;119;124;116;124;119;118;119;120;170;119 04:13:36 INFO - PROCESS | 25619 | |12;stanford-crypto-pbkdf2;155;155;154;154;161;157;158;157;153;155 04:13:36 INFO - PROCESS | 25619 | |13;stanford-crypto-sha256-iterative;63;62;65;68;63;62;64;62;65;60 04:13:36 INFO - PROCESS | 25619 | __end_tp_report 04:13:36 INFO - PROCESS | 25619 | __start_cc_report 04:13:36 INFO - PROCESS | 25619 | _x_x_mozilla_cycle_collect,1651 04:13:36 INFO - PROCESS | 25619 | __end_cc_report 04:13:36 INFO - PROCESS | 25619 | __startTimestamp1468840416419__endTimestamp 04:13:36 INFO - PROCESS | 25619 | 04:13:36 INFO - PROCESS | 25619 | ------- Summary: start ------- 04:13:36 INFO - PROCESS | 25619 | Number of tests: 14 04:13:36 INFO - PROCESS | 25619 | 04:13:36 INFO - PROCESS | 25619 | [#0] ai-astar Cycles:10 Average:109.90 Median:111.00 stddev:2.88 (2.6%) stddev-sans-first:0.83 04:13:36 INFO - PROCESS | 25619 | Values: 102.0 112.0 111.0 110.0 110.0 112.0 110.0 110.0 111.0 111.0 04:13:36 INFO - PROCESS | 25619 | 04:13:36 INFO - PROCESS | 25619 | [#1] audio-beat-detection Cycles:10 Average:134.10 Median:133.00 stddev:20.18 (15.2%) stddev-sans-first:20.86 04:13:36 INFO - PROCESS | 25619 | Values: 147.0 120.0 119.0 169.0 118.0 122.0 144.0 119.0 164.0 119.0 04:13:36 INFO - PROCESS | 25619 | 04:13:36 INFO - PROCESS | 25619 | [#2] audio-dft Cycles:10 Average:161.20 Median:162.00 stddev:0.92 (0.6%) stddev-sans-first:0.87 04:13:36 INFO - PROCESS | 25619 | Values: 160.0 160.0 162.0 160.0 161.0 162.0 162.0 162.0 161.0 162.0 04:13:36 INFO - PROCESS | 25619 | 04:13:36 INFO - PROCESS | 25619 | [#3] audio-fft Cycles:10 Average:82.30 Median:75.00 stddev:16.83 (22.4%) stddev-sans-first:17.58 04:13:36 INFO - PROCESS | 25619 | Values: 74.0 75.0 74.0 125.0 75.0 76.0 74.0 75.0 99.0 76.0 04:13:36 INFO - PROCESS | 25619 | 04:13:36 INFO - PROCESS | 25619 | [#4] audio-oscillator Cycles:10 Average:96.00 Median:85.00 stddev:19.08 (22.5%) stddev-sans-first:19.82 04:13:36 INFO - PROCESS | 25619 | Values: 85.0 84.0 112.0 85.0 84.0 85.0 119.0 85.0 85.0 136.0 04:13:36 INFO - PROCESS | 25619 | 04:13:36 INFO - PROCESS | 25619 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 04:13:36 INFO - PROCESS | 25619 | Values: 117.0 117.0 117.0 116.0 117.0 116.0 116.0 117.0 117.0 116.0 04:13:36 INFO - PROCESS | 25619 | 04:13:36 INFO - PROCESS | 25619 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 04:13:36 INFO - PROCESS | 25619 | Values: 146.0 146.0 146.0 146.0 146.0 147.0 146.0 145.0 146.0 147.0 04:13:36 INFO - PROCESS | 25619 | 04:13:36 INFO - PROCESS | 25619 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 04:13:36 INFO - PROCESS | 25619 | Values: 94.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 94.0 95.0 04:13:36 INFO - PROCESS | 25619 | 04:13:36 INFO - PROCESS | 25619 | [#8] json-parse-financial Cycles:10 Average:51.20 Median:51.00 stddev:0.63 (1.2%) stddev-sans-first:0.67 04:13:36 INFO - PROCESS | 25619 | Values: 51.0 51.0 50.0 51.0 51.0 52.0 51.0 52.0 51.0 52.0 04:13:36 INFO - PROCESS | 25619 | 04:13:36 INFO - PROCESS | 25619 | [#9] json-stringify-tinderbox Cycles:10 Average:61.80 Median:62.00 stddev:0.42 (0.7%) stddev-sans-first:0.33 04:13:36 INFO - PROCESS | 25619 | Values: 61.0 62.0 62.0 62.0 62.0 62.0 61.0 62.0 62.0 62.0 04:13:36 INFO - PROCESS | 25619 | 04:13:36 INFO - PROCESS | 25619 | [#10] stanford-crypto-aes Cycles:10 Average:76.00 Median:75.50 stddev:2.05 (2.7%) stddev-sans-first:2.15 04:13:36 INFO - PROCESS | 25619 | Values: 75.0 74.0 75.0 81.0 75.0 76.0 76.0 75.0 75.0 78.0 04:13:36 INFO - PROCESS | 25619 | 04:13:36 INFO - PROCESS | 25619 | [#11] stanford-crypto-ccm Cycles:10 Average:124.80 Median:119.50 stddev:16.07 (13.5%) stddev-sans-first:16.91 04:13:36 INFO - PROCESS | 25619 | Values: 119.0 124.0 116.0 124.0 119.0 118.0 119.0 120.0 170.0 119.0 04:13:36 INFO - PROCESS | 25619 | 04:13:36 INFO - PROCESS | 25619 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.90 Median:156.00 stddev:2.38 (1.5%) stddev-sans-first:2.50 04:13:36 INFO - PROCESS | 25619 | Values: 155.0 155.0 154.0 154.0 161.0 157.0 158.0 157.0 153.0 155.0 04:13:36 INFO - PROCESS | 25619 | 04:13:36 INFO - PROCESS | 25619 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.40 Median:63.50 stddev:2.22 (3.5%) stddev-sans-first:2.35 04:13:36 INFO - PROCESS | 25619 | Values: 63.0 62.0 65.0 68.0 63.0 62.0 64.0 62.0 65.0 60.0 04:13:36 INFO - PROCESS | 25619 | -------- Summary: end -------- 04:13:36 INFO - PROCESS | 25619 | 04:13:37 INFO - TEST-INFO | 25619: exit 0 04:13:37 INFO - TEST-OK | kraken | took 60094ms 04:13:37 INFO - SUITE-END | took 1172s 04:13:37 INFO - Completed test suite (00:19:32) 04:13:37 INFO - javascript benchmark 04:13:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3052.359004609032, 3061.770367222459, 3087.583176271204, 3091.149933768214, 3102.689731026896, 5276.788928442863, 5289.153735402337, 5352.812651557191, 5381.408045115034, 5398.082326004574, 5325.360956685194, 5338.466153384659, 5355.223492593572, 5395.892082158354, 5434.130539113743, 4769.546893045155, 4858.368412106422, 4858.635602329822, 4879.804807807701, 5076.36545431821, 4939.28380384844, 4981.950180498203, 5018.723970181639, 5035.244713292998, 5043.268726034741, 4771.570558649721, 4816.83141090062, 4838.298446725205, 4900.926486102676, 4934.728589927553, 4830.033993201374, 4844.903101937976, 4856.635752318555, 4911.042346742387, 4937.851864444073, 4836.854894353175, 4860.902781944341, 4861.270809378586, 4876.390451193601, 4904.901901961976, 5280.445553216895, 5291.656042357235, 5348.037353276409, 5362.91955620666, 5388.191771234307, 5725.112607545837, 5770.8268751937085, 5777.335606405275, 5783.710814459302, 5787.363390027093, 5784.595078344518, 5793.420657934215, 5827.184194212814, 5833.679147646878, 5849.590528662953, 5240.266362709223, 5274.55166310864, 5322.547583455411, 5323.547498462635, 5420.566354691694, 5900.0, 5900.350961394243, 5907.970460147758, 5909.409059094142, 5910.172575839386, 5436.075867102602, 5664.971675141598, 5665.206871038058, 5670.177824215466, 5674.602777805514, 5616.438356164351, 5663.348714897839, 5674.886502270014, 5757.971210143923, 5760.452756988079, 5680.5455563554815, 5686.317641883001, 5686.886262274731, 5688.431156884279, 5734.856628584319, 5476.890462190813, 5602.047651899187, 5687.744051517609, 5693.857653558612, 5696.3164420269, 4368.956310436918, 4385.693001489865, 4396.692231543825, 4408.911821763547, 4443.155800397914, 3901.3367727486398, 3919.235749028912, 3921.1961547882615, 3923.705722070856, 3951.8221680024467, 5320.600954928318, 5416.377116631559, 5439.755211015514, 5470.124780035176, 5512.0, 5722.484976352148, 5763.0, 5787.247657804459, 5788.247527821441, 5838.970805145947, 5461.726913654381, 5481.451854814487, 5486.259354987105, 5499.422560631157, 5505.146702261156, 4881.633877459205, 4892.584130348889, 4908.92636610444, 5008.12357837377, 5063.87340316495, 5903.439173278532, 5904.350521442638, 5905.261842269716, 5910.8522286944035, 5947.791827286024, 5688.516476099578, 5692.174634678031, 5697.316322041382, 5703.942960570507, 5704.11586204139, 5822.82531524055, 5823.359430462561, 5851.824445266649, 5877.265341832271, 5881.588288819741, 5620.437956204347, 5624.521915637217, 5627.943720562742, 5628.296462942132, 5630.211770352072, 5649.757053448235, 5712.285964254468, 5714.742836572281, 5718.142278658068, 5725.799597014085, 5447.863803404946, 5477.75350109254, 5501.477359650827, 5542.7782888684005, 5580.302462192226, 5550.0, 5552.722363881709, 5557.9717752215965, 5559.193916881949, 5563.193336966198, 5441.863953401196, 5443.8094666686475, 5469.945300547103, 5476.17857321405, 5477.589180811535, 5558.249636299048, 5565.220869078414, 5590.189422533791, 5619.185218143428, 5683.71581420919, 5476.561875049907, 5480.150576660624, 5483.506484416422, 5489.670619762827, 5489.890202196014], "value": 5276.434511561326, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [625.871696302258, 638.6966191059246, 642.1331202876115, 644.8001119652905, 651.475562172451, 32414.18964525888, 35200.471992920124, 44190.999999999956, 44425.77787111068, 44734.552654473446, 45410.0, 45680.31479527801, 45869.7706511467, 45880.77059614706, 45933.0, 8952.0, 8974.685885993991, 9016.0, 9120.954395228015, 9122.77193070172, 8928.107189281052, 9008.0, 9017.23353514952, 9022.548872556346, 9024.0, 9040.367174297802, 9095.181433670969, 9099.363044586882, 9100.499472529009, 9101.544922753868, 8964.238039766595, 9007.324450666227, 9010.14403631654, 9013.36906416551, 9017.819643607158, 8864.246539044188, 8908.242799362062, 8918.420302680304, 8923.107689231025, 8925.687600934001, 42412.0, 42628.3605745914, 42715.0, 42753.0, 42863.57136428658, 3505.2113274513285, 3586.6413358663926, 3653.561572611277, 3803.0, 4087.1825634873144, 33197.17415542144, 33361.49957750636, 33627.6637233627, 33662.49506257408, 35085.29829403398, 4001.579834117434, 4208.9789551052045, 4254.149170165979, 4276.23027854986, 4345.283028300327, 263366.0, 263466.0, 263512.0, 264461.0, 264611.0, 57968.13047804286, 57974.130388044214, 58385.70807145937, 58387.416125839045, 58514.0, 60116.69941650264, 60411.39588604058, 60492.39507604956, 60638.39361606327, 60660.0, 17115.22981465837, 17313.91343043302, 17337.56656083583, 17349.0, 17360.13199340028, 13128.540501082607, 13142.60572182836, 13146.737065258641, 13152.736945261233, 13153.145045572008, 14520.564383068524, 15947.681046379008, 15994.120323382325, 16066.75899861503, 16075.437359692354, 5397.9474002569905, 6311.684415779193, 6343.3339499351905, 6400.23197216337, 6488.610683359014, 990.6631745206664, 1015.8577799108131, 1089.942666029623, 1134.4711187118082, 1193.7612477504533, 32792.50811237833, 33006.0, 33010.0, 33249.66750332514, 33487.83256083753, 1146.690393593725, 1159.287038471334, 1186.4127257007665, 1190.7082764722697, 1264.9430775614935, 17393.0, 17393.913030434767, 17448.214830332665, 17459.912700436416, 17505.7374139388, 538217.0, 539652.0, 540218.0, 540864.0, 543964.0, 59642.403575964556, 59690.10464843031, 59735.701321493114, 59828.0, 59894.40105598975, 1261.9369031548385, 1368.7809950407886, 1379.9448022079005, 1384.3078460769616, 1408.753468143071, 33376.0, 34276.14309642279, 34510.82744586261, 34542.0, 34790.0, 50341.74829125831, 50495.74752126216, 50992.0, 51129.0, 51190.48809511857, 390824.0, 391659.0, 391663.0, 393565.0, 393813.0, 27305.450291461984, 28192.0, 28192.15423537297, 29431.11706648804, 29491.705082949753, 48945.0, 48973.887531531764, 49790.25314620356, 50813.491865080876, 50933.68931019472, 41455.7927210362, 42116.78941605272, 42534.0, 43931.0, 43975.120497590506, 42709.78645106879, 42710.78644606757, 42868.35697464603, 43246.351304731084, 44173.55826441823, 42125.1574968505, 42923.35614965716, 42985.3552196711, 43224.0, 43412.565874342115, 35627.64372356243, 36655.81672091623, 37500.24999500049, 37642.0, 38113.80943095267, 27749.722502774715, 27877.721222787513, 28034.71965280321, 28125.0, 28239.43521129607], "value": 20123.751646239758, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [351.4763003125341, 372.43204113726574, 383.41529168018786, 386.51685393258424, 392.156862745098, 14740.557783266506, 15448.69102617947, 18778.62442751146, 18990.0, 19347.22611095558, 19200.807991920075, 19238.32665856695, 20092.598148037032, 20155.395338139842, 20294.289699860507, 5677.347105082907, 5707.77168913243, 5764.74058667361, 5855.707214639272, 5859.970700146493, 5583.637063590874, 5651.40660230676, 5698.0313346730945, 5709.115087161496, 5737.885242295151, 5434.239206511072, 5669.971650141743, 5671.886562268752, 5677.517411020068, 5694.800681976131, 5693.943060569382, 5745.166950792132, 5748.42515748426, 5772.884542309131, 5800.187973683687, 5407.864803379907, 5577.609567330289, 5585.776568937237, 5586.385497595261, 5589.301337332833, 14448.855511444855, 21538.56922861534, 22683.432914177112, 22714.205002824987, 22911.885440572856, 2272.625016872214, 2285.0859656137513, 2749.3264150283308, 2923.8099523530905, 2928.575356573306, 9606.135447809731, 9995.25035622324, 10019.148372388356, 14434.36659025223, 14478.782818257734, 1830.8626852986079, 1873.185164453467, 1904.209752952523, 1907.0845993922856, 1956.9217231310731, 78184.60907695425, 78724.0, 81600.59199703964, 81747.5912620439, 83082.0, 10921.0, 10926.562937482571, 11037.11703063753, 11289.927456891583, 11828.34944078084, 14746.336414861356, 14762.114273143647, 14842.0, 14851.925740371229, 14852.702945941237, 8112.269895709414, 8479.95760021196, 8490.150984901584, 8624.698135565224, 8673.739787806377, 8319.920019995001, 8349.248567628943, 8475.830483390298, 8528.147185281423, 8543.700970466003, 4435.493945920544, 4567.0, 4570.131674981742, 4605.424321959755, 4740.881477963078, 1866.552027513387, 1906.8379187768917, 1947.9254593857497, 1970.6748386516065, 1984.2757393551537, 857.3698331726176, 969.5103972493846, 1039.7088815131776, 1087.4127970895786, 1102.7904698107334, 19520.70718939217, 19834.50413739639, 20275.59448811045, 20307.593848122953, 20774.480637984172, 971.50453268832, 1007.6070332570157, 1022.8312328465869, 1040.7606250562262, 1054.551815478434, 10591.523381447852, 11285.492152853141, 11291.717707057389, 11320.547178112947, 11321.320720756616, 528108.0, 528668.0, 530334.0, 531554.0, 532240.0, 70155.0, 89737.0, 94251.52874235585, 95076.52461737648, 95231.52384238034, 1020.8774947006258, 1022.2435397805571, 1057.9047885690325, 1079.5465904320204, 1087.0325410384764, 17436.953782773075, 17447.0, 17967.640647186723, 17971.281148753904, 18302.450926472226, 29150.0, 29906.551401728557, 31908.521372178973, 44387.33418998653, 44806.55193448024, 60734.69632651808, 62495.687521562104, 63185.368146317946, 63288.68355658192, 64423.67788161029, 8228.21831925966, 8315.251627353568, 8426.747197584082, 8455.95772021136, 8466.280366168945, 13212.669683257995, 13486.93256533711, 13736.0, 13793.655158621115, 13984.790228146789, 11714.941425292818, 11819.349935753617, 11931.224470409743, 11971.461284242056, 12024.617169025325, 11488.712782180179, 11595.768084638428, 11610.883891161318, 11634.88365116338, 11751.823722643996, 11890.28658280506, 11957.222780519238, 12013.399330033288, 12025.518979240733, 12168.634940951786, 8332.916670833214, 8374.37192210599, 8402.621882015446, 8437.470544754531, 8439.409241353293, 10737.409442480739, 12075.879241207476, 12078.879211207775, 12083.154179207371, 12243.0], "value": 9287.853576532758, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1339.1161833190097, 1453.2661006191872, 1516.5298757385212, 1594.8963317384369, 1766.9823301766978, 8296.419250652456, 8561.486310821347, 8609.913900860998, 8846.11538846115, 8847.955760221206, 8748.912510874889, 8770.736877893658, 8821.558922053888, 8834.24908882744, 8835.116488351177, 2295.2540424362105, 2304.412374844421, 2311.1910831209025, 2313.34069790109, 2319.6288593824993, 2287.142321629389, 2322.0247496051697, 2382.868942208178, 2384.225126833786, 2384.821138414617, 2255.052877791323, 2263.1852533088077, 2287.0965968442456, 2309.8729569873735, 2314.733805612351, 2190.3538456155393, 2210.071769856648, 2211.1266049910278, 2214.678871563622, 2220.544788318391, 2192.473806286496, 2199.0, 2199.846010779246, 2199.912003519857, 2200.8019278265033, 8735.43219690718, 8748.825023499558, 8783.34124940632, 8811.911880881173, 8823.911760882373, 5123.897522049539, 5308.787648494055, 5310.6813591184655, 5312.362516498045, 5313.0, 3331.1672081979505, 3355.1444381682513, 3380.0535849961802, 3380.7633465657414, 3388.5933687957604, 1060.0936199549428, 1063.7659714862796, 1072.892710728921, 1081.5727787523963, 1099.2415233488866, 11454.312741235553, 11497.31016139026, 11506.884931150666, 11520.654380368602, 11529.769404611945, 4187.20443115807, 4245.280661332165, 4406.361077643788, 4418.138462999748, 4421.38100665907, 9238.260939124853, 9267.25861931044, 9357.953210233905, 9362.578683959102, 9377.578008989612, 5019.824306149268, 5020.623453241022, 5024.371953505812, 5024.422191447957, 5028.270900719448, 4299.849505267301, 4664.720116793003, 4698.7415692137265, 4803.735794531264, 4825.5174482551465, 3717.7397582168987, 3756.6619004289746, 3801.904952376213, 3844.8462061517225, 3855.768653880776, 1091.165258577189, 1091.9727006824894, 1104.1663544024211, 1107.734143805497, 1120.0871289898869, 986.7089208683456, 995.7311525887969, 1001.2240513602017, 1006.4917216805467, 1008.0977525114981, 6054.122152287981, 6180.289266734293, 6246.968765156145, 6314.684265786692, 6325.936740632626, 392.39766957719763, 401.4580316572662, 402.84691817109314, 404.6904118349465, 406.40664629640463, 4302.978485107555, 4397.956020439755, 4403.0, 4436.401085853368, 4446.399736035593, 10522.842157367646, 10848.728781780519, 10870.782584348426, 10934.726631834268, 10983.176261780398, 10737.677869663923, 10787.946060269649, 10799.406032668121, 10802.945985270024, 10860.076893464144, 7646.732364367221, 7909.762707118795, 7937.761867143995, 8089.797755056053, 8097.352211823158, 5984.281886173687, 6306.936930630635, 6336.556441049082, 6336.778212762531, 6438.581492202992, 9744.220462362851, 10105.696829095139, 10264.127549158107, 10294.948525257325, 10347.534360953925, 10298.330608510423, 10314.742131446774, 10377.688669339932, 10403.271770975958, 10420.478976051016, 7894.423023412975, 7912.525248485109, 8054.677812887418, 8102.513849169069, 8111.269985701315, 8542.18849209324, 8570.100139485265, 8581.871271931052, 8624.65501379963, 8673.826523469621, 7676.309132178131, 7918.168592297956, 7937.960310198412, 7960.363170946426, 8017.278444939983, 7639.701250787269, 7659.119201291923, 7706.253402388442, 7802.21977802238, 7903.0, 7183.389411900047, 7332.45006624516, 7399.038125043925, 7402.629868506446, 7430.888536671846, 5288.233206185005, 5308.601854860978, 5385.973070134624, 5454.509094181542, 5554.166874968787, 5159.896802063862, 5394.622376433612, 5415.5938304626525, 5452.100403433547, 5487.506124448819], "value": 4499.678297195784, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [329.6094128457778, 329.99835000824993, 333.77136661386936, 334.4131050007237, 336.78950655840106, 5332.600054995872, 5342.919856202156, 5351.49160829721, 5380.515753582177, 5382.950324686678, 5322.2282768998475, 5325.600579956509, 5331.360236771583, 5334.306540149775, 5346.518813306801, 3983.2830090583684, 4059.4316795648633, 4194.328907374806, 4195.433616461784, 4210.9578904210875, 4188.371744238373, 4196.895077623069, 4204.2432362174795, 4217.557156498569, 4220.240356735786, 3990.9201815963665, 4150.522689890656, 4161.065104726302, 4173.497540885279, 4175.394567787669, 4034.213328400978, 4038.454808600831, 4078.9592104078874, 4147.149834283965, 4168.353905144708, 3640.6177351377987, 3653.30587188436, 3658.725595580342, 3686.152184997439, 3690.464882592009, 5056.216286475602, 5125.077486052509, 5126.846194614168, 5131.589472842164, 5133.486651334874, 4691.601213896789, 4765.547273009059, 4783.665143439961, 4787.976060119712, 4802.735849528274, 5426.810061647863, 5476.205950137208, 5476.698781567012, 5486.177073438977, 5506.5870059745275, 4009.6190861868076, 4017.1563971566006, 4027.711132437621, 4059.1272876331436, 4059.640020593105, 5553.806875808779, 5673.517750991171, 5676.2620859288445, 5715.971420142872, 5729.87994442055, 4058.1072164123843, 4076.7146299758733, 4082.652974497201, 4090.775007374623, 4101.5488296287385, 4147.4815648044, 4160.583941605815, 4181.958180418218, 4188.979055104705, 4195.580441955841, 4547.795349209294, 4711.644177911045, 4718.457377401574, 4753.904921901542, 4770.642201834877, 5564.415736347625, 5584.748686309126, 5601.047821870292, 5603.411641777636, 5609.074502707008, 1434.4979257259874, 1438.496526215837, 1442.8773554247796, 1451.0, 1451.1728314860638, 931.8602209668468, 942.4345392764286, 958.3339578992533, 982.6413359124011, 985.3644399362371, 5375.81184658535, 5384.757685904144, 5388.73056347189, 5401.783928642811, 5437.374701909252, 5637.943620563742, 5646.632968857011, 5663.546916246691, 5688.715564221855, 5694.686792226385, 5208.73956302191, 5291.417944026154, 5314.70769107695, 5316.494932981361, 5387.138057910715, 2954.320506283567, 2984.6269216347955, 2985.9552106718415, 2991.641003079601, 3003.654579723316, 5508.228847961289, 5772.9711351442975, 5816.796412125555, 5825.7378417971295, 5828.562857785683, 5651.491365777099, 5711.400302968212, 5726.570507211975, 5731.226284451545, 5731.455511726379, 5737.540996720252, 5755.65466072037, 5780.277465316835, 5852.561057920673, 5855.970720146372, 5374.381946076252, 5603.691796951207, 5655.773769049192, 5743.770249189985, 5756.3380211276235, 5633.915411326755, 5684.147377893184, 5685.232493613475, 5687.800926967537, 5700.0, 5803.0, 5948.196993405835, 5951.642901425928, 6026.578139530191, 6032.758689652364, 4047.8178481967793, 4055.1078762672164, 4057.924649967702, 4065.3698676705158, 4076.0, 5544.445555444423, 5645.633033852787, 5746.195532625352, 5794.246747922743, 5841.824745257649, 5524.502794748492, 5531.917021244604, 5538.809156031472, 5558.944410556004, 5637.689927054052, 5507.862303442446, 5554.416786237549, 5582.637128586629, 5586.692731899784, 5602.215689803512, 5234.398044224963, 5442.428545002717, 5495.972520137374, 5500.449955004628, 5524.640898341595, 5607.719614019201, 5622.606417550732, 5641.238432811518, 5642.181883626933, 5683.943160568341, 5282.788688452572, 5495.175723641486, 5541.833744987657, 5571.470710282517, 5575.163725441216], "value": 4248.235802527164, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [671.6507416143602, 715.6922523314972, 741.4142827166538, 770.6647608290394, 772.9149793522712, 14800.77798833017, 15822.367105315774, 16244.431444899446, 16263.34946602136, 16270.186490675478, 13967.441302347894, 14003.229822359766, 14023.649408764786, 14028.0, 14030.298485075757, 666.6733300682655, 804.3283857978595, 813.5484805932705, 820.0323618130603, 827.4208054361941, 821.3265122599471, 824.6618886256636, 824.9628766705482, 825.154216927651, 827.4580150001758, 862.4523427623442, 863.1670438027303, 865.9610317535695, 866.3718803867177, 867.5835598912525, 685.7359916432159, 838.1869586501084, 860.475110182788, 861.2291998661194, 863.1584205399748, 625.9655718935456, 629.3391938464594, 630.2972186012609, 630.4042679667716, 630.4735545819246, 15424.845751542452, 15440.536783896501, 15445.382184712598, 15451.768223476656, 15458.768118478232, 14669.70660586793, 14927.552173434815, 15023.549293521102, 15047.247637618184, 15079.773803392958, 13398.196108233537, 13568.342186632924, 13863.4454621815, 13899.444022239099, 14001.229932353717, 4504.256797628387, 4606.516315786861, 4606.654500912445, 4743.976280118612, 4761.309610106549, 70650.0, 70668.29331706668, 70841.29158708398, 71057.2894271061, 71695.64152179206, 11247.606333778278, 11543.76912461746, 11797.88202117968, 12070.215435996632, 12385.380730963416, 21848.89075554612, 21924.123035078417, 21953.341399758032, 21955.560888782136, 21975.340739777832, 7878.251566101211, 8151.633176507072, 8157.0, 8371.916280837235, 8379.748607541784, 3985.3822657488136, 4131.194417088699, 4205.137946720914, 4320.071184695305, 4449.221386257392, 3452.3613131570237, 3555.520004799319, 3558.5195998540385, 3563.1270338767167, 3566.375884220251, 536.2974503400558, 588.3263663105805, 591.6065816232158, 591.6834493545932, 608.9208402907682, 584.2229834320344, 585.5666806563113, 594.625386006813, 621.4344946099028, 766.432839698619, 10435.895641043644, 10584.206184536191, 10699.83950240747, 10829.945850270698, 11004.174686898514, 553.9030669632798, 615.6983078291605, 616.6885722710002, 700.2157583506404, 703.2826516952782, 5005.174146265826, 5122.87192820175, 5163.3545806774155, 5206.140986737221, 5267.868303292372, 116449.41775291238, 117440.0, 119110.0, 122239.0, 122667.0, 98456.0, 105897.47051264849, 108397.0, 108673.45663271633, 108787.0, 59139.70430147822, 59217.40782592205, 84811.57594211989, 92507.0, 97116.0, 9845.803083938425, 9942.502874856373, 9956.900430995598, 10069.244806639677, 10184.23618228621, 46438.30342544932, 55688.44311556833, 56756.71621641865, 56909.715451422475, 58859.70570147122, 61123.69438152781, 81431.18568814236, 82401.58799205965, 83066.0, 84531.5773421129, 13285.933570332087, 13359.332033398485, 13467.528636497676, 14012.439502420197, 14282.57152285433, 14212.289385530888, 14311.785323219952, 14513.160179603667, 14914.477993270617, 14985.550433487013, 13478.561583511908, 13577.389017494039, 13743.725125497234, 13764.518241861486, 13928.373223204777, 12715.80926286125, 13351.065425420127, 13493.190408575518, 13516.25660588677, 13766.65583360424, 12797.55208567733, 12968.157069790434, 13465.461381544628, 14151.929240354144, 14347.35436905321, 10904.39276485807, 10905.672829815117, 11055.281406708538, 11409.942950285196, 11612.361320127475, 10994.780104398027, 11077.224594278323, 11183.0, 11257.324560526395, 11355.261907976286], "value": 7613.515596931546, "unit": "score"}], "name": "dromaeo_css", "value": 7235.986522994146, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 112.0, 111.0, 110.0, 110.0, 112.0, 110.0, 110.0, 111.0, 111.0], "value": 109.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 120.0, 119.0, 169.0, 118.0, 122.0, 144.0, 119.0, 164.0, 119.0], "value": 134.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 162.0, 160.0, 161.0, 162.0, 162.0, 162.0, 161.0, 162.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 74.0, 125.0, 75.0, 76.0, 74.0, 75.0, 99.0, 76.0], "value": 82.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 112.0, 85.0, 84.0, 85.0, 119.0, 85.0, 85.0, 136.0], "value": 96.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 116.0, 117.0, 117.0, 116.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 145.0, 146.0, 147.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 94.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 51.0, 50.0, 51.0, 51.0, 52.0, 51.0, 52.0, 51.0, 52.0], "value": 51.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 62.0, 62.0, 62.0, 62.0, 61.0, 62.0, 62.0, 62.0], "value": 61.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 75.0, 81.0, 75.0, 76.0, 76.0, 75.0, 75.0, 78.0], "value": 76.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 124.0, 116.0, 124.0, 119.0, 118.0, 119.0, 120.0, 170.0, 119.0], "value": 124.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 155.0, 154.0, 154.0, 161.0, 157.0, 158.0, 157.0, 153.0, 155.0], "value": 155.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 65.0, 68.0, 63.0, 62.0, 64.0, 62.0, 65.0, 60.0], "value": 63.4, "unit": "score"}], "name": "kraken", "value": 1474.0000000000002, "alertThreshold": 2.0}]} 04:13:37 INFO - Return code: 0 04:13:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:13:37 INFO - # TBPL SUCCESS # 04:13:37 INFO - Running post-action listener: _resource_record_post_action 04:13:37 INFO - ##### 04:13:37 INFO - ##### Finished run-tests step (success) 04:13:37 INFO - ##### 04:13:37 INFO - Running post-run listener: _resource_record_post_run 04:13:37 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 12288; Write bytes: 573624320; Read time: 220; Write time: 379272 04:13:37 INFO - TinderboxPrint: CPU usage
13.0% 04:13:37 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 220 04:13:37 INFO - TinderboxPrint: I/O write bytes / time
573,624,320 / 379,272 04:13:37 INFO - TinderboxPrint: CPU idle
8,263.7 (87.0%) 04:13:37 INFO - TinderboxPrint: CPU user
1,194.5 (12.6%) 04:13:37 INFO - TinderboxPrint: Swap in / out
0 / 0 04:13:37 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 257466368; Read time: 0; Write time: 208664 04:13:37 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 8192; Write bytes: 298934272; Read time: 204; Write time: 164924 04:13:38 INFO - Running post-run listener: _upload_blobber_files 04:13:38 INFO - Blob upload gear active. 04:13:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:13:38 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 04:13:38 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', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:13:38 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 Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:13:38 INFO - (blobuploader) - INFO - Open directory for files ... 04:13:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:13:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:13:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:13:55 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:13:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:13:55 INFO - (blobuploader) - INFO - Done attempting. 04:13:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:13:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:13:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:13:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:13:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:13:56 INFO - (blobuploader) - INFO - Done attempting. 04:13:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:13:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:13:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:13:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:13:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:13:57 INFO - (blobuploader) - INFO - Done attempting. 04:13:57 INFO - (blobuploader) - INFO - Iteration through files over. 04:13:57 INFO - Return code: 0 04:13:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:13:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:13:57 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e0fb5f1c7ee652fdedb39660e8dcae02c4011f560858b1209a36ad10d817f8f5258823813463dcef62b98b399e67da75ca040551e4413615814b1d012a6978a2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/615e2cdb7ca74676c745cd2c7d12ecd7a0c027e2c57739c6d05bb297510c91e1685cdac3bd7e1cf2a8b91ee645ab22989430c4d081be25c335f01df3b126953c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ea28a160c56a2f0df37653e5a748a7c713f090f40b366cab528b2a91589092ef5858b4f9cf4a4117992a0656b3cafe7d165f2abeb2f9df0e0ce3b2f1807d5d54"} 04:13:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:13:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:13:57 INFO - Contents: 04:13:57 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e0fb5f1c7ee652fdedb39660e8dcae02c4011f560858b1209a36ad10d817f8f5258823813463dcef62b98b399e67da75ca040551e4413615814b1d012a6978a2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/615e2cdb7ca74676c745cd2c7d12ecd7a0c027e2c57739c6d05bb297510c91e1685cdac3bd7e1cf2a8b91ee645ab22989430c4d081be25c335f01df3b126953c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ea28a160c56a2f0df37653e5a748a7c713f090f40b366cab528b2a91589092ef5858b4f9cf4a4117992a0656b3cafe7d165f2abeb2f9df0e0ce3b2f1807d5d54"} 04:13:57 INFO - Running post-run listener: copy_logs_to_upload_dir 04:13:57 INFO - Copying logs to upload dir... 04:13:57 INFO - mkdir: /builds/slave/test/build/upload/logs 04:13:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.959681 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-07-18 04:13:56.409753) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-18 04:13:56.413818) ========= 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=1f5564757af27664ca02d71f000001b0-1468839010.207572-1911851818 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e0fb5f1c7ee652fdedb39660e8dcae02c4011f560858b1209a36ad10d817f8f5258823813463dcef62b98b399e67da75ca040551e4413615814b1d012a6978a2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/615e2cdb7ca74676c745cd2c7d12ecd7a0c027e2c57739c6d05bb297510c91e1685cdac3bd7e1cf2a8b91ee645ab22989430c4d081be25c335f01df3b126953c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ea28a160c56a2f0df37653e5a748a7c713f090f40b366cab528b2a91589092ef5858b4f9cf4a4117992a0656b3cafe7d165f2abeb2f9df0e0ce3b2f1807d5d54"} build_url:https://queue.taskcluster.net/v1/task/cinzP-tsRKeCi3CD0qBtyQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011292 build_url: 'https://queue.taskcluster.net/v1/task/cinzP-tsRKeCi3CD0qBtyQ/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/Mozilla-Inbound/sha512/e0fb5f1c7ee652fdedb39660e8dcae02c4011f560858b1209a36ad10d817f8f5258823813463dcef62b98b399e67da75ca040551e4413615814b1d012a6978a2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/615e2cdb7ca74676c745cd2c7d12ecd7a0c027e2c57739c6d05bb297510c91e1685cdac3bd7e1cf2a8b91ee645ab22989430c4d081be25c335f01df3b126953c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ea28a160c56a2f0df37653e5a748a7c713f090f40b366cab528b2a91589092ef5858b4f9cf4a4117992a0656b3cafe7d165f2abeb2f9df0e0ce3b2f1807d5d54"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-18 04:13:56.439088) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 04:13:56.439454) ========= 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=1f5564757af27664ca02d71f000001b0-1468839010.207572-1911851818 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004361 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 04:13:56.523493) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-18 04:13:56.523815) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-18 04:13:56.524119) ========= ========= Total master_lag: 0.17 =========