builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-023 starttime: 1467739056.01 results: success (0) buildid: 20160705073126 builduid: 7f31b0dbb3fe4b2a9e05bd49f6a2257e revision: dbb31bcad5a1f60a35b5600ea1578d9b9fa55237 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-05 10:17:36.009368) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-05 10:17:36.009837) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-05 10:17:36.010155) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-05 10:17:36.021718) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 10:17:36.021986) ========= 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=6d15e502d8e29d5d2676d664000001c3-1467739051.453071-18295571 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-05 10:17:37-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 67.4M=0s 2016-07-05 10:17:37 (67.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.131464 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 10:17:36.165370) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 10:17:36.165730) ========= 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=6d15e502d8e29d5d2676d664000001c3-1467739051.453071-18295571 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020784 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 10:17:36.214592) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-05 10:17:36.214918) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev dbb31bcad5a1f60a35b5600ea1578d9b9fa55237 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev dbb31bcad5a1f60a35b5600ea1578d9b9fa55237 --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=6d15e502d8e29d5d2676d664000001c3-1467739051.453071-18295571 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-05 10:17:37,942 truncating revision to first 12 chars 2016-07-05 10:17:37,942 Setting DEBUG logging. 2016-07-05 10:17:37,942 attempt 1/10 2016-07-05 10:17:37,942 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/dbb31bcad5a1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-05 10:17:39,030 unpacking tar archive at: mozilla-central-dbb31bcad5a1/testing/mozharness/ program finished with exit code 0 elapsedTime=1.487799 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-05 10:17:37.716209) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-05 10:17:37.716557) ========= script_repo_revision: dbb31bcad5a1f60a35b5600ea1578d9b9fa55237 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-05 10:17:37.716931) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-05 10:17:37.717219) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-05 10:17:37.727107) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 27 secs) (at 2016-07-05 10:17:37.727376) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d15e502d8e29d5d2676d664000001c3-1467739051.453071-18295571 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:17:39 INFO - MultiFileLogger online at 20160705 10:17:39 in /builds/slave/test 10:17:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 10:17:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:17:39 INFO - {'append_to_log': False, 10:17:39 INFO - 'base_work_dir': '/builds/slave/test', 10:17:39 INFO - 'blob_upload_branch': 'Firefox', 10:17:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:17:39 INFO - 'branch': 'Firefox', 10:17:39 INFO - 'buildbot_json_path': 'buildprops.json', 10:17:39 INFO - 'config_files': ('talos/linux_config.py',), 10:17:39 INFO - 'default_actions': ('clobber', 10:17:39 INFO - 'read-buildbot-config', 10:17:39 INFO - 'download-and-extract', 10:17:39 INFO - 'populate-webroot', 10:17:39 INFO - 'create-virtualenv', 10:17:39 INFO - 'install', 10:17:39 INFO - 'run-tests'), 10:17:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:17:39 INFO - 'download_minidump_stackwalk': True, 10:17:39 INFO - 'download_symbols': 'ondemand', 10:17:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:17:39 INFO - 'tooltool.py': '/tools/tooltool.py', 10:17:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:17:39 INFO - '/tools/misc-python/virtualenv.py')}, 10:17:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:17:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:17:39 INFO - 'installer_path': 'installer.exe', 10:17:39 INFO - 'log_level': 'info', 10:17:39 INFO - 'log_name': 'talos', 10:17:39 INFO - 'log_to_console': True, 10:17:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:17:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:17:39 INFO - 'opt_config_files': (), 10:17:39 INFO - 'pip_index': False, 10:17:39 INFO - 'sps_profile': False, 10:17:39 INFO - 'sps_profile_interval': 0, 10:17:39 INFO - 'suite': 'dromaeojs-e10s', 10:17:39 INFO - 'system_bits': '32', 10:17:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:17:39 INFO - 'title': 'talos-linux64-ix-023', 10:17:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:17:39 INFO - 'use_talos_json': True, 10:17:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:17:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:17:39 INFO - 'work_dir': 'build'} 10:17:39 INFO - ##### 10:17:39 INFO - ##### Running clobber step. 10:17:39 INFO - ##### 10:17:39 INFO - Running pre-action listener: _resource_record_pre_action 10:17:39 INFO - Running main action method: clobber 10:17:39 INFO - rmtree: /builds/slave/test/build 10:17:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:17:40 INFO - Running post-action listener: _resource_record_post_action 10:17:40 INFO - ##### 10:17:40 INFO - ##### Finished clobber step (success) 10:17:40 INFO - ##### 10:17:40 INFO - ##### 10:17:40 INFO - ##### Running read-buildbot-config step. 10:17:40 INFO - ##### 10:17:40 INFO - Running pre-action listener: _resource_record_pre_action 10:17:40 INFO - Running main action method: read_buildbot_config 10:17:40 INFO - Using buildbot properties: 10:17:40 INFO - { 10:17:40 INFO - "project": "", 10:17:40 INFO - "product": "firefox", 10:17:40 INFO - "script_repo_revision": "production", 10:17:40 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 10:17:40 INFO - "repository": "", 10:17:40 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 10:17:40 INFO - "buildid": "20160705073126", 10:17:40 INFO - "pgo_build": "True", 10:17:40 INFO - "basedir": "/builds/slave/test", 10:17:40 INFO - "buildnumber": 763, 10:17:40 INFO - "slavename": "talos-linux64-ix-023", 10:17:40 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 10:17:40 INFO - "platform": "ubuntu64_hw", 10:17:40 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 10:17:40 INFO - "branch": "mozilla-central", 10:17:40 INFO - "repo_path": "mozilla-central", 10:17:40 INFO - "revision": "dbb31bcad5a1f60a35b5600ea1578d9b9fa55237", 10:17:40 INFO - "stage_platform": "linux64-pgo", 10:17:40 INFO - "builduid": "7f31b0dbb3fe4b2a9e05bd49f6a2257e", 10:17:40 INFO - "slavebuilddir": "test" 10:17:40 INFO - } 10:17:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/KpMV4ix0QPS5l89dgmA3NQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 10:17:40 INFO - Running post-action listener: _resource_record_post_action 10:17:40 INFO - ##### 10:17:40 INFO - ##### Finished read-buildbot-config step (success) 10:17:40 INFO - ##### 10:17:40 INFO - ##### 10:17:40 INFO - ##### Running download-and-extract step. 10:17:40 INFO - ##### 10:17:40 INFO - Running pre-action listener: _resource_record_pre_action 10:17:40 INFO - Running main action method: download_and_extract 10:17:40 INFO - mkdir: /builds/slave/test/build/tests 10:17:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:17:40 INFO - https://queue.taskcluster.net/v1/task/KpMV4ix0QPS5l89dgmA3NQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:17:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KpMV4ix0QPS5l89dgmA3NQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:17:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KpMV4ix0QPS5l89dgmA3NQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:17:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KpMV4ix0QPS5l89dgmA3NQ/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 10:17:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KpMV4ix0QPS5l89dgmA3NQ/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 10:17:41 INFO - Downloaded 1361 bytes. 10:17:41 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:17:41 INFO - Using the following test package requirements: 10:17:41 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 10:17:41 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:17:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:17:41 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:17:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:17:41 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:17:41 INFO - u'jsshell-linux-x86_64.zip'], 10:17:41 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:17:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:17:41 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 10:17:41 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:17:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:17:41 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:17:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:17:41 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:17:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:17:41 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:17:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:17:41 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:17:41 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')]} 10:17:41 INFO - https://queue.taskcluster.net/v1/task/KpMV4ix0QPS5l89dgmA3NQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:17:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KpMV4ix0QPS5l89dgmA3NQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:17:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KpMV4ix0QPS5l89dgmA3NQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:17:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KpMV4ix0QPS5l89dgmA3NQ/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 10:17:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KpMV4ix0QPS5l89dgmA3NQ/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 10:17:42 INFO - Downloaded 24299185 bytes. 10:17:42 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'] 10:17:42 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 10:17:43 INFO - Return code: 0 10:17:43 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 10:17:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:17:43 INFO - https://queue.taskcluster.net/v1/task/KpMV4ix0QPS5l89dgmA3NQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:17:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KpMV4ix0QPS5l89dgmA3NQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:17:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KpMV4ix0QPS5l89dgmA3NQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:17:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KpMV4ix0QPS5l89dgmA3NQ/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 10:17:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KpMV4ix0QPS5l89dgmA3NQ/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 10:17:44 INFO - Downloaded 24299185 bytes. 10:17:44 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'] 10:17:44 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 10:17:46 INFO - Return code: 0 10:17: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')]} 10:17:46 INFO - https://queue.taskcluster.net/v1/task/KpMV4ix0QPS5l89dgmA3NQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:17:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KpMV4ix0QPS5l89dgmA3NQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 10:17:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KpMV4ix0QPS5l89dgmA3NQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 10:17:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KpMV4ix0QPS5l89dgmA3NQ/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 10:17:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KpMV4ix0QPS5l89dgmA3NQ/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 10:17:47 INFO - Downloaded 14403333 bytes. 10:17:47 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'] 10:17:47 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 10:17:47 INFO - Return code: 0 10:17:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:17:47 INFO - https://queue.taskcluster.net/v1/task/KpMV4ix0QPS5l89dgmA3NQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:17:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KpMV4ix0QPS5l89dgmA3NQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:17:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KpMV4ix0QPS5l89dgmA3NQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:17:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KpMV4ix0QPS5l89dgmA3NQ/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 10:17:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KpMV4ix0QPS5l89dgmA3NQ/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 10:17:48 INFO - Downloaded 60366068 bytes. 10:17:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KpMV4ix0QPS5l89dgmA3NQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:17:48 INFO - mkdir: /builds/slave/test/properties 10:17:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:17:48 INFO - Writing to file /builds/slave/test/properties/build_url 10:17:48 INFO - Contents: 10:17:48 INFO - build_url:https://queue.taskcluster.net/v1/task/KpMV4ix0QPS5l89dgmA3NQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:17:49 INFO - Running post-action listener: _resource_record_post_action 10:17:49 INFO - Running post-action listener: set_extra_try_arguments 10:17:49 INFO - ##### 10:17:49 INFO - ##### Finished download-and-extract step (success) 10:17:49 INFO - ##### 10:17:49 INFO - ##### 10:17:49 INFO - ##### Running populate-webroot step. 10:17:49 INFO - ##### 10:17:49 INFO - Running pre-action listener: _resource_record_pre_action 10:17:49 INFO - Running main action method: populate_webroot 10:17:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:17:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:17:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:17:49 INFO - '--tppagecycles', 10:17:49 INFO - '7'], 10:17:49 INFO - 'tests': ['tsvgm']}}, 10:17:49 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:17:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:17:49 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:17:49 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:17:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:17:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:17:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:17:49 INFO - 'talos_options': ['--disable-e10s'], 10:17:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:17:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:17:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:17:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:17:49 INFO - 'talos_options': ['--disable-e10s'], 10:17:49 INFO - 'tests': ['damp', 'tps']}, 10:17:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:17:49 INFO - 'tests': ['damp', 'tps']}, 10:17:49 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:17:49 INFO - 'tests': ['dromaeo_dom']}, 10:17:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:17:49 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:17:49 INFO - 'tests': ['basic_compositor_video']}, 10:17:49 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:17:49 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:17:49 INFO - 'tests': ['a11yr', 10:17:49 INFO - 'ts_paint', 10:17:49 INFO - 'tpaint', 10:17:49 INFO - 'sessionrestore', 10:17:49 INFO - 'sessionrestore_no_auto_restore', 10:17:49 INFO - 'tabpaint']}, 10:17:49 INFO - 'other-e10s': {'tests': ['a11yr', 10:17:49 INFO - 'ts_paint', 10:17:49 INFO - 'tpaint', 10:17:49 INFO - 'sessionrestore', 10:17:49 INFO - 'sessionrestore_no_auto_restore', 10:17:49 INFO - 'tabpaint']}, 10:17:49 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:17:49 INFO - 'ts_paint', 10:17:49 INFO - 'tpaint', 10:17:49 INFO - 'sessionrestore', 10:17:49 INFO - 'sessionrestore_no_auto_restore', 10:17:49 INFO - 'tabpaint']}, 10:17:49 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:17:49 INFO - 'ts_paint', 10:17:49 INFO - 'tpaint', 10:17:49 INFO - 'sessionrestore', 10:17:49 INFO - 'sessionrestore_no_auto_restore', 10:17:49 INFO - 'tabpaint']}, 10:17:49 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:17:49 INFO - 'tests': ['a11yr', 10:17:49 INFO - 'ts_paint', 10:17:49 INFO - 'tpaint', 10:17:49 INFO - 'sessionrestore', 10:17:49 INFO - 'sessionrestore_no_auto_restore', 10:17:49 INFO - 'tabpaint']}, 10:17:49 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:17:49 INFO - 'tests': ['a11yr', 10:17:49 INFO - 'ts_paint', 10:17:49 INFO - 'tpaint', 10:17:49 INFO - 'sessionrestore', 10:17:49 INFO - 'sessionrestore_no_auto_restore', 10:17:49 INFO - 'tabpaint']}, 10:17:49 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:17:49 INFO - 'tests': ['tsvgx', 10:17:49 INFO - 'tsvgr_opacity', 10:17:49 INFO - 'tart', 10:17:49 INFO - 'tscrollx', 10:17:49 INFO - 'cart']}, 10:17:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:17:49 INFO - 'tsvgr_opacity', 10:17:49 INFO - 'tart', 10:17:49 INFO - 'tscrollx', 10:17:49 INFO - 'cart']}, 10:17:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:17:49 INFO - 'talos_options': ['--disable-e10s'], 10:17:49 INFO - 'tests': ['tp5o']}, 10:17:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:17:49 INFO - 'tests': ['tp5o']}, 10:17:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:17:49 INFO - 'talos_options': ['--disable-e10s', 10:17:49 INFO - '--xperf_path', 10:17:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:17:49 INFO - 'tests': ['tp5n']}, 10:17:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:17:49 INFO - 'talos_options': ['--xperf_path', 10:17:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:17:49 INFO - 'tests': ['tp5n']}}, 10:17:49 INFO - 'talos.zip': {'path': '', 10:17:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:17:49 INFO - Running post-action listener: _resource_record_post_action 10:17:49 INFO - ##### 10:17:49 INFO - ##### Finished populate-webroot step (success) 10:17:49 INFO - ##### 10:17:49 INFO - ##### 10:17:49 INFO - ##### Running create-virtualenv step. 10:17:49 INFO - ##### 10:17:49 INFO - Running pre-action listener: _resource_record_pre_action 10:17:49 INFO - Running main action method: create_virtualenv 10:17:49 INFO - Creating virtualenv /builds/slave/test/build/venv 10:17:49 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 10:17:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:17:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:17:49 INFO - Using real prefix '/usr' 10:17:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:17:50 INFO - Installing distribute.............................................................................................................................................................................................done. 10:17:51 INFO - Installing pip.................done. 10:17:51 INFO - Return code: 0 10:17:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:17:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:17:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:17:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:17:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:17:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17:51 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 0x289a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b5b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b593b0>, '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 0x2b5a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b5a740>, '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': '6d15e502d8e29d5d2676d664000001c3-1467739051.453071-18295571', '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 10:17:51 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 10:17:51 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 10:17:51 INFO - Using env: {'DISPLAY': ':0', 10:17:51 INFO - 'HOME': '/home/cltbld', 10:17:51 INFO - 'LANG': 'en_US.UTF-8', 10:17:51 INFO - 'LANGUAGE': 'en_US:en', 10:17:51 INFO - 'LOGNAME': 'cltbld', 10:17:51 INFO - 'MAIL': '/var/mail/cltbld', 10:17:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:17:51 INFO - 'MOZ_NO_REMOTE': '1', 10:17:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:17:51 INFO - 'NO_EM_RESTART': '1', 10:17:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:17:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:17:52 INFO - 'PWD': '/builds/slave/test', 10:17:52 INFO - 'SHELL': '/bin/bash', 10:17:52 INFO - 'SHLVL': '1', 10:17:52 INFO - 'TERM': 'linux', 10:17:52 INFO - 'TMOUT': '86400', 10:17:52 INFO - 'USER': 'cltbld', 10:17:52 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1467739051.453071-18295571', 10:17:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:17:52 INFO - '_': '/tools/buildbot/bin/python'} 10:17:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:17:52 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 10:17:52 INFO - Cleaning up... 10:17:52 INFO - Return code: 0 10:17:52 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:17:52 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')]} 10:17:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:17:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17:52 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')]} 10:17:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:17:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17:52 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 0x289a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b5b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b593b0>, '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 0x2b5a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b5a740>, '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': '6d15e502d8e29d5d2676d664000001c3-1467739051.453071-18295571', '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 10:17:52 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 10:17:52 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 10:17:52 INFO - Using env: {'DISPLAY': ':0', 10:17:52 INFO - 'HOME': '/home/cltbld', 10:17:52 INFO - 'LANG': 'en_US.UTF-8', 10:17:52 INFO - 'LANGUAGE': 'en_US:en', 10:17:52 INFO - 'LOGNAME': 'cltbld', 10:17:52 INFO - 'MAIL': '/var/mail/cltbld', 10:17:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:17:52 INFO - 'MOZ_NO_REMOTE': '1', 10:17:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:17:52 INFO - 'NO_EM_RESTART': '1', 10:17:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:17:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:17:52 INFO - 'PWD': '/builds/slave/test', 10:17:52 INFO - 'SHELL': '/bin/bash', 10:17:52 INFO - 'SHLVL': '1', 10:17:52 INFO - 'TERM': 'linux', 10:17:52 INFO - 'TMOUT': '86400', 10:17:52 INFO - 'USER': 'cltbld', 10:17:52 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1467739051.453071-18295571', 10:17:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:17:52 INFO - '_': '/tools/buildbot/bin/python'} 10:17:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:17:52 INFO - Downloading/unpacking psutil>=3.1.1 10:17:52 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 10:17:52 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 10:17:52 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 10:17:52 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 10:17:52 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 10:17:52 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 10:17:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:17:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:17:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:17:54 INFO - Installing collected packages: psutil 10:17:54 INFO - Running setup.py install for psutil 10:17:54 INFO - building 'psutil._psutil_linux' extension 10:17:54 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 10:17:54 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 10:17:54 INFO - building 'psutil._psutil_posix' extension 10:17:54 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 10:17:54 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 10:17:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:17:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:17:54 INFO - Successfully installed psutil 10:17:54 INFO - Cleaning up... 10:17:55 INFO - Return code: 0 10:17:55 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:17:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:17:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:17:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:17:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:17:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17:55 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 0x289a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b5b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b593b0>, '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 0x2b5a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b5a740>, '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': '6d15e502d8e29d5d2676d664000001c3-1467739051.453071-18295571', '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 10:17:55 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 10:17:55 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 10:17:55 INFO - Using env: {'DISPLAY': ':0', 10:17:55 INFO - 'HOME': '/home/cltbld', 10:17:55 INFO - 'LANG': 'en_US.UTF-8', 10:17:55 INFO - 'LANGUAGE': 'en_US:en', 10:17:55 INFO - 'LOGNAME': 'cltbld', 10:17:55 INFO - 'MAIL': '/var/mail/cltbld', 10:17:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:17:55 INFO - 'MOZ_NO_REMOTE': '1', 10:17:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:17:55 INFO - 'NO_EM_RESTART': '1', 10:17:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:17:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:17:55 INFO - 'PWD': '/builds/slave/test', 10:17:55 INFO - 'SHELL': '/bin/bash', 10:17:55 INFO - 'SHLVL': '1', 10:17:55 INFO - 'TERM': 'linux', 10:17:55 INFO - 'TMOUT': '86400', 10:17:55 INFO - 'USER': 'cltbld', 10:17:55 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1467739051.453071-18295571', 10:17:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:17:55 INFO - '_': '/tools/buildbot/bin/python'} 10:17:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:17:55 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:17:55 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 10:17:55 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 10:17:55 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 10:17:55 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 10:17:55 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 10:17:55 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 10:17:57 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:17:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:17:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:17:57 INFO - Installing collected packages: mozsystemmonitor 10:17:57 INFO - Running setup.py install for mozsystemmonitor 10:17:57 INFO - Successfully installed mozsystemmonitor 10:17:57 INFO - Cleaning up... 10:17:57 INFO - Return code: 0 10:17:57 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:17:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:17:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:17:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:17:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:17:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17:57 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 0x289a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b5b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b593b0>, '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 0x2b5a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b5a740>, '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': '6d15e502d8e29d5d2676d664000001c3-1467739051.453071-18295571', '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 10:17:57 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 10:17:57 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 10:17:57 INFO - Using env: {'DISPLAY': ':0', 10:17:57 INFO - 'HOME': '/home/cltbld', 10:17:57 INFO - 'LANG': 'en_US.UTF-8', 10:17:57 INFO - 'LANGUAGE': 'en_US:en', 10:17:57 INFO - 'LOGNAME': 'cltbld', 10:17:57 INFO - 'MAIL': '/var/mail/cltbld', 10:17:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:17:57 INFO - 'MOZ_NO_REMOTE': '1', 10:17:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:17:57 INFO - 'NO_EM_RESTART': '1', 10:17:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:17:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:17:57 INFO - 'PWD': '/builds/slave/test', 10:17:57 INFO - 'SHELL': '/bin/bash', 10:17:57 INFO - 'SHLVL': '1', 10:17:57 INFO - 'TERM': 'linux', 10:17:57 INFO - 'TMOUT': '86400', 10:17:57 INFO - 'USER': 'cltbld', 10:17:57 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1467739051.453071-18295571', 10:17:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:17:57 INFO - '_': '/tools/buildbot/bin/python'} 10:17:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:17:57 INFO - Downloading/unpacking jsonschema==2.5.1 10:17:57 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 10:17:57 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 10:17:57 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 10:17:57 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 10:17:57 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 10:17:57 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 10:17:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:17:59 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:17:59 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 10:17:59 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 10:17:59 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 10:17:59 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 10:17:59 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 10:17:59 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 10:17:59 INFO - Downloading functools32-3.2.3-2.tar.gz 10:17:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:17:59 INFO - warning: no files found matching '*.txt' 10:17:59 INFO - no previously-included directories found matching 'build' 10:17:59 INFO - no previously-included directories found matching 'dist' 10:17:59 INFO - no previously-included directories found matching '.git*' 10:17:59 INFO - Installing collected packages: jsonschema, functools32 10:17:59 INFO - Running setup.py install for functools32 10:17:59 INFO - warning: no files found matching '*.txt' 10:17:59 INFO - no previously-included directories found matching 'build' 10:17:59 INFO - no previously-included directories found matching 'dist' 10:17:59 INFO - no previously-included directories found matching '.git*' 10:17:59 INFO - Successfully installed jsonschema functools32 10:17:59 INFO - Cleaning up... 10:17:59 INFO - Return code: 0 10:17:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:17:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:17:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:17:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:17:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:17:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17:59 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 0x289a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b5b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b593b0>, '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 0x2b5a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b5a740>, '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': '6d15e502d8e29d5d2676d664000001c3-1467739051.453071-18295571', '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 10:17:59 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 10:17:59 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 10:17:59 INFO - Using env: {'DISPLAY': ':0', 10:17:59 INFO - 'HOME': '/home/cltbld', 10:17:59 INFO - 'LANG': 'en_US.UTF-8', 10:17:59 INFO - 'LANGUAGE': 'en_US:en', 10:17:59 INFO - 'LOGNAME': 'cltbld', 10:17:59 INFO - 'MAIL': '/var/mail/cltbld', 10:17:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:17:59 INFO - 'MOZ_NO_REMOTE': '1', 10:17:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:17:59 INFO - 'NO_EM_RESTART': '1', 10:17:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:17:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:17:59 INFO - 'PWD': '/builds/slave/test', 10:17:59 INFO - 'SHELL': '/bin/bash', 10:17:59 INFO - 'SHLVL': '1', 10:17:59 INFO - 'TERM': 'linux', 10:17:59 INFO - 'TMOUT': '86400', 10:17:59 INFO - 'USER': 'cltbld', 10:17:59 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1467739051.453071-18295571', 10:17:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:17:59 INFO - '_': '/tools/buildbot/bin/python'} 10:18:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:18:00 INFO - Downloading/unpacking blobuploader==1.2.4 10:18:00 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 10:18:00 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 10:18:00 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 10:18:00 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 10:18:00 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 10:18:00 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 10:18:02 INFO - Downloading blobuploader-1.2.4.tar.gz 10:18:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:18:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:18:02 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 10:18:02 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 10:18:02 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 10:18:02 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 10:18:02 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 10:18:02 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 10:18:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:18:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:18:02 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 10:18:02 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 10:18:02 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 10:18:02 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 10:18:02 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 10:18:02 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 10:18:02 INFO - Downloading docopt-0.6.1.tar.gz 10:18:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:18:02 INFO - Installing collected packages: blobuploader, requests, docopt 10:18:02 INFO - Running setup.py install for blobuploader 10:18:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:18:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:18:02 INFO - Running setup.py install for requests 10:18:03 INFO - Running setup.py install for docopt 10:18:03 INFO - Successfully installed blobuploader requests docopt 10:18:03 INFO - Cleaning up... 10:18:03 INFO - Return code: 0 10:18:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:18:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:18:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:18:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:18:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:18:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:18:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:18:03 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 0x289a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b5b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b593b0>, '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 0x2b5a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b5a740>, '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': '6d15e502d8e29d5d2676d664000001c3-1467739051.453071-18295571', '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 10:18:03 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 10:18:03 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 10:18:03 INFO - Using env: {'DISPLAY': ':0', 10:18:03 INFO - 'HOME': '/home/cltbld', 10:18:03 INFO - 'LANG': 'en_US.UTF-8', 10:18:03 INFO - 'LANGUAGE': 'en_US:en', 10:18:03 INFO - 'LOGNAME': 'cltbld', 10:18:03 INFO - 'MAIL': '/var/mail/cltbld', 10:18:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:18:03 INFO - 'MOZ_NO_REMOTE': '1', 10:18:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:18:03 INFO - 'NO_EM_RESTART': '1', 10:18:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:18:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:18:03 INFO - 'PWD': '/builds/slave/test', 10:18:03 INFO - 'SHELL': '/bin/bash', 10:18:03 INFO - 'SHLVL': '1', 10:18:03 INFO - 'TERM': 'linux', 10:18:03 INFO - 'TMOUT': '86400', 10:18:03 INFO - 'USER': 'cltbld', 10:18:03 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1467739051.453071-18295571', 10:18:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:18:03 INFO - '_': '/tools/buildbot/bin/python'} 10:18:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:18:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:18:03 INFO - Running setup.py (path:/tmp/pip-rOS4IG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:18:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:18:03 INFO - Running setup.py (path:/tmp/pip-OVPhXN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:18:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:18:03 INFO - Running setup.py (path:/tmp/pip-mexSZv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:18:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:18:03 INFO - Running setup.py (path:/tmp/pip-6Ty8Xi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:18:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:18:03 INFO - Running setup.py (path:/tmp/pip-xr1yCH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:18:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:18:04 INFO - Running setup.py (path:/tmp/pip-Mqi6p_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:18:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:18:04 INFO - Running setup.py (path:/tmp/pip-Xgt1PO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:18:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:18:04 INFO - Running setup.py (path:/tmp/pip-zacZM8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:18:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:18:04 INFO - Running setup.py (path:/tmp/pip-5JHakb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:18:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:18:04 INFO - Running setup.py (path:/tmp/pip-9o6J30-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:18:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:18:04 INFO - Running setup.py (path:/tmp/pip-LgW7qN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:18:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:18:04 INFO - Running setup.py (path:/tmp/pip-m8LSAV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:18:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:18:04 INFO - Running setup.py (path:/tmp/pip-PwYlB8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:18:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:18:04 INFO - Running setup.py (path:/tmp/pip-Qh8Fan-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:18:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:18:04 INFO - Running setup.py (path:/tmp/pip-3UXhHm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:18:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:18:04 INFO - Running setup.py (path:/tmp/pip-paXrUa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:18:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:18:04 INFO - Running setup.py (path:/tmp/pip-9oc9AX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:18:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:18:04 INFO - Running setup.py install for manifestparser 10:18:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:18:04 INFO - Running setup.py install for mozcrash 10:18:05 INFO - Running setup.py install for mozdebug 10:18:05 INFO - Running setup.py install for mozdevice 10:18:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:18:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:18:05 INFO - Running setup.py install for mozfile 10:18:05 INFO - Running setup.py install for mozhttpd 10:18:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:18:05 INFO - Running setup.py install for mozinfo 10:18:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:18:05 INFO - Running setup.py install for mozInstall 10:18:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:18:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:18:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:18:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:18:05 INFO - Running setup.py install for mozleak 10:18:05 INFO - Running setup.py install for mozlog 10:18:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:18:05 INFO - Running setup.py install for moznetwork 10:18:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:18:05 INFO - Running setup.py install for mozprocess 10:18:06 INFO - Running setup.py install for mozprofile 10:18:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:18:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:18:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:18:06 INFO - Running setup.py install for mozrunner 10:18:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:18:06 INFO - Running setup.py install for mozscreenshot 10:18:06 INFO - Running setup.py install for moztest 10:18:06 INFO - Running setup.py install for mozversion 10:18:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:18:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:18:06 INFO - Cleaning up... 10:18:06 INFO - Return code: 0 10:18:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:18:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:18:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:18:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:18:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:18:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:18:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:18:06 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 0x289a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b5b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b593b0>, '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 0x2b5a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b5a740>, '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': '6d15e502d8e29d5d2676d664000001c3-1467739051.453071-18295571', '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 10:18:06 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 10:18:06 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 10:18:06 INFO - Using env: {'DISPLAY': ':0', 10:18:06 INFO - 'HOME': '/home/cltbld', 10:18:06 INFO - 'LANG': 'en_US.UTF-8', 10:18:06 INFO - 'LANGUAGE': 'en_US:en', 10:18:06 INFO - 'LOGNAME': 'cltbld', 10:18:06 INFO - 'MAIL': '/var/mail/cltbld', 10:18:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:18:06 INFO - 'MOZ_NO_REMOTE': '1', 10:18:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:18:06 INFO - 'NO_EM_RESTART': '1', 10:18:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:18:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:18:06 INFO - 'PWD': '/builds/slave/test', 10:18:06 INFO - 'SHELL': '/bin/bash', 10:18:06 INFO - 'SHLVL': '1', 10:18:06 INFO - 'TERM': 'linux', 10:18:06 INFO - 'TMOUT': '86400', 10:18:06 INFO - 'USER': 'cltbld', 10:18:06 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1467739051.453071-18295571', 10:18:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:18:06 INFO - '_': '/tools/buildbot/bin/python'} 10:18:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:18:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:18:06 INFO - Running setup.py (path:/tmp/pip-PLMq7s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:18:06 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)) 10:18:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:18:06 INFO - Running setup.py (path:/tmp/pip-f1Z8y9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:18:07 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)) 10:18:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:18:07 INFO - Running setup.py (path:/tmp/pip-goHhir-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:18:07 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)) 10:18:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:18:07 INFO - Running setup.py (path:/tmp/pip-LC1ntR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:18:07 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)) 10:18:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:18:07 INFO - Running setup.py (path:/tmp/pip-l6FLqR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:18:07 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)) 10:18:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:18:07 INFO - Running setup.py (path:/tmp/pip-Wl6Jht-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:18:07 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)) 10:18:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:18:07 INFO - Running setup.py (path:/tmp/pip-K7dwtQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:18:07 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)) 10:18:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:18:07 INFO - Running setup.py (path:/tmp/pip-AU7_5x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:18:07 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)) 10:18:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:18:07 INFO - Running setup.py (path:/tmp/pip-uGd_0C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:18:07 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)) 10:18:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:18:07 INFO - Running setup.py (path:/tmp/pip-oTXNqf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:18:07 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)) 10:18:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:18:07 INFO - Running setup.py (path:/tmp/pip-JGMaWS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:18:07 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)) 10:18:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:18:07 INFO - Running setup.py (path:/tmp/pip-Hz9qqQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:18:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 10:18:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:18:07 INFO - Running setup.py (path:/tmp/pip-3Ku4tP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:18:07 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)) 10:18:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:18:07 INFO - Running setup.py (path:/tmp/pip-3Lt7_Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:18:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 10:18:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:18:07 INFO - Running setup.py (path:/tmp/pip-KOoUyT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:18:07 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)) 10:18:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:18:07 INFO - Running setup.py (path:/tmp/pip-chl3_2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:18:08 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)) 10:18:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:18:08 INFO - Running setup.py (path:/tmp/pip-7fVYBY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:18:08 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)) 10:18:08 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)) 10:18:08 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)) 10:18:08 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)) 10:18:08 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)) 10:18:08 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)) 10:18:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:18:08 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 10:18:08 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 10:18:08 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 10:18:08 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 10:18:08 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 10:18:08 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 10:18:09 INFO - Downloading blessings-1.6.tar.gz 10:18:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:18:10 INFO - Installing collected packages: blessings 10:18:10 INFO - Running setup.py install for blessings 10:18:10 INFO - Successfully installed blessings 10:18:10 INFO - Cleaning up... 10:18:10 INFO - Return code: 0 10:18:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:18:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:18:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:18:10 INFO - Reading from file tmpfile_stdout 10:18:10 INFO - Current package versions: 10:18:10 INFO - argparse == 1.2.1 10:18:10 INFO - blessings == 1.6 10:18:10 INFO - blobuploader == 1.2.4 10:18:10 INFO - docopt == 0.6.1 10:18:10 INFO - functools32 == 3.2.3-2 10:18:10 INFO - jsonschema == 2.5.1 10:18:10 INFO - manifestparser == 1.1 10:18:10 INFO - mozInstall == 1.12 10:18:10 INFO - mozcrash == 0.17 10:18:10 INFO - mozdebug == 0.1 10:18:10 INFO - mozdevice == 0.48 10:18:10 INFO - mozfile == 1.2 10:18:10 INFO - mozhttpd == 0.7 10:18:10 INFO - mozinfo == 0.9 10:18:10 INFO - mozleak == 0.1 10:18:10 INFO - mozlog == 3.2 10:18:10 INFO - moznetwork == 0.27 10:18:10 INFO - mozprocess == 0.22 10:18:10 INFO - mozprofile == 0.28 10:18:10 INFO - mozrunner == 6.11 10:18:10 INFO - mozscreenshot == 0.1 10:18:10 INFO - mozsystemmonitor == 0.3 10:18:10 INFO - moztest == 0.7 10:18:10 INFO - mozversion == 1.4 10:18:10 INFO - psutil == 3.1.1 10:18:10 INFO - requests == 1.2.3 10:18:10 INFO - wsgiref == 0.1.2 10:18:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:18: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')]} 10:18:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:18:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:18: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')]} 10:18:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:18:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:18:10 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 0x289a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b5b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b593b0>, '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 0x2b5a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b5a740>, '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': '6d15e502d8e29d5d2676d664000001c3-1467739051.453071-18295571', '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 10:18:10 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 10:18:10 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 10:18:10 INFO - Using env: {'DISPLAY': ':0', 10:18:10 INFO - 'HOME': '/home/cltbld', 10:18:10 INFO - 'LANG': 'en_US.UTF-8', 10:18:10 INFO - 'LANGUAGE': 'en_US:en', 10:18:10 INFO - 'LOGNAME': 'cltbld', 10:18:10 INFO - 'MAIL': '/var/mail/cltbld', 10:18:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:18:10 INFO - 'MOZ_NO_REMOTE': '1', 10:18:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:18:10 INFO - 'NO_EM_RESTART': '1', 10:18:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:18:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:18:10 INFO - 'PWD': '/builds/slave/test', 10:18:10 INFO - 'SHELL': '/bin/bash', 10:18:10 INFO - 'SHLVL': '1', 10:18:10 INFO - 'TERM': 'linux', 10:18:10 INFO - 'TMOUT': '86400', 10:18:10 INFO - 'USER': 'cltbld', 10:18:10 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1467739051.453071-18295571', 10:18:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:18:10 INFO - '_': '/tools/buildbot/bin/python'} 10:18:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:18:10 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)) 10:18:10 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)) 10:18:10 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)) 10:18:10 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)) 10:18:10 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)) 10:18:10 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)) 10:18:10 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)) 10:18:10 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)) 10:18:10 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)) 10:18:10 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)) 10:18:10 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)) 10:18:10 INFO - Cleaning up... 10:18:10 INFO - Return code: 0 10:18:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:18: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')]} 10:18:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:18:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:18: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')]} 10:18:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:18:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:18:10 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 0x289a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b5b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b593b0>, '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 0x2b5a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b5a740>, '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': '6d15e502d8e29d5d2676d664000001c3-1467739051.453071-18295571', '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 10:18:10 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 10:18:10 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 10:18:10 INFO - Using env: {'DISPLAY': ':0', 10:18:10 INFO - 'HOME': '/home/cltbld', 10:18:10 INFO - 'LANG': 'en_US.UTF-8', 10:18:10 INFO - 'LANGUAGE': 'en_US:en', 10:18:10 INFO - 'LOGNAME': 'cltbld', 10:18:10 INFO - 'MAIL': '/var/mail/cltbld', 10:18:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:18:10 INFO - 'MOZ_NO_REMOTE': '1', 10:18:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:18:10 INFO - 'NO_EM_RESTART': '1', 10:18:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:18:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:18:10 INFO - 'PWD': '/builds/slave/test', 10:18:10 INFO - 'SHELL': '/bin/bash', 10:18:10 INFO - 'SHLVL': '1', 10:18:10 INFO - 'TERM': 'linux', 10:18:10 INFO - 'TMOUT': '86400', 10:18:10 INFO - 'USER': 'cltbld', 10:18:10 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1467739051.453071-18295571', 10:18:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:18:10 INFO - '_': '/tools/buildbot/bin/python'} 10:18:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:18:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:18:10 INFO - Cleaning up... 10:18:10 INFO - Return code: 0 10:18:10 INFO - Running post-action listener: _resource_record_post_action 10:18:10 INFO - Running post-action listener: _start_resource_monitoring 10:18:10 INFO - Starting resource monitoring. 10:18:10 INFO - ##### 10:18:10 INFO - ##### Finished create-virtualenv step (success) 10:18:10 INFO - ##### 10:18:10 INFO - ##### 10:18:10 INFO - ##### Running install step. 10:18:10 INFO - ##### 10:18:10 INFO - Running pre-action listener: _resource_record_pre_action 10:18:10 INFO - Running main action method: install 10:18:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:18:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:18:11 INFO - Reading from file tmpfile_stdout 10:18:11 INFO - Detecting whether we're running mozinstall >=1.0... 10:18:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:18:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:18:11 INFO - Reading from file tmpfile_stdout 10:18:11 INFO - Output received: 10:18:11 INFO - Usage: mozinstall [options] installer 10:18:11 INFO - Options: 10:18:11 INFO - -h, --help show this help message and exit 10:18:11 INFO - -d DEST, --destination=DEST 10:18:11 INFO - Directory to install application into. [default: 10:18:11 INFO - "/builds/slave/test"] 10:18:11 INFO - --app=APP Application being installed. [default: firefox] 10:18:11 INFO - mkdir: /builds/slave/test/build/application 10:18:11 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'] 10:18:11 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 10:18:28 INFO - Reading from file tmpfile_stdout 10:18:28 INFO - Output received: 10:18:28 INFO - /builds/slave/test/build/application/firefox/firefox 10:18:28 INFO - Running post-action listener: _resource_record_post_action 10:18:28 INFO - ##### 10:18:28 INFO - ##### Finished install step (success) 10:18:28 INFO - ##### 10:18:28 INFO - ##### 10:18:28 INFO - ##### Running run-tests step. 10:18:28 INFO - ##### 10:18:28 INFO - Running pre-action listener: _resource_record_pre_action 10:18:28 INFO - Running main action method: run_tests 10:18:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:18:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:18:28 INFO - Python 2.7.3 10:18:28 INFO - Return code: 0 10:18:28 INFO - grabbing minidump binary from tooltool 10:18: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')]} 10:18:28 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 0x2b593b0>, '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 0x2b5a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b5a740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:18:28 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 10:18:28 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 10:18:28 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 10:18:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:18:28 INFO - Return code: 0 10:18:28 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:18:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:18:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:18:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:18:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:18:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KpMV4ix0QPS5l89dgmA3NQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 10:18:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/KpMV4ix0QPS5l89dgmA3NQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-023 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 10:18:28 INFO - Using env: {'DISPLAY': ':0', 10:18:28 INFO - 'HOME': '/home/cltbld', 10:18:28 INFO - 'LANG': 'en_US.UTF-8', 10:18:28 INFO - 'LANGUAGE': 'en_US:en', 10:18:28 INFO - 'LOGNAME': 'cltbld', 10:18:28 INFO - 'MAIL': '/var/mail/cltbld', 10:18:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:18:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:18:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:18:28 INFO - 'MOZ_NO_REMOTE': '1', 10:18:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:18:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:18:28 INFO - 'NO_EM_RESTART': '1', 10:18:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:18:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:18:28 INFO - 'PWD': '/builds/slave/test', 10:18:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:18:28 INFO - 'SHELL': '/bin/bash', 10:18:28 INFO - 'SHLVL': '1', 10:18:28 INFO - 'TERM': 'linux', 10:18:28 INFO - 'TMOUT': '86400', 10:18:28 INFO - 'USER': 'cltbld', 10:18:28 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1467739051.453071-18295571', 10:18:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:18:28 INFO - '_': '/tools/buildbot/bin/python'} 10:18:28 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KpMV4ix0QPS5l89dgmA3NQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 10:18:28 INFO - mozversion application_buildid: 20160705073126 10:18:28 INFO - mozversion application_changeset: dbb31bcad5a1f60a35b5600ea1578d9b9fa55237 10:18:28 INFO - mozversion application_display_name: Nightly 10:18:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:18:28 INFO - mozversion application_name: Firefox 10:18:28 INFO - mozversion application_remotingname: firefox 10:18:28 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:18:28 INFO - mozversion application_vendor: Mozilla 10:18:28 INFO - mozversion application_version: 50.0a1 10:18:28 INFO - mozversion platform_buildid: 20160705073126 10:18:28 INFO - mozversion platform_changeset: dbb31bcad5a1f60a35b5600ea1578d9b9fa55237 10:18:28 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:18:28 INFO - mozversion platform_version: 50.0a1 10:18:28 INFO - using testdate: 1467739108 10:18:28 INFO - actual date: 1467739108 10:18:28 INFO - starting webserver on 'localhost:57397' 10:18:28 INFO - SUITE-START | Running 2 tests 10:18:28 INFO - TEST-START | dromaeo_css 10:18:28 INFO - operating with platform_type : linux_ 10:18:28 INFO - Initialising browser for dromaeo_css test... 10:18:28 INFO - TEST-INFO | started process 27741 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZ9oel9/profile http://localhost:57397/getInfo.html) 10:18:33 INFO - PROCESS | 27741 | __metrics Screen width/height:1600/1200 10:18:33 INFO - PROCESS | 27741 | colorDepth:24 10:18:33 INFO - PROCESS | 27741 | Browser inner width/height: 1024/697 10:18:33 INFO - PROCESS | 27741 | __metrics 10:18:34 ERROR - PROCESS | 27741 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 10:18:34 INFO - TEST-INFO | 27741: exit 0 10:18:34 INFO - Browser initialized. 10:18:34 INFO - Running cycle 1/1 for dromaeo_css test... 10:18:34 INFO - TEST-INFO | started process 27862 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZ9oel9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:18:46 INFO - PROCESS | 27862 | RSS: Main: 168017920 10:18:46 INFO - PROCESS | 27862 | 10:19:36 INFO - PROCESS | 27862 | 1467739176335 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] 10:21:43 INFO - PROCESS | 27862 | Cycle 1(1): loaded http://localhost:57397/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57397/tests/dromaeo/cssquery-ext.html) 10:21:44 INFO - PROCESS | 27862 | RSS: Main: 172699648 10:21:44 INFO - PROCESS | 27862 | 10:24:46 INFO - PROCESS | 27862 | Cycle 1(1): loaded http://localhost:57397/tests/dromaeo/cssquery-ext.html (next: http://localhost:57397/tests/dromaeo/cssquery-jquery.html) 10:24:47 INFO - PROCESS | 27862 | RSS: Main: 168730624 10:24:47 INFO - PROCESS | 27862 | 10:27:49 INFO - PROCESS | 27862 | Cycle 1(1): loaded http://localhost:57397/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57397/tests/dromaeo/cssquery-mootools.html) 10:27:49 INFO - PROCESS | 27862 | RSS: Main: 171180032 10:27:49 INFO - PROCESS | 27862 | 10:30:51 INFO - PROCESS | 27862 | Cycle 1(1): loaded http://localhost:57397/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57397/tests/dromaeo/cssquery-prototype.html) 10:30:52 INFO - PROCESS | 27862 | RSS: Main: 167256064 10:30:52 INFO - PROCESS | 27862 | 10:33:54 INFO - PROCESS | 27862 | Cycle 1(1): loaded http://localhost:57397/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57397/tests/dromaeo/cssquery-yui.html) 10:33:55 INFO - PROCESS | 27862 | RSS: Main: 169246720 10:33:55 INFO - PROCESS | 27862 | 10:36:57 INFO - PROCESS | 27862 | Cycle 1(1): loaded http://localhost:57397/tests/dromaeo/cssquery-yui.html (next: http://localhost:57397/tests/dromaeo/cssquery-dojo.html) 10:36:57 INFO - PROCESS | 27862 | RSS: Main: 170438656 10:36:57 INFO - PROCESS | 27862 | 10:36:57 INFO - PROCESS | 27862 | __start_tp_report 10:36:57 INFO - PROCESS | 27862 | _x_x_mozilla_page_load 10:36:57 INFO - PROCESS | 27862 | _x_x_mozilla_page_load_details 10:36:57 INFO - PROCESS | 27862 | |i|pagename|runs| 10:36:57 INFO - PROCESS | 27862 | |0;dojo.html;3079.507278835386;3143.9842800786023;3161.099086760273;3173.8095714257147;3180.061881744885;5318.042752304588;5356.544693701036;5362.8123015694455;5374.274472946151;5405.5135037846585;5217;5285.2600635911;5303.522682958533;5305;5360.9463905360935;4866.07544566533;4896.069746748124;4946.431160416544;4959;4976.875578110558;4962.280469331945;5024.82413115541;5029.597632189416;5038.899222015558;5068.087744206042;213.24025732051945;4863.8784030399165;4956.5043495650325;4966.751662416865;4977.1538838397555;4829.879253018667;4833.492483289239;4840.564349208553;4846.5153484651255;4876.68301560401;4811.302361157613;4821.638377121695;4822.300766388889;4834.516548345137;4853.272009198613;5112.18205087188;5264.92102618461;5304.071787437183;5304.336957880265;5333.546648534879;5729.656220626775;5738.081906894919;5742.569307301969;5746.13807928814;5749.137629355589;5617.101263797814;5810.1865738796605;5810.273715785527;5820;5829.09649004405;5335.546478549328;5378.435264297232;5385.7307134643115;5431.809886653988;5439.673619582798;5908.084246941731;5909.025010873243;5919.970400148058;5921.792737254175;5926;5453.727313634382;5494.313210848644;5667.1782591524;5686.175504551817;5687.03320435527;5586.860328491739;5655.971720141455;5656.4060773619;5658;5711.771529138788;5551.500364967092;5593.133064375028;5619.80330688424;5628;5632.408597097246;5539.944600554023;5659.943400566024;5679.602427830095;5708.942910570841;5718.51392631631;4263.509696384894;4323.654107671442;4369.47566292047;4390.363397307373;4412.823487060546;3892.5718171001167;3914.823832927525;3926.411038344214;3945.6054394560315;3996;5320.600954928396;5363.517283444508;5423.457654234545;5486.615936884459;5488.25908502355;5629.043062679354;5701.942980570141;5719.771209151588;5747.1379293106365;5774.538036957033;5374.247605335257;5404.972975135099;5443.918341224885;5445.972770136124;5450.645708028966;4822.71063736177;4843.636727245471;4866.46468888422;4902.681325713888;4953.281774142729;5856.677882716492;5862.765489380462;5865.178874957509;5866.208061911588;5903.26209223847;5614.578906581941;5647.435256474402;5677.971610141923;5680.403557626472;5690.402507736628;5688.431156884444;5850.912236316543;5861.853453663522;5899.882002359843;5902.970485147547;5625.240592519957;5629.8592535186945;5630.85922851932;5631.746571404215;5633.295838020247;5742.741576628978;5743.913841292468;5752.798652047326;5754;5759.8560035999435;5335.226392173191;5528.695921724344;5539.667619942817;5554.972225138848;5571.832845014656;5495.477929596682;5537.889242215053;5548.250986116823;5558.416366281644;5568.9443105568425;5378.300820893259;5463.918041229305;5493.505584497414;5494.09347457665;5494.203340515683;5391.083515802401;5435.565154787687;5465.535429488538;5482.23248745184;5484.287042684426;5339.893202136013;5422.051141050221;5462.3445186577865;5518.668879867221;5523.834284971457 10:36:57 INFO - PROCESS | 27862 | |1;ext.html;550.4844553444883;592.493418127501;603.879224155169;605.5004621187521;637.2798737426707;38220.235595288075;42432;43020;43125.35311970319;43371.56628433715;42824.14351712964;43400.78299608506;43452.13095738083;43471.56528434715;43563.128737425235;8745.387822852419;8888.911110888874;8891.911080889206;8913.910860891405;8929.374943753939;8797.868031979526;8860.556972151398;8887.955560222223;8901.688440904569;8901.732948011537;8918.910810891904;8934.687285944994;8955.149260820212;8957.328200384965;8963.058878817728;8890.066543012988;8910.465372077664;8925.152110549487;8933.285337173043;8933.687320943736;8765.474071555664;8771.780705482413;8787.340949428755;8795.252403545706;8800.691975780817;32765.6723432765;40572.18855622871;41037.589624103675;41211.175776484604;41229.38155927663;3281.1797050737314;3324.25204329024;3545.94681079784;3852.7303088783797;4137.54487006429;30657.846710766527;30691.386172276652;30695.232619184477;31513.52729709056;31876.840615796773;4151.91696166078;4252.213340531981;4367.3667318238995;4382.408374869384;4407.140607581523;357508;358334;361543;362049;364857;33874.49188262129;60459;60920.69539652274;61025.38974610286;61049.08426373608;35006.12484687903;35038.64961350405;35066;35073.64926350755;35103.297934041686;14146.575602731935;14208.8632909367;14220.928895355457;14221.715565688628;14255.928720356333;12501.24992500453;12514.49942002328;12564.183328083645;12692.619221423372;12706.301153436465;8237.79405514867;8259.091499935003;8286.917130828615;8340.624671889658;8392.538410387488;3084.519430673289;3125.6561778204377;3149.889753858604;3172.952405713916;3177.0786471923348;963.6482683820495;970.5875003123645;988.3081842710131;1089.8692156941217;1179.8938095571268;31575.84212078925;31700.682993169772;32190.19524511906;32379.838100809346;32567.51148732771;1039.5218199628105;1098.8626421697288;1100.763335882773;1133.9376334301692;1155.7284038251005;16351.59121021984;16628.33486660544;16981.575460613585;17043.573910652332;17142.657146857244;585942;590940;593146;593872;596174;58455;59180;59216.70391648014;59299.407005930254;59863.70068149632;1327.8008298755265;1333.7399207154513;1347.6832944258092;1364.9044566880223;1381.951631692886;30349.393012140074;30768.38463230678;31170.844145779127;31233.84383078161;31393.843030785614;50924.745376272884;51365.486345137564;51435;51744;51866.48133518617;455752;455833;457550;458381;459744;28246;28503.42993140167;28772.712272877005;28853.7114628851;28929.56605650875;48383.27425088697;48474.515254847;49060.75469622629;49066.26400604065;49916.50083499119;40750.59249407586;42090.57909420867;42181.1563768729;42321.365179522945;42413.57586424219;41234.38148427836;41610.79194604007;41864;42513.36229956491;43286.350704740085;34507;39995;41356;41685.374719378626;42796.358054629825;35229.82385088058;36309.63690363063;36689.633103668624;37034.444483332234;37054.44418333781;28051;28272;28284.010059647815;28358.85820570884;28539.571906421836 10:36:57 INFO - PROCESS | 27862 | |2;jquery.html;386.3027235839309;389.2429225157069;394.62707741184573;400.46537871940956;416.4523651398411;14478.782818257734;19008.714869276955;19149.90425047873;20514.589708205825;20685;19119.330823421184;19310.131044103015;19918.50203744907;19939.003049847484;20204.19183232669;5774.6535207887455;5816.447437493432;5965.135055416962;6016.217891674076;6034.0948857671265;5379;5714.114312281582;5864.149698293766;5869.677167755772;5878.323992740826;5685.346185188715;5699.601027928046;5706;5731;5739.225204597367;5442.2380866678495;5763.625364351325;5769.798057068004;5788.623739456964;5836.037053886103;5596.972015139939;5630;5660.235868157787;5665.291838520185;5666.631668941505;22784.430389240235;22872.31383058511;23193;23716.644250336085;23718.16986405485;2296.5406918616177;2307.9538409231723;2378.2746262389965;2406.3262286559793;2408.2414039577475;9541.427514349092;9704.61181552737;9782.168515676176;11078.335299882034;14397.912302716153;1883.3125909043238;1898.84428979744;1899.164367678217;1955.8044195580328;1967.7209813621262;76211.23788762097;77813.61093194554;78139.6093019537;78654;79307.6034619829;10304.227182961307;10640;11227.249323915694;11470.770584588261;11558.190926635054;15716.449924252596;15732.134732589817;15804.68390632204;15812.76280855765;15822.446214382442;7857.842843143105;8057.758267251992;8088.595570221465;8205.425620206648;8290.792730181794;7664.961675191588;7703.460757746904;7733.8453230935065;7811.945387372745;7821.413393995359;4320.308750599889;4468.553144685506;4780.235162374003;4847.079054979543;4864.732439715779;1833.6607727570442;1963.33246696124;1995.1321175288506;2018.1221168791624;2020.2121172742643;949.767307009787;960.6349587156835;986.7187851462298;1001.6444162322271;1005.527402121002;19982.400527984184;20057.79942200559;20341.898290508452;20350.796492035188;20390.796092039185;995.6266400099962;998.8751406074241;1034.343192073039;1040.5785656809005;1084.6854412220525;10776.012875236212;11198.776024479464;11208.15938804593;11302.830457543143;11320.377379244055;475036;477249;480450;494364;495553;92466.53766731123;95915.52042239744;96102.51948740211;96568.51715741376;97544;977.5454413697522;981.9656312029188;986.1863962231188;994.0655783563427;1000.8999100089933;17499.125043747506;17607.911960440117;17633;17708.822911770716;17907.910460447616;42144.15711685688;42684.5731542693;42960;44001.33997989968;44255.11489770122;59286.407135928086;59585;60084;60187.39812601993;60221.69889150702;8589.398742087993;8737.257333126501;8836.425632333878;8872.600732967161;8927.33045021613;13342.733145336844;14294.213818240096;14612.85387146115;14678.63303417423;15025.69948601;12439.191452555555;12699.746005080031;12925.15986460877;13016.674583135497;13131.868681313064;11960.76078478443;12320.322382268703;12401.75196496047;12417.565385211474;12745.553905613258;11666.250062490695;12643.367831608199;12805.679858003625;13127.737445251232;13160.40778165004;7798.103218129988;8381.874271885805;8871.423357481743;9178.770530736785;9230.215431688383;11320.207585469267;11551.653450396501;12500.749985000431;12725.490980360682;12813.103082784115 10:36:57 INFO - PROCESS | 27862 | |3;mootools.html;1420.1195258939456;1469.9853001469985;1581.4464937271948;1701.6936951348769;1730.8355706207913;7421.443391745614;7789.688412463494;8026.879596806045;8574.442661227016;8594.91405085949;8014.759557213293;8274.089850116483;8308.626111824968;8316.875246871286;8348.415610907225;2231.152162178374;2265.682804407384;2271.0915633746467;2272.681824544565;2274.10172981673;2241.23797908711;2251.2908433843368;2268.0587556164173;2279.8974046167878;2286.0284379138884;2186.693862859201;2248.4154119928853;2264.5923733727923;2265.105283413051;2267.5691618592496;2219.977800221993;2226.4322597737555;2227.0757635581213;2233.4081468410886;2234.028197733991;2197.846150769447;2223.7331520217517;2230.509287956647;2230.921917732888;2235.2400183937375;8339.83320333596;8370.790730231733;8382.916170838274;8383.413161078726;8462.746117616482;4908.582770464479;4982.975085124551;5025.547700706918;5025.69845809249;5037.0429618372755;3211.8715251389917;3287.5068739689;3327.168207948013;3376.088456116859;3404.3021180657906;1099.8295264234057;1122.4724379541603;1123.3203911633425;1130.9717257068558;1136.8976792088752;11473.942630286796;11489.195756297062;11560.595379161688;11599.478023488964;11606.30362178272;4142.2543942090115;4173.311403618369;4317.978410107992;4343.891402714958;4369.890752731207;9852.753681158028;9865.260105492116;9874.111329980193;9877.753056173653;9879.851802222973;4981.3026176334615;4990.276409920614;5007.223880298559;5007.69953802773;5023.8492845214705;4067.6339129477897;4484.529124441952;4586.701864378805;4648.837290694877;4656.16189085961;3717.8141092945243;3781.9810900945317;3864.555576108727;3883.1457079442475;3890.319194141014;1195.8505186851644;1222.7432239229684;1227.4783217132683;1233.3278363292027;1233.7169343882442;1013.8023085498257;1014.1582486536157;1016.3495362967707;1017.5878769098526;1025.5282570017876;5937.910931336033;6010.248718910137;6016.879662406727;6019.849503762441;6257.9687101564205;951.414879848888;979.7060881735451;983.6557204978201;995.721198064543;1024.7643042100358;4223.049813791872;4235.957640423618;4290.50659174199;4365.978170109192;4383.517813040563;10243.334183278062;10576.471176441148;10588;10607.15142788575;10610.257281990187;10322.638707645196;10455;10483.108935740547;10488.528016239135;10547.945205479544;7613.238676132342;7882.605869706492;7901.999999999885;7914.762557123296;7970.322522585529;5986.431289027535;5991.161237426851;6143.508519318533;6200.0699895016105;6213.316535181036;9504.382215156269;9508.908392813593;9664.178544823488;9722.1736152425;9723.756906077404;9559.904400955902;9792.167665748491;9814.55834487464;9815.509224538888;9960.601575937171;6844.384005439534;7277.126744790659;7310.634468276671;7363.521371110861;7525.096988361432;8179.877301840596;8238.464499807493;8267.62795674184;8284;8337.416380853281;7034.613096279753;7181.964090179516;7257.963710181626;7335.046443962251;7514.323710866049;7349.4855360124275;7390.815229619087;7452.180260171485;7455.739049133254;7550.026395211004;6536.477081833537;6587.80236592903;6593.175853018372;6596.406323430914;6634.170728658918;5066.341375621146;5125.974370128126;5218.373795144607;5327;5387.730613469233;5075.593952483866;5098.439171691185;5132.820351287687;5147.58819294448;5178.844634660966 10:36:57 INFO - PROCESS | 27862 | |4;prototype.html;296.99257518562035;302.0425251951315;311.89239712299263;315.41490535057454;315.61179748908825;5631.943680563193;5648.966372106049;5654.434556544344;5703.0589952657765;5713.4572215639555;5612.579056570763;5614.185943038257;5645.983722929871;5696.8860622787515;5708.743106560204;4141.233871733732;4163.2930498495625;4279.293916503773;4290.562661508383;4328.264195086843;4302.763348015857;4325.243082460573;4326.58897404746;4334.869953901388;4344.913101737963;4288.828446862138;4316.07204451043;4328.523862375152;4332.978335108336;4336.371226172203;4118.691098167635;4327.632151267146;4329.826806927719;4337.804798784062;4339.652827773771;3734.514513113278;3735.084904198489;3742.925141497182;3745.2883952049024;3747.2130852521004;5505.862353441156;5552.222688823568;5564.4713752193475;5576.832695019156;5579.972100139514;4914;4975.7263350515705;4981.427135879384;5009.348784658007;5023.2214006828635;5951.3751056139345;5974.761009559613;5997.700114994276;6000.279966404059;6017.368176341465;4128.277551428518;4148.730332528376;4150.937735933963;4151.937720934188;4165.812538435777;6015.729292181863;6110.712074303406;6159.045347971027;6163.414475624809;6166.198394208769;4107.644477322477;4122.711410201317;4145.689073319513;4173.7078404512;4175.498940127143;4175.331946888483;4189.49726032878;4225.514065882401;4228.281192197333;4229.513605935295;4760.785764640599;4893.535114164149;4909.803607855646;4912.238603016538;4939;5942.970285148546;5950.732217050243;5955.52355811534;6019.157317975487;6021.488173505301;1454.4327712192253;1469.9485518006818;1473.2854565535706;1490.6720521485256;1492.2687882937282;909.7952960583948;917.9076898490774;956.6651671914914;963.7349728824629;970.9951450242703;5684.744186511617;5698.145278208219;5769.509591684754;5776.595638305363;5802.970985145047;5998.550108741774;6058.42480954946;6059.666718330446;6099;6137.146227004375;5505.513511351913;5684.658920464785;5720.683123335056;5730.71346432685;5745.626534275259;3258.6415494295607;3263.9347213055607;3269.4441944869427;3292.2592416706048;3299.4492588483376;6029.939700602938;6301.212348456443;6310.432061114522;6324.272708638566;6334.800925532577;6181;6193.380661933861;6197.81406557804;6201.81394558164;6203.131561581382;6049.485793707584;6216.595921265103;6267.5299352548745;6287.9056814147825;6323.936760632335;6155.169052177898;6179.412955769195;6197.605538753744;6210.347913469202;6232.657203853651;6134.693265336805;6176.320604733386;6194.305477117468;6201.410865967726;6217.129601855653;6203.2556093269095;6394.648294343856;6400.423961843457;6401.423871851555;6453.225612926479;4304.687070443545;4324.891877703082;4326.286162783105;4339.175556644227;4340.457442819647;5798.913016304675;5930.975202646768;6115.84710382244;6140.201773769381;6257;5899;5915.940840591539;5953.672548009901;5955.642661440154;5958.940410595838;5740.368559458373;5963.3142188647125;5963.612365196248;5994.520438365008;6019.428154325332;5865.882682346414;5880.794172203952;5886.911696324473;5927.851803704942;5977.731002104829;6009.669468179292;6027.336992930862;6039.486643635164;6045.818625441244;6071.635701857903;5630;5837.153612726046;5854.385289544707;5908.172855800105;5916.7041647918295 10:36:57 INFO - PROCESS | 27862 | |5;yui.html;747.2191559819984;778.4122987144705;788.3377962511489;795.6896810244004;836.732245681382;15207.619809504755;15998.120103394309;16030.519084427471;16081.919590402047;16783.91608041961;15885.126318052502;16648.58378540537;16681.66636667266;16724.16379181042;16734.330626774943;665.7636539028648;786.9842603147933;799.4403917257914;804.1194891593696;804.6982381606897;787.4055088408244;811.3022800391658;812.0296245986019;812.2689579378577;813.515958004986;839.4585492357426;848.3552500099937;851.7317045130795;851.7870532366908;851.9190676885686;836.2515548584045;846.3652260804397;846.6571038729325;848.9660413583449;849.2314455417857;614.8309214965875;615.6367743031633;617.1760699466219;617.8331850400411;618.2086928731186;15248.466303679428;15279.847201527953;15367.231638418147;15376.384944602314;15394;14691.77962330566;14806.481773137888;14894.925525372304;14955.252237388087;14977.475788347356;12891.35543222835;13008;13081.738365232737;13140.474381024844;13330.333483325892;3827.3684842001035;3904.2386734586485;3911.2373087247997;3924.2936271471126;4010.7593544387432;77556.61221693912;79058.20941790624;79921;80416.59791701121;80990;11641.126915481373;11834.408279585987;11843.46704398287;11856.525738970517;11873.109516786102;20631.17475301001;20725.481862953246;20882;20887.8955605221;21049.579008419747;8866.157715017192;8879.33404994628;8957.417767845069;9075.2286055686;9075.863862042075;4624.630029597624;4629.699069560468;4691.413573303337;4713.552212539803;4775.5463230993;3359.3953088444314;3451.430513965218;3472.0972547137926;3472.3055388922317;3501.1072176594807;629.4052120745943;629.7890206780688;638.3871483375918;651.9380658837403;657.0604036228144;709.818996155977;714.1858281559026;731.4477569435043;750.4296734481724;774.8062984253936;9377.160392513768;9391.34260601765;9565.139137477661;9598.18415434682;9647.758806029906;707.8478127202676;721.4949535325293;726.1504040272894;734.765593802417;737.7270409948353;4734.479207287196;4735.076660051257;4746;4746.4541577719;4779.880502987453;71587;71970;72318.63840680763;112685;114975.42512287384;102057.4485637865;107892.46053769838;107946.46026769973;108552.4572377133;108998.45500772445;90238.09761902297;91072.08927910769;91080;91161.54419227994;94911;8886.244669202932;8977.371583989057;9069.410488318503;9124.726258212264;9194.174127092801;52746;54048;54783.726081369336;55030.44969550413;55442;80369.59815200887;82688.58655706682;84002.15997839943;84129;85025.14974850172;11707;11949;11958.521659133537;12054.0959428045;12145.69635759113;13640;13669.384877680726;13791.931040344734;14025.789613156016;14871.330790114687;11205.159613029218;11302.717432064264;11346.489407976496;11516.596919107791;11528.942355288169;12230.694232643898;12246.877531224574;12399.318037507663;12449.564265251034;12459.501619935101;11616.535338586362;11986.880131198577;13078.215307081606;13430.39563219638;14751.852481475047;11503;11806.763864722485;11831.875971782667;12222.511099555919;12276.447559860006;11905.642830715093;12002.63992080239;12125.514979400725;12260.509579616715;12275.26348419062 10:36:57 INFO - PROCESS | 27862 | __end_tp_report 10:36:57 INFO - PROCESS | 27862 | __start_cc_report 10:36:57 INFO - PROCESS | 27862 | _x_x_mozilla_cycle_collect,364 10:36:57 INFO - PROCESS | 27862 | __end_cc_report 10:36:57 INFO - PROCESS | 27862 | __startTimestamp1467740217808__endTimestamp 10:36:57 INFO - PROCESS | 27862 | 10:36:57 INFO - PROCESS | 27862 | ------- Summary: start ------- 10:36:57 INFO - PROCESS | 27862 | Number of tests: 6 10:36:57 INFO - PROCESS | 27862 | 10:36:57 INFO - PROCESS | 27862 | [#0] dojo.html Cycles:165 Average:5270.67 Median:5465.54 stddev:703.52 (12.9%) stddev-sans-first:684.35 10:36:57 INFO - PROCESS | 27862 | Values: 3079.5 3144.0 3161.1 3173.8 3180.1 5318.0 5356.5 5362.8 5374.3 5405.5 5217.0 5285.3 5303.5 5305.0 5360.9 4866.1 4896.1 4946.4 4959.0 4976.9 4962.3 5024.8 5029.6 5038.9 5068.1 213.2 4863.9 4956.5 4966.8 4977.2 4829.9 4833.5 4840.6 4846.5 4876.7 4811.3 4821.6 4822.3 4834.5 4853.3 5112.2 5264.9 5304.1 5304.3 5333.5 5729.7 5738.1 5742.6 5746.1 5749.1 5617.1 5810.2 5810.3 5820.0 5829.1 5335.5 5378.4 5385.7 5431.8 5439.7 5908.1 5909.0 5920.0 5921.8 5926.0 5453.7 5494.3 5667.2 5686.2 5687.0 5586.9 5656.0 5656.4 5658.0 5711.8 5551.5 5593.1 5619.8 5628.0 5632.4 5539.9 5659.9 5679.6 5708.9 5718.5 4263.5 4323.7 4369.5 4390.4 4412.8 3892.6 3914.8 3926.4 3945.6 3996.0 5320.6 5363.5 5423.5 5486.6 5488.3 5629.0 5701.9 5719.8 5747.1 5774.5 5374.2 5405.0 5443.9 5446.0 5450.6 4822.7 4843.6 4866.5 4902.7 4953.3 5856.7 5862.8 5865.2 5866.2 5903.3 5614.6 5647.4 5678.0 5680.4 5690.4 5688.4 5850.9 5861.9 5899.9 5903.0 5625.2 5629.9 5630.9 5631.7 5633.3 5742.7 5743.9 5752.8 5754.0 5759.9 5335.2 5528.7 5539.7 5555.0 5571.8 5495.5 5537.9 5548.3 5558.4 5568.9 5378.3 5463.9 5493.5 5494.1 5494.2 5391.1 5435.6 5465.5 5482.2 5484.3 5339.9 5422.1 5462.3 5518.7 5523.8 10:36:57 INFO - PROCESS | 27862 | 10:36:57 INFO - PROCESS | 27862 | [#1] ext.html Cycles:180 Average:61345.72 Median:41648.08 stddev:127820.13 (306.9%) stddev-sans-first:128097.19 10:36:57 INFO - PROCESS | 27862 | Values: 550.5 592.5 603.9 605.5 637.3 38220.2 42432.0 43020.0 43125.4 43371.6 42824.1 43400.8 43452.1 43471.6 43563.1 8745.4 8888.9 8891.9 8913.9 8929.4 8797.9 8860.6 8888.0 8901.7 8901.7 8918.9 8934.7 8955.1 8957.3 8963.1 8890.1 8910.5 8925.2 8933.3 8933.7 8765.5 8771.8 8787.3 8795.3 8800.7 32765.7 40572.2 41037.6 41211.2 41229.4 3281.2 3324.3 3545.9 3852.7 4137.5 30657.8 30691.4 30695.2 31513.5 31876.8 4151.9 4252.2 4367.4 4382.4 4407.1 357508.0 358334.0 361543.0 362049.0 364857.0 33874.5 60459.0 60920.7 61025.4 61049.1 35006.1 35038.6 35066.0 35073.6 35103.3 14146.6 14208.9 14220.9 14221.7 14255.9 12501.2 12514.5 12564.2 12692.6 12706.3 8237.8 8259.1 8286.9 8340.6 8392.5 3084.5 3125.7 3149.9 3173.0 3177.1 963.6 970.6 988.3 1089.9 1179.9 31575.8 31700.7 32190.2 32379.8 32567.5 1039.5 1098.9 1100.8 1133.9 1155.7 16351.6 16628.3 16981.6 17043.6 17142.7 585942.0 590940.0 593146.0 593872.0 596174.0 58455.0 59180.0 59216.7 59299.4 59863.7 1327.8 1333.7 1347.7 1364.9 1382.0 30349.4 30768.4 31170.8 31233.8 31393.8 50924.7 51365.5 51435.0 51744.0 51866.5 455752.0 455833.0 457550.0 458381.0 459744.0 28246.0 28503.4 28772.7 28853.7 28929.6 48383.3 48474.5 49060.8 49066.3 49916.5 40750.6 42090.6 42181.2 42321.4 42413.6 41234.4 41610.8 41864.0 42513.4 43286.4 34507.0 39995.0 41356.0 41685.4 42796.4 35229.8 36309.6 36689.6 37034.4 37054.4 28051.0 28272.0 28284.0 28358.9 28539.6 10:36:57 INFO - PROCESS | 27862 | 10:36:57 INFO - PROCESS | 27862 | [#2] jquery.html Cycles:180 Average:29185.87 Median:397.55 stddev:79949.35 (20110.7%) stddev-sans-first:80144.38 10:36:57 INFO - PROCESS | 27862 | Values: 386.3 389.2 394.6 400.5 416.5 14478.8 19008.7 19149.9 20514.6 20685.0 19119.3 19310.1 19918.5 19939.0 20204.2 5774.7 5816.4 5965.1 6016.2 6034.1 5379.0 5714.1 5864.1 5869.7 5878.3 5685.3 5699.6 5706.0 5731.0 5739.2 5442.2 5763.6 5769.8 5788.6 5836.0 5597.0 5630.0 5660.2 5665.3 5666.6 22784.4 22872.3 23193.0 23716.6 23718.2 2296.5 2308.0 2378.3 2406.3 2408.2 9541.4 9704.6 9782.2 11078.3 14397.9 1883.3 1898.8 1899.2 1955.8 1967.7 76211.2 77813.6 78139.6 78654.0 79307.6 10304.2 10640.0 11227.2 11470.8 11558.2 15716.4 15732.1 15804.7 15812.8 15822.4 7857.8 8057.8 8088.6 8205.4 8290.8 7665.0 7703.5 7733.8 7811.9 7821.4 4320.3 4468.6 4780.2 4847.1 4864.7 1833.7 1963.3 1995.1 2018.1 2020.2 949.8 960.6 986.7 1001.6 1005.5 19982.4 20057.8 20341.9 20350.8 20390.8 995.6 998.9 1034.3 1040.6 1084.7 10776.0 11198.8 11208.2 11302.8 11320.4 475036.0 477249.0 480450.0 494364.0 495553.0 92466.5 95915.5 96102.5 96568.5 97544.0 977.5 982.0 986.2 994.1 1000.9 17499.1 17607.9 17633.0 17708.8 17907.9 42144.2 42684.6 42960.0 44001.3 44255.1 59286.4 59585.0 60084.0 60187.4 60221.7 8589.4 8737.3 8836.4 8872.6 8927.3 13342.7 14294.2 14612.9 14678.6 15025.7 12439.2 12699.7 12925.2 13016.7 13131.9 11960.8 12320.3 12401.8 12417.6 12745.6 11666.3 12643.4 12805.7 13127.7 13160.4 7798.1 8381.9 8871.4 9178.8 9230.2 11320.2 11551.7 12500.7 12725.5 12813.1 10:36:57 INFO - PROCESS | 27862 | 10:36:57 INFO - PROCESS | 27862 | [#3] mootools.html Cycles:180 Average:5585.59 Median:5007.46 stddev:3114.34 (62.2%) stddev-sans-first:3107.35 10:36:57 INFO - PROCESS | 27862 | Values: 1420.1 1470.0 1581.4 1701.7 1730.8 7421.4 7789.7 8026.9 8574.4 8594.9 8014.8 8274.1 8308.6 8316.9 8348.4 2231.2 2265.7 2271.1 2272.7 2274.1 2241.2 2251.3 2268.1 2279.9 2286.0 2186.7 2248.4 2264.6 2265.1 2267.6 2220.0 2226.4 2227.1 2233.4 2234.0 2197.8 2223.7 2230.5 2230.9 2235.2 8339.8 8370.8 8382.9 8383.4 8462.7 4908.6 4983.0 5025.5 5025.7 5037.0 3211.9 3287.5 3327.2 3376.1 3404.3 1099.8 1122.5 1123.3 1131.0 1136.9 11473.9 11489.2 11560.6 11599.5 11606.3 4142.3 4173.3 4318.0 4343.9 4369.9 9852.8 9865.3 9874.1 9877.8 9879.9 4981.3 4990.3 5007.2 5007.7 5023.8 4067.6 4484.5 4586.7 4648.8 4656.2 3717.8 3782.0 3864.6 3883.1 3890.3 1195.9 1222.7 1227.5 1233.3 1233.7 1013.8 1014.2 1016.3 1017.6 1025.5 5937.9 6010.2 6016.9 6019.8 6258.0 951.4 979.7 983.7 995.7 1024.8 4223.0 4236.0 4290.5 4366.0 4383.5 10243.3 10576.5 10588.0 10607.2 10610.3 10322.6 10455.0 10483.1 10488.5 10547.9 7613.2 7882.6 7902.0 7914.8 7970.3 5986.4 5991.2 6143.5 6200.1 6213.3 9504.4 9508.9 9664.2 9722.2 9723.8 9559.9 9792.2 9814.6 9815.5 9960.6 6844.4 7277.1 7310.6 7363.5 7525.1 8179.9 8238.5 8267.6 8284.0 8337.4 7034.6 7182.0 7258.0 7335.0 7514.3 7349.5 7390.8 7452.2 7455.7 7550.0 6536.5 6587.8 6593.2 6596.4 6634.2 5066.3 5126.0 5218.4 5327.0 5387.7 5075.6 5098.4 5132.8 5147.6 5178.8 10:36:57 INFO - PROCESS | 27862 | 10:36:57 INFO - PROCESS | 27862 | [#4] prototype.html Cycles:180 Average:4978.26 Median:5725.70 stddev:1507.07 (26.3%) stddev-sans-first:1469.77 10:36:57 INFO - PROCESS | 27862 | Values: 297.0 302.0 311.9 315.4 315.6 5631.9 5649.0 5654.4 5703.1 5713.5 5612.6 5614.2 5646.0 5696.9 5708.7 4141.2 4163.3 4279.3 4290.6 4328.3 4302.8 4325.2 4326.6 4334.9 4344.9 4288.8 4316.1 4328.5 4333.0 4336.4 4118.7 4327.6 4329.8 4337.8 4339.7 3734.5 3735.1 3742.9 3745.3 3747.2 5505.9 5552.2 5564.5 5576.8 5580.0 4914.0 4975.7 4981.4 5009.3 5023.2 5951.4 5974.8 5997.7 6000.3 6017.4 4128.3 4148.7 4150.9 4151.9 4165.8 6015.7 6110.7 6159.0 6163.4 6166.2 4107.6 4122.7 4145.7 4173.7 4175.5 4175.3 4189.5 4225.5 4228.3 4229.5 4760.8 4893.5 4909.8 4912.2 4939.0 5943.0 5950.7 5955.5 6019.2 6021.5 1454.4 1469.9 1473.3 1490.7 1492.3 909.8 917.9 956.7 963.7 971.0 5684.7 5698.1 5769.5 5776.6 5803.0 5998.6 6058.4 6059.7 6099.0 6137.1 5505.5 5684.7 5720.7 5730.7 5745.6 3258.6 3263.9 3269.4 3292.3 3299.4 6029.9 6301.2 6310.4 6324.3 6334.8 6181.0 6193.4 6197.8 6201.8 6203.1 6049.5 6216.6 6267.5 6287.9 6323.9 6155.2 6179.4 6197.6 6210.3 6232.7 6134.7 6176.3 6194.3 6201.4 6217.1 6203.3 6394.6 6400.4 6401.4 6453.2 4304.7 4324.9 4326.3 4339.2 4340.5 5798.9 5931.0 6115.8 6140.2 6257.0 5899.0 5915.9 5953.7 5955.6 5958.9 5740.4 5963.3 5963.6 5994.5 6019.4 5865.9 5880.8 5886.9 5927.9 5977.7 6009.7 6027.3 6039.5 6045.8 6071.6 5630.0 5837.2 5854.4 5908.2 5916.7 10:36:57 INFO - PROCESS | 27862 | 10:36:57 INFO - PROCESS | 27862 | [#5] yui.html Cycles:180 Average:20862.67 Median:4724.02 stddev:29839.84 (631.7%) stddev-sans-first:29885.32 10:36:57 INFO - PROCESS | 27862 | Values: 747.2 778.4 788.3 795.7 836.7 15207.6 15998.1 16030.5 16081.9 16783.9 15885.1 16648.6 16681.7 16724.2 16734.3 665.8 787.0 799.4 804.1 804.7 787.4 811.3 812.0 812.3 813.5 839.5 848.4 851.7 851.8 851.9 836.3 846.4 846.7 849.0 849.2 614.8 615.6 617.2 617.8 618.2 15248.5 15279.8 15367.2 15376.4 15394.0 14691.8 14806.5 14894.9 14955.3 14977.5 12891.4 13008.0 13081.7 13140.5 13330.3 3827.4 3904.2 3911.2 3924.3 4010.8 77556.6 79058.2 79921.0 80416.6 80990.0 11641.1 11834.4 11843.5 11856.5 11873.1 20631.2 20725.5 20882.0 20887.9 21049.6 8866.2 8879.3 8957.4 9075.2 9075.9 4624.6 4629.7 4691.4 4713.6 4775.5 3359.4 3451.4 3472.1 3472.3 3501.1 629.4 629.8 638.4 651.9 657.1 709.8 714.2 731.4 750.4 774.8 9377.2 9391.3 9565.1 9598.2 9647.8 707.8 721.5 726.2 734.8 737.7 4734.5 4735.1 4746.0 4746.5 4779.9 71587.0 71970.0 72318.6 112685.0 114975.4 102057.4 107892.5 107946.5 108552.5 108998.5 90238.1 91072.1 91080.0 91161.5 94911.0 8886.2 8977.4 9069.4 9124.7 9194.2 52746.0 54048.0 54783.7 55030.4 55442.0 80369.6 82688.6 84002.2 84129.0 85025.1 11707.0 11949.0 11958.5 12054.1 12145.7 13640.0 13669.4 13791.9 14025.8 14871.3 11205.2 11302.7 11346.5 11516.6 11528.9 12230.7 12246.9 12399.3 12449.6 12459.5 11616.5 11986.9 13078.2 13430.4 14751.9 11503.0 11806.8 11831.9 12222.5 12276.4 11905.6 12002.6 12125.5 12260.5 12275.3 10:36:57 INFO - PROCESS | 27862 | -------- Summary: end -------- 10:36:57 INFO - PROCESS | 27862 | 10:36:58 INFO - TEST-INFO | 27862: exit 0 10:36:58 INFO - TEST-OK | dromaeo_css | took 1109912ms 10:36:58 INFO - TEST-START | kraken 10:36:58 INFO - operating with platform_type : linux_ 10:36:58 INFO - Initialising browser for kraken test... 10:36:58 INFO - TEST-INFO | started process 28108 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSnwoNZ/profile http://localhost:57397/getInfo.html) 10:37:02 INFO - PROCESS | 28108 | __metrics Screen width/height:1600/1200 10:37:02 INFO - PROCESS | 28108 | colorDepth:24 10:37:02 INFO - PROCESS | 28108 | Browser inner width/height: 1024/697 10:37:02 INFO - PROCESS | 28108 | __metrics 10:37:03 ERROR - PROCESS | 28108 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 10:37:04 INFO - TEST-INFO | 28108: exit 0 10:37:04 INFO - Browser initialized. 10:37:04 INFO - Running cycle 1/1 for kraken test... 10:37:04 INFO - TEST-INFO | started process 28227 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSnwoNZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:37:16 INFO - PROCESS | 28227 | RSS: Main: 168468480 10:37:16 INFO - PROCESS | 28227 | 10:37:18 INFO - PROCESS | 28227 | Cycle 1(1): loaded http://localhost:57397/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57397/tests/kraken/driver.html?testName=audio-beat-detection) 10:37:19 INFO - PROCESS | 28227 | RSS: Main: 173535232 10:37:19 INFO - PROCESS | 28227 | 10:37:22 INFO - PROCESS | 28227 | Cycle 1(1): loaded http://localhost:57397/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57397/tests/kraken/driver.html?testName=audio-dft) 10:37:22 INFO - PROCESS | 28227 | RSS: Main: 173015040 10:37:22 INFO - PROCESS | 28227 | 10:37:25 INFO - PROCESS | 28227 | Cycle 1(1): loaded http://localhost:57397/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57397/tests/kraken/driver.html?testName=audio-fft) 10:37:26 INFO - PROCESS | 28227 | RSS: Main: 167956480 10:37:26 INFO - PROCESS | 28227 | 10:37:28 INFO - PROCESS | 28227 | Cycle 1(1): loaded http://localhost:57397/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57397/tests/kraken/driver.html?testName=audio-oscillator) 10:37:29 INFO - PROCESS | 28227 | RSS: Main: 168882176 10:37:29 INFO - PROCESS | 28227 | 10:37:31 INFO - PROCESS | 28227 | Cycle 1(1): loaded http://localhost:57397/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57397/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:37:31 INFO - PROCESS | 28227 | RSS: Main: 169295872 10:37:31 INFO - PROCESS | 28227 | 10:37:34 INFO - PROCESS | 28227 | Cycle 1(1): loaded http://localhost:57397/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57397/tests/kraken/driver.html?testName=imaging-darkroom) 10:37:35 INFO - PROCESS | 28227 | RSS: Main: 168448000 10:37:35 INFO - PROCESS | 28227 | 10:37:39 INFO - PROCESS | 28227 | Cycle 1(1): loaded http://localhost:57397/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57397/tests/kraken/driver.html?testName=imaging-desaturate) 10:37:39 INFO - PROCESS | 28227 | RSS: Main: 167424000 10:37:39 INFO - PROCESS | 28227 | 10:37:42 INFO - PROCESS | 28227 | Cycle 1(1): loaded http://localhost:57397/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57397/tests/kraken/driver.html?testName=json-parse-financial) 10:37:43 INFO - PROCESS | 28227 | RSS: Main: 169111552 10:37:43 INFO - PROCESS | 28227 | 10:37:44 INFO - PROCESS | 28227 | Cycle 1(1): loaded http://localhost:57397/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57397/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:37:45 INFO - PROCESS | 28227 | RSS: Main: 169242624 10:37:45 INFO - PROCESS | 28227 | 10:37:47 INFO - PROCESS | 28227 | Cycle 1(1): loaded http://localhost:57397/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57397/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:37:47 INFO - PROCESS | 28227 | RSS: Main: 169721856 10:37:47 INFO - PROCESS | 28227 | 10:37:49 INFO - PROCESS | 28227 | Cycle 1(1): loaded http://localhost:57397/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57397/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:37:50 INFO - PROCESS | 28227 | RSS: Main: 169984000 10:37:50 INFO - PROCESS | 28227 | 10:37:53 INFO - PROCESS | 28227 | Cycle 1(1): loaded http://localhost:57397/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57397/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:37:53 INFO - PROCESS | 28227 | RSS: Main: 170061824 10:37:53 INFO - PROCESS | 28227 | 10:37:56 INFO - PROCESS | 28227 | Cycle 1(1): loaded http://localhost:57397/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57397/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:37:56 INFO - PROCESS | 28227 | RSS: Main: 170106880 10:37:56 INFO - PROCESS | 28227 | 10:37:58 INFO - PROCESS | 28227 | Cycle 1(1): loaded http://localhost:57397/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57397/tests/kraken/driver.html?testName=ai-astar) 10:37:58 INFO - PROCESS | 28227 | RSS: Main: 170881024 10:37:58 INFO - PROCESS | 28227 | 10:37:58 INFO - PROCESS | 28227 | __start_tp_report 10:37:58 INFO - PROCESS | 28227 | _x_x_mozilla_page_load 10:37:58 INFO - PROCESS | 28227 | _x_x_mozilla_page_load_details 10:37:58 INFO - PROCESS | 28227 | |i|pagename|runs| 10:37:58 INFO - PROCESS | 28227 | |0;ai-astar;100;110;105;111;114;112;113;112;111;110 10:37:58 INFO - PROCESS | 28227 | |1;audio-beat-detection;144;118;145;182;120;144;151;124;183;116 10:37:58 INFO - PROCESS | 28227 | |2;audio-dft;162;171;163;164;163;165;168;168;162;164 10:37:58 INFO - PROCESS | 28227 | |3;audio-fft;74;76;75;171;79;76;75;74;166;76 10:37:58 INFO - PROCESS | 28227 | |4;audio-oscillator;88;85;146;84;85;86;127;85;84;153 10:37:58 INFO - PROCESS | 28227 | |5;imaging-gaussian-blur;118;118;118;118;118;118;117;118;117;117 10:37:58 INFO - PROCESS | 28227 | |6;imaging-darkroom;147;149;146;148;146;148;146;147;149;147 10:37:58 INFO - PROCESS | 28227 | |7;imaging-desaturate;95;95;96;96;95;95;96;96;96;95 10:37:58 INFO - PROCESS | 28227 | |8;json-parse-financial;55;55;55;55;55;55;55;56;61;57 10:37:58 INFO - PROCESS | 28227 | |9;json-stringify-tinderbox;62;61;61;61;61;61;61;61;62;61 10:37:58 INFO - PROCESS | 28227 | |10;stanford-crypto-aes;76;74;76;77;75;79;75;84;81;74 10:37:58 INFO - PROCESS | 28227 | |11;stanford-crypto-ccm;120;133;125;120;130;120;120;119;169;136 10:37:58 INFO - PROCESS | 28227 | |12;stanford-crypto-pbkdf2;157;157;158;158;161;156;161;158;154;155 10:37:58 INFO - PROCESS | 28227 | |13;stanford-crypto-sha256-iterative;63;63;64;61;64;62;66;62;65;61 10:37:58 INFO - PROCESS | 28227 | __end_tp_report 10:37:58 INFO - PROCESS | 28227 | __start_cc_report 10:37:58 INFO - PROCESS | 28227 | _x_x_mozilla_cycle_collect,903 10:37:58 INFO - PROCESS | 28227 | __end_cc_report 10:37:58 INFO - PROCESS | 28227 | __startTimestamp1467740278877__endTimestamp 10:37:58 INFO - PROCESS | 28227 | 10:37:58 INFO - PROCESS | 28227 | ------- Summary: start ------- 10:37:58 INFO - PROCESS | 28227 | Number of tests: 14 10:37:58 INFO - PROCESS | 28227 | 10:37:58 INFO - PROCESS | 28227 | [#0] ai-astar Cycles:10 Average:109.80 Median:111.50 stddev:4.21 (3.8%) stddev-sans-first:2.57 10:37:58 INFO - PROCESS | 28227 | Values: 100.0 110.0 105.0 111.0 114.0 112.0 113.0 112.0 111.0 110.0 10:37:58 INFO - PROCESS | 28227 | 10:37:58 INFO - PROCESS | 28227 | [#1] audio-beat-detection Cycles:10 Average:142.70 Median:144.50 stddev:24.57 (17.0%) stddev-sans-first:26.06 10:37:58 INFO - PROCESS | 28227 | Values: 144.0 118.0 145.0 182.0 120.0 144.0 151.0 124.0 183.0 116.0 10:37:58 INFO - PROCESS | 28227 | 10:37:58 INFO - PROCESS | 28227 | [#2] audio-dft Cycles:10 Average:165.00 Median:164.50 stddev:3.02 (1.8%) stddev-sans-first:3.00 10:37:58 INFO - PROCESS | 28227 | Values: 162.0 171.0 163.0 164.0 163.0 165.0 168.0 168.0 162.0 164.0 10:37:58 INFO - PROCESS | 28227 | 10:37:58 INFO - PROCESS | 28227 | [#3] audio-fft Cycles:10 Average:94.20 Median:75.50 stddev:39.20 (51.9%) stddev-sans-first:40.89 10:37:58 INFO - PROCESS | 28227 | Values: 74.0 76.0 75.0 171.0 79.0 76.0 75.0 74.0 166.0 76.0 10:37:58 INFO - PROCESS | 28227 | 10:37:58 INFO - PROCESS | 28227 | [#4] audio-oscillator Cycles:10 Average:102.30 Median:85.00 stddev:28.14 (33.1%) stddev-sans-first:29.37 10:37:58 INFO - PROCESS | 28227 | Values: 88.0 85.0 146.0 84.0 85.0 86.0 127.0 85.0 84.0 153.0 10:37:58 INFO - PROCESS | 28227 | 10:37:58 INFO - PROCESS | 28227 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 10:37:58 INFO - PROCESS | 28227 | Values: 118.0 118.0 118.0 118.0 118.0 118.0 117.0 118.0 117.0 117.0 10:37:58 INFO - PROCESS | 28227 | 10:37:58 INFO - PROCESS | 28227 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.50 stddev:1.16 (0.8%) stddev-sans-first:1.22 10:37:58 INFO - PROCESS | 28227 | Values: 147.0 149.0 146.0 148.0 146.0 148.0 146.0 147.0 149.0 147.0 10:37:58 INFO - PROCESS | 28227 | 10:37:58 INFO - PROCESS | 28227 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 10:37:58 INFO - PROCESS | 28227 | Values: 95.0 95.0 96.0 96.0 95.0 95.0 96.0 96.0 96.0 95.0 10:37:58 INFO - PROCESS | 28227 | 10:37:58 INFO - PROCESS | 28227 | [#8] json-parse-financial Cycles:10 Average:55.90 Median:55.00 stddev:1.91 (3.5%) stddev-sans-first:2.00 10:37:58 INFO - PROCESS | 28227 | Values: 55.0 55.0 55.0 55.0 55.0 55.0 55.0 56.0 61.0 57.0 10:37:58 INFO - PROCESS | 28227 | 10:37:58 INFO - PROCESS | 28227 | [#9] json-stringify-tinderbox Cycles:10 Average:61.20 Median:61.00 stddev:0.42 (0.7%) stddev-sans-first:0.33 10:37:58 INFO - PROCESS | 28227 | Values: 62.0 61.0 61.0 61.0 61.0 61.0 61.0 61.0 62.0 61.0 10:37:58 INFO - PROCESS | 28227 | 10:37:58 INFO - PROCESS | 28227 | [#10] stanford-crypto-aes Cycles:10 Average:77.10 Median:76.50 stddev:3.28 (4.3%) stddev-sans-first:3.46 10:37:58 INFO - PROCESS | 28227 | Values: 76.0 74.0 76.0 77.0 75.0 79.0 75.0 84.0 81.0 74.0 10:37:58 INFO - PROCESS | 28227 | 10:37:58 INFO - PROCESS | 28227 | [#11] stanford-crypto-ccm Cycles:10 Average:129.20 Median:127.50 stddev:15.30 (12.0%) stddev-sans-first:15.86 10:37:58 INFO - PROCESS | 28227 | Values: 120.0 133.0 125.0 120.0 130.0 120.0 120.0 119.0 169.0 136.0 10:37:58 INFO - PROCESS | 28227 | 10:37:58 INFO - PROCESS | 28227 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.50 Median:158.00 stddev:2.27 (1.4%) stddev-sans-first:2.40 10:37:58 INFO - PROCESS | 28227 | Values: 157.0 157.0 158.0 158.0 161.0 156.0 161.0 158.0 154.0 155.0 10:37:58 INFO - PROCESS | 28227 | 10:37:58 INFO - PROCESS | 28227 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.10 Median:63.50 stddev:1.66 (2.6%) stddev-sans-first:1.76 10:37:58 INFO - PROCESS | 28227 | Values: 63.0 63.0 64.0 61.0 64.0 62.0 66.0 62.0 65.0 61.0 10:37:58 INFO - PROCESS | 28227 | -------- Summary: end -------- 10:37:58 INFO - PROCESS | 28227 | 10:37:59 INFO - TEST-INFO | 28227: exit 0 10:37:59 INFO - TEST-OK | kraken | took 61343ms 10:37:59 INFO - SUITE-END | took 1171s 10:38:00 INFO - Completed test suite (00:19:31) 10:38:00 INFO - javascript benchmark 10:38:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7222.902624741072, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3079.507278835386, 3143.9842800786023, 3161.099086760273, 3173.8095714257147, 3180.061881744885, 5318.042752304588, 5356.544693701036, 5362.8123015694455, 5374.274472946151, 5405.5135037846585, 5217.0, 5285.2600635911, 5303.522682958533, 5305.0, 5360.9463905360935, 4866.07544566533, 4896.069746748124, 4946.431160416544, 4959.0, 4976.875578110558, 4962.280469331945, 5024.82413115541, 5029.597632189416, 5038.899222015558, 5068.087744206042, 213.24025732051945, 4863.8784030399165, 4956.5043495650325, 4966.751662416865, 4977.1538838397555, 4829.879253018667, 4833.492483289239, 4840.564349208553, 4846.5153484651255, 4876.68301560401, 4811.302361157613, 4821.638377121695, 4822.300766388889, 4834.516548345137, 4853.272009198613, 5112.18205087188, 5264.92102618461, 5304.071787437183, 5304.336957880265, 5333.546648534879, 5729.656220626775, 5738.081906894919, 5742.569307301969, 5746.13807928814, 5749.137629355589, 5617.101263797814, 5810.1865738796605, 5810.273715785527, 5820.0, 5829.09649004405, 5335.546478549328, 5378.435264297232, 5385.7307134643115, 5431.809886653988, 5439.673619582798, 5908.084246941731, 5909.025010873243, 5919.970400148058, 5921.792737254175, 5926.0, 5453.727313634382, 5494.313210848644, 5667.1782591524, 5686.175504551817, 5687.03320435527, 5586.860328491739, 5655.971720141455, 5656.4060773619, 5658.0, 5711.771529138788, 5551.500364967092, 5593.133064375028, 5619.80330688424, 5628.0, 5632.408597097246, 5539.944600554023, 5659.943400566024, 5679.602427830095, 5708.942910570841, 5718.51392631631, 4263.509696384894, 4323.654107671442, 4369.47566292047, 4390.363397307373, 4412.823487060546, 3892.5718171001167, 3914.823832927525, 3926.411038344214, 3945.6054394560315, 3996.0, 5320.600954928396, 5363.517283444508, 5423.457654234545, 5486.615936884459, 5488.25908502355, 5629.043062679354, 5701.942980570141, 5719.771209151588, 5747.1379293106365, 5774.538036957033, 5374.247605335257, 5404.972975135099, 5443.918341224885, 5445.972770136124, 5450.645708028966, 4822.71063736177, 4843.636727245471, 4866.46468888422, 4902.681325713888, 4953.281774142729, 5856.677882716492, 5862.765489380462, 5865.178874957509, 5866.208061911588, 5903.26209223847, 5614.578906581941, 5647.435256474402, 5677.971610141923, 5680.403557626472, 5690.402507736628, 5688.431156884444, 5850.912236316543, 5861.853453663522, 5899.882002359843, 5902.970485147547, 5625.240592519957, 5629.8592535186945, 5630.85922851932, 5631.746571404215, 5633.295838020247, 5742.741576628978, 5743.913841292468, 5752.798652047326, 5754.0, 5759.8560035999435, 5335.226392173191, 5528.695921724344, 5539.667619942817, 5554.972225138848, 5571.832845014656, 5495.477929596682, 5537.889242215053, 5548.250986116823, 5558.416366281644, 5568.9443105568425, 5378.300820893259, 5463.918041229305, 5493.505584497414, 5494.09347457665, 5494.203340515683, 5391.083515802401, 5435.565154787687, 5465.535429488538, 5482.23248745184, 5484.287042684426, 5339.893202136013, 5422.051141050221, 5462.3445186577865, 5518.668879867221, 5523.834284971457], "value": 5227.715766817151, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [550.4844553444883, 592.493418127501, 603.879224155169, 605.5004621187521, 637.2798737426707, 38220.235595288075, 42432.0, 43020.0, 43125.35311970319, 43371.56628433715, 42824.14351712964, 43400.78299608506, 43452.13095738083, 43471.56528434715, 43563.128737425235, 8745.387822852419, 8888.911110888874, 8891.911080889206, 8913.910860891405, 8929.374943753939, 8797.868031979526, 8860.556972151398, 8887.955560222223, 8901.688440904569, 8901.732948011537, 8918.910810891904, 8934.687285944994, 8955.149260820212, 8957.328200384965, 8963.058878817728, 8890.066543012988, 8910.465372077664, 8925.152110549487, 8933.285337173043, 8933.687320943736, 8765.474071555664, 8771.780705482413, 8787.340949428755, 8795.252403545706, 8800.691975780817, 32765.6723432765, 40572.18855622871, 41037.589624103675, 41211.175776484604, 41229.38155927663, 3281.1797050737314, 3324.25204329024, 3545.94681079784, 3852.7303088783797, 4137.54487006429, 30657.846710766527, 30691.386172276652, 30695.232619184477, 31513.52729709056, 31876.840615796773, 4151.91696166078, 4252.213340531981, 4367.3667318238995, 4382.408374869384, 4407.140607581523, 357508.0, 358334.0, 361543.0, 362049.0, 364857.0, 33874.49188262129, 60459.0, 60920.69539652274, 61025.38974610286, 61049.08426373608, 35006.12484687903, 35038.64961350405, 35066.0, 35073.64926350755, 35103.297934041686, 14146.575602731935, 14208.8632909367, 14220.928895355457, 14221.715565688628, 14255.928720356333, 12501.24992500453, 12514.49942002328, 12564.183328083645, 12692.619221423372, 12706.301153436465, 8237.79405514867, 8259.091499935003, 8286.917130828615, 8340.624671889658, 8392.538410387488, 3084.519430673289, 3125.6561778204377, 3149.889753858604, 3172.952405713916, 3177.0786471923348, 963.6482683820495, 970.5875003123645, 988.3081842710131, 1089.8692156941217, 1179.8938095571268, 31575.84212078925, 31700.682993169772, 32190.19524511906, 32379.838100809346, 32567.51148732771, 1039.5218199628105, 1098.8626421697288, 1100.763335882773, 1133.9376334301692, 1155.7284038251005, 16351.59121021984, 16628.33486660544, 16981.575460613585, 17043.573910652332, 17142.657146857244, 585942.0, 590940.0, 593146.0, 593872.0, 596174.0, 58455.0, 59180.0, 59216.70391648014, 59299.407005930254, 59863.70068149632, 1327.8008298755265, 1333.7399207154513, 1347.6832944258092, 1364.9044566880223, 1381.951631692886, 30349.393012140074, 30768.38463230678, 31170.844145779127, 31233.84383078161, 31393.843030785614, 50924.745376272884, 51365.486345137564, 51435.0, 51744.0, 51866.48133518617, 455752.0, 455833.0, 457550.0, 458381.0, 459744.0, 28246.0, 28503.42993140167, 28772.712272877005, 28853.7114628851, 28929.56605650875, 48383.27425088697, 48474.515254847, 49060.75469622629, 49066.26400604065, 49916.50083499119, 40750.59249407586, 42090.57909420867, 42181.1563768729, 42321.365179522945, 42413.57586424219, 41234.38148427836, 41610.79194604007, 41864.0, 42513.36229956491, 43286.350704740085, 34507.0, 39995.0, 41356.0, 41685.374719378626, 42796.358054629825, 35229.82385088058, 36309.63690363063, 36689.633103668624, 37034.444483332234, 37054.44418333781, 28051.0, 28272.0, 28284.010059647815, 28358.85820570884, 28539.571906421836], "value": 18860.511490204273, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [386.3027235839309, 389.2429225157069, 394.62707741184573, 400.46537871940956, 416.4523651398411, 14478.782818257734, 19008.714869276955, 19149.90425047873, 20514.589708205825, 20685.0, 19119.330823421184, 19310.131044103015, 19918.50203744907, 19939.003049847484, 20204.19183232669, 5774.6535207887455, 5816.447437493432, 5965.135055416962, 6016.217891674076, 6034.0948857671265, 5379.0, 5714.114312281582, 5864.149698293766, 5869.677167755772, 5878.323992740826, 5685.346185188715, 5699.601027928046, 5706.0, 5731.0, 5739.225204597367, 5442.2380866678495, 5763.625364351325, 5769.798057068004, 5788.623739456964, 5836.037053886103, 5596.972015139939, 5630.0, 5660.235868157787, 5665.291838520185, 5666.631668941505, 22784.430389240235, 22872.31383058511, 23193.0, 23716.644250336085, 23718.16986405485, 2296.5406918616177, 2307.9538409231723, 2378.2746262389965, 2406.3262286559793, 2408.2414039577475, 9541.427514349092, 9704.61181552737, 9782.168515676176, 11078.335299882034, 14397.912302716153, 1883.3125909043238, 1898.84428979744, 1899.164367678217, 1955.8044195580328, 1967.7209813621262, 76211.23788762097, 77813.61093194554, 78139.6093019537, 78654.0, 79307.6034619829, 10304.227182961307, 10640.0, 11227.249323915694, 11470.770584588261, 11558.190926635054, 15716.449924252596, 15732.134732589817, 15804.68390632204, 15812.76280855765, 15822.446214382442, 7857.842843143105, 8057.758267251992, 8088.595570221465, 8205.425620206648, 8290.792730181794, 7664.961675191588, 7703.460757746904, 7733.8453230935065, 7811.945387372745, 7821.413393995359, 4320.308750599889, 4468.553144685506, 4780.235162374003, 4847.079054979543, 4864.732439715779, 1833.6607727570442, 1963.33246696124, 1995.1321175288506, 2018.1221168791624, 2020.2121172742643, 949.767307009787, 960.6349587156835, 986.7187851462298, 1001.6444162322271, 1005.527402121002, 19982.400527984184, 20057.79942200559, 20341.898290508452, 20350.796492035188, 20390.796092039185, 995.6266400099962, 998.8751406074241, 1034.343192073039, 1040.5785656809005, 1084.6854412220525, 10776.012875236212, 11198.776024479464, 11208.15938804593, 11302.830457543143, 11320.377379244055, 475036.0, 477249.0, 480450.0, 494364.0, 495553.0, 92466.53766731123, 95915.52042239744, 96102.51948740211, 96568.51715741376, 97544.0, 977.5454413697522, 981.9656312029188, 986.1863962231188, 994.0655783563427, 1000.8999100089933, 17499.125043747506, 17607.911960440117, 17633.0, 17708.822911770716, 17907.910460447616, 42144.15711685688, 42684.5731542693, 42960.0, 44001.33997989968, 44255.11489770122, 59286.407135928086, 59585.0, 60084.0, 60187.39812601993, 60221.69889150702, 8589.398742087993, 8737.257333126501, 8836.425632333878, 8872.600732967161, 8927.33045021613, 13342.733145336844, 14294.213818240096, 14612.85387146115, 14678.63303417423, 15025.69948601, 12439.191452555555, 12699.746005080031, 12925.15986460877, 13016.674583135497, 13131.868681313064, 11960.76078478443, 12320.322382268703, 12401.75196496047, 12417.565385211474, 12745.553905613258, 11666.250062490695, 12643.367831608199, 12805.679858003625, 13127.737445251232, 13160.40778165004, 7798.103218129988, 8381.874271885805, 8871.423357481743, 9178.770530736785, 9230.215431688383, 11320.207585469267, 11551.653450396501, 12500.749985000431, 12725.490980360682, 12813.103082784115], "value": 9398.682718248663, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1420.1195258939456, 1469.9853001469985, 1581.4464937271948, 1701.6936951348769, 1730.8355706207913, 7421.443391745614, 7789.688412463494, 8026.879596806045, 8574.442661227016, 8594.91405085949, 8014.759557213293, 8274.089850116483, 8308.626111824968, 8316.875246871286, 8348.415610907225, 2231.152162178374, 2265.682804407384, 2271.0915633746467, 2272.681824544565, 2274.10172981673, 2241.23797908711, 2251.2908433843368, 2268.0587556164173, 2279.8974046167878, 2286.0284379138884, 2186.693862859201, 2248.4154119928853, 2264.5923733727923, 2265.105283413051, 2267.5691618592496, 2219.977800221993, 2226.4322597737555, 2227.0757635581213, 2233.4081468410886, 2234.028197733991, 2197.846150769447, 2223.7331520217517, 2230.509287956647, 2230.921917732888, 2235.2400183937375, 8339.83320333596, 8370.790730231733, 8382.916170838274, 8383.413161078726, 8462.746117616482, 4908.582770464479, 4982.975085124551, 5025.547700706918, 5025.69845809249, 5037.0429618372755, 3211.8715251389917, 3287.5068739689, 3327.168207948013, 3376.088456116859, 3404.3021180657906, 1099.8295264234057, 1122.4724379541603, 1123.3203911633425, 1130.9717257068558, 1136.8976792088752, 11473.942630286796, 11489.195756297062, 11560.595379161688, 11599.478023488964, 11606.30362178272, 4142.2543942090115, 4173.311403618369, 4317.978410107992, 4343.891402714958, 4369.890752731207, 9852.753681158028, 9865.260105492116, 9874.111329980193, 9877.753056173653, 9879.851802222973, 4981.3026176334615, 4990.276409920614, 5007.223880298559, 5007.69953802773, 5023.8492845214705, 4067.6339129477897, 4484.529124441952, 4586.701864378805, 4648.837290694877, 4656.16189085961, 3717.8141092945243, 3781.9810900945317, 3864.555576108727, 3883.1457079442475, 3890.319194141014, 1195.8505186851644, 1222.7432239229684, 1227.4783217132683, 1233.3278363292027, 1233.7169343882442, 1013.8023085498257, 1014.1582486536157, 1016.3495362967707, 1017.5878769098526, 1025.5282570017876, 5937.910931336033, 6010.248718910137, 6016.879662406727, 6019.849503762441, 6257.9687101564205, 951.414879848888, 979.7060881735451, 983.6557204978201, 995.721198064543, 1024.7643042100358, 4223.049813791872, 4235.957640423618, 4290.50659174199, 4365.978170109192, 4383.517813040563, 10243.334183278062, 10576.471176441148, 10588.0, 10607.15142788575, 10610.257281990187, 10322.638707645196, 10455.0, 10483.108935740547, 10488.528016239135, 10547.945205479544, 7613.238676132342, 7882.605869706492, 7901.999999999885, 7914.762557123296, 7970.322522585529, 5986.431289027535, 5991.161237426851, 6143.508519318533, 6200.0699895016105, 6213.316535181036, 9504.382215156269, 9508.908392813593, 9664.178544823488, 9722.1736152425, 9723.756906077404, 9559.904400955902, 9792.167665748491, 9814.55834487464, 9815.509224538888, 9960.601575937171, 6844.384005439534, 7277.126744790659, 7310.634468276671, 7363.521371110861, 7525.096988361432, 8179.877301840596, 8238.464499807493, 8267.62795674184, 8284.0, 8337.416380853281, 7034.613096279753, 7181.964090179516, 7257.963710181626, 7335.046443962251, 7514.323710866049, 7349.4855360124275, 7390.815229619087, 7452.180260171485, 7455.739049133254, 7550.026395211004, 6536.477081833537, 6587.80236592903, 6593.175853018372, 6596.406323430914, 6634.170728658918, 5066.341375621146, 5125.974370128126, 5218.373795144607, 5327.0, 5387.730613469233, 5075.593952483866, 5098.439171691185, 5132.820351287687, 5147.58819294448, 5178.844634660966], "value": 4511.220964178113, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [296.99257518562035, 302.0425251951315, 311.89239712299263, 315.41490535057454, 315.61179748908825, 5631.943680563193, 5648.966372106049, 5654.434556544344, 5703.0589952657765, 5713.4572215639555, 5612.579056570763, 5614.185943038257, 5645.983722929871, 5696.8860622787515, 5708.743106560204, 4141.233871733732, 4163.2930498495625, 4279.293916503773, 4290.562661508383, 4328.264195086843, 4302.763348015857, 4325.243082460573, 4326.58897404746, 4334.869953901388, 4344.913101737963, 4288.828446862138, 4316.07204451043, 4328.523862375152, 4332.978335108336, 4336.371226172203, 4118.691098167635, 4327.632151267146, 4329.826806927719, 4337.804798784062, 4339.652827773771, 3734.514513113278, 3735.084904198489, 3742.925141497182, 3745.2883952049024, 3747.2130852521004, 5505.862353441156, 5552.222688823568, 5564.4713752193475, 5576.832695019156, 5579.972100139514, 4914.0, 4975.7263350515705, 4981.427135879384, 5009.348784658007, 5023.2214006828635, 5951.3751056139345, 5974.761009559613, 5997.700114994276, 6000.279966404059, 6017.368176341465, 4128.277551428518, 4148.730332528376, 4150.937735933963, 4151.937720934188, 4165.812538435777, 6015.729292181863, 6110.712074303406, 6159.045347971027, 6163.414475624809, 6166.198394208769, 4107.644477322477, 4122.711410201317, 4145.689073319513, 4173.7078404512, 4175.498940127143, 4175.331946888483, 4189.49726032878, 4225.514065882401, 4228.281192197333, 4229.513605935295, 4760.785764640599, 4893.535114164149, 4909.803607855646, 4912.238603016538, 4939.0, 5942.970285148546, 5950.732217050243, 5955.52355811534, 6019.157317975487, 6021.488173505301, 1454.4327712192253, 1469.9485518006818, 1473.2854565535706, 1490.6720521485256, 1492.2687882937282, 909.7952960583948, 917.9076898490774, 956.6651671914914, 963.7349728824629, 970.9951450242703, 5684.744186511617, 5698.145278208219, 5769.509591684754, 5776.595638305363, 5802.970985145047, 5998.550108741774, 6058.42480954946, 6059.666718330446, 6099.0, 6137.146227004375, 5505.513511351913, 5684.658920464785, 5720.683123335056, 5730.71346432685, 5745.626534275259, 3258.6415494295607, 3263.9347213055607, 3269.4441944869427, 3292.2592416706048, 3299.4492588483376, 6029.939700602938, 6301.212348456443, 6310.432061114522, 6324.272708638566, 6334.800925532577, 6181.0, 6193.380661933861, 6197.81406557804, 6201.81394558164, 6203.131561581382, 6049.485793707584, 6216.595921265103, 6267.5299352548745, 6287.9056814147825, 6323.936760632335, 6155.169052177898, 6179.412955769195, 6197.605538753744, 6210.347913469202, 6232.657203853651, 6134.693265336805, 6176.320604733386, 6194.305477117468, 6201.410865967726, 6217.129601855653, 6203.2556093269095, 6394.648294343856, 6400.423961843457, 6401.423871851555, 6453.225612926479, 4304.687070443545, 4324.891877703082, 4326.286162783105, 4339.175556644227, 4340.457442819647, 5798.913016304675, 5930.975202646768, 6115.84710382244, 6140.201773769381, 6257.0, 5899.0, 5915.940840591539, 5953.672548009901, 5955.642661440154, 5958.940410595838, 5740.368559458373, 5963.3142188647125, 5963.612365196248, 5994.520438365008, 6019.428154325332, 5865.882682346414, 5880.794172203952, 5886.911696324473, 5927.851803704942, 5977.731002104829, 6009.669468179292, 6027.336992930862, 6039.486643635164, 6045.818625441244, 6071.635701857903, 5630.0, 5837.153612726046, 5854.385289544707, 5908.172855800105, 5916.7041647918295], "value": 4478.948230501583, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [747.2191559819984, 778.4122987144705, 788.3377962511489, 795.6896810244004, 836.732245681382, 15207.619809504755, 15998.120103394309, 16030.519084427471, 16081.919590402047, 16783.91608041961, 15885.126318052502, 16648.58378540537, 16681.66636667266, 16724.16379181042, 16734.330626774943, 665.7636539028648, 786.9842603147933, 799.4403917257914, 804.1194891593696, 804.6982381606897, 787.4055088408244, 811.3022800391658, 812.0296245986019, 812.2689579378577, 813.515958004986, 839.4585492357426, 848.3552500099937, 851.7317045130795, 851.7870532366908, 851.9190676885686, 836.2515548584045, 846.3652260804397, 846.6571038729325, 848.9660413583449, 849.2314455417857, 614.8309214965875, 615.6367743031633, 617.1760699466219, 617.8331850400411, 618.2086928731186, 15248.466303679428, 15279.847201527953, 15367.231638418147, 15376.384944602314, 15394.0, 14691.77962330566, 14806.481773137888, 14894.925525372304, 14955.252237388087, 14977.475788347356, 12891.35543222835, 13008.0, 13081.738365232737, 13140.474381024844, 13330.333483325892, 3827.3684842001035, 3904.2386734586485, 3911.2373087247997, 3924.2936271471126, 4010.7593544387432, 77556.61221693912, 79058.20941790624, 79921.0, 80416.59791701121, 80990.0, 11641.126915481373, 11834.408279585987, 11843.46704398287, 11856.525738970517, 11873.109516786102, 20631.17475301001, 20725.481862953246, 20882.0, 20887.8955605221, 21049.579008419747, 8866.157715017192, 8879.33404994628, 8957.417767845069, 9075.2286055686, 9075.863862042075, 4624.630029597624, 4629.699069560468, 4691.413573303337, 4713.552212539803, 4775.5463230993, 3359.3953088444314, 3451.430513965218, 3472.0972547137926, 3472.3055388922317, 3501.1072176594807, 629.4052120745943, 629.7890206780688, 638.3871483375918, 651.9380658837403, 657.0604036228144, 709.818996155977, 714.1858281559026, 731.4477569435043, 750.4296734481724, 774.8062984253936, 9377.160392513768, 9391.34260601765, 9565.139137477661, 9598.18415434682, 9647.758806029906, 707.8478127202676, 721.4949535325293, 726.1504040272894, 734.765593802417, 737.7270409948353, 4734.479207287196, 4735.076660051257, 4746.0, 4746.4541577719, 4779.880502987453, 71587.0, 71970.0, 72318.63840680763, 112685.0, 114975.42512287384, 102057.4485637865, 107892.46053769838, 107946.46026769973, 108552.4572377133, 108998.45500772445, 90238.09761902297, 91072.08927910769, 91080.0, 91161.54419227994, 94911.0, 8886.244669202932, 8977.371583989057, 9069.410488318503, 9124.726258212264, 9194.174127092801, 52746.0, 54048.0, 54783.726081369336, 55030.44969550413, 55442.0, 80369.59815200887, 82688.58655706682, 84002.15997839943, 84129.0, 85025.14974850172, 11707.0, 11949.0, 11958.521659133537, 12054.0959428045, 12145.69635759113, 13640.0, 13669.384877680726, 13791.931040344734, 14025.789613156016, 14871.330790114687, 11205.159613029218, 11302.717432064264, 11346.489407976496, 11516.596919107791, 11528.942355288169, 12230.694232643898, 12246.877531224574, 12399.318037507663, 12449.564265251034, 12459.501619935101, 11616.535338586362, 11986.880131198577, 13078.215307081606, 13430.39563219638, 14751.852481475047, 11503.0, 11806.763864722485, 11831.875971782667, 12222.511099555919, 12276.447559860006, 11905.642830715093, 12002.63992080239, 12125.514979400725, 12260.509579616715, 12275.26348419062], "value": 7582.736308125835, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1518.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 110.0, 105.0, 111.0, 114.0, 112.0, 113.0, 112.0, 111.0, 110.0], "value": 109.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 118.0, 145.0, 182.0, 120.0, 144.0, 151.0, 124.0, 183.0, 116.0], "value": 142.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 171.0, 163.0, 164.0, 163.0, 165.0, 168.0, 168.0, 162.0, 164.0], "value": 165.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 75.0, 171.0, 79.0, 76.0, 75.0, 74.0, 166.0, 76.0], "value": 94.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 146.0, 84.0, 85.0, 86.0, 127.0, 85.0, 84.0, 153.0], "value": 102.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 118.0, 118.0, 118.0, 117.0, 118.0, 117.0, 117.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 149.0, 146.0, 148.0, 146.0, 148.0, 146.0, 147.0, 149.0, 147.0], "value": 147.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 96.0, 95.0, 95.0, 96.0, 96.0, 96.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 55.0, 55.0, 55.0, 55.0, 55.0, 56.0, 61.0, 57.0], "value": 55.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 61.0, 61.0, 61.0, 61.0, 61.0, 61.0, 62.0, 61.0], "value": 61.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 76.0, 77.0, 75.0, 79.0, 75.0, 84.0, 81.0, 74.0], "value": 77.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 133.0, 125.0, 120.0, 130.0, 120.0, 120.0, 119.0, 169.0, 136.0], "value": 129.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 157.0, 158.0, 158.0, 161.0, 156.0, 161.0, 158.0, 154.0, 155.0], "value": 157.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 64.0, 61.0, 64.0, 62.0, 66.0, 62.0, 65.0, 61.0], "value": 63.1, "unit": "score"}]}]} 10:38:00 INFO - Return code: 0 10:38:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:38:00 ERROR - # TBPL SUCCESS # 10:38:00 INFO - Running post-action listener: _resource_record_post_action 10:38:00 INFO - ##### 10:38:00 INFO - ##### Finished run-tests step (success) 10:38:00 INFO - ##### 10:38:00 INFO - Running post-run listener: _resource_record_post_run 10:38:00 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 4096; Write bytes: 559034368; Read time: 16; Write time: 430208 10:38:00 INFO - TinderboxPrint: CPU usage
13.2% 10:38:00 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 10:38:00 INFO - TinderboxPrint: I/O write bytes / time
559,034,368 / 430,208 10:38:00 INFO - TinderboxPrint: CPU idle
8,230.8 (86.8%) 10:38:00 INFO - TinderboxPrint: CPU user
1,202.3 (12.7%) 10:38:00 INFO - TinderboxPrint: Swap in / out
0 / 0 10:38:00 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 256933888; Read time: 0; Write time: 242168 10:38:00 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 0; Write bytes: 298143744; Read time: 0; Write time: 187580 10:38:00 INFO - Running post-run listener: _upload_blobber_files 10:38:00 INFO - Blob upload gear active. 10:38:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:38:00 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 10:38:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:38:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:38:01 INFO - (blobuploader) - INFO - Open directory for files ... 10:38:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:38:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:38:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:38:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:38:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:38:01 INFO - (blobuploader) - INFO - Done attempting. 10:38:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:38:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:38:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:38:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:38:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:38:02 INFO - (blobuploader) - INFO - Done attempting. 10:38:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:38:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:38:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:38:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:38:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:38:06 INFO - (blobuploader) - INFO - Done attempting. 10:38:06 INFO - (blobuploader) - INFO - Iteration through files over. 10:38:06 INFO - Return code: 0 10:38:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:38:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:38:06 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c45d45b7ba263b07799900a6069b200433b10ddfc63e24bae727a8d24fa10ae292b0eba13470fb7e88ab6c07458315e4f2216fbfc4d77d671d45c51fdbfa18d4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6e6f7f8c474964ea03d7c852ef752381a72bbbee98e96e772438563439d23bee71ead6ca2afebf6a1b434dfee67ea7111c5d84f7efef5b15c4578fd6ee423e3a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/056b22ebdee27a735daed741f930a0348a485db18f2d7a626ae00e44f9b196a983d82e203ab119ece99fe5f9667f344ddaa409fb1983167df9999eb0a03f8807"} 10:38:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:38:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:38:06 INFO - Contents: 10:38:06 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c45d45b7ba263b07799900a6069b200433b10ddfc63e24bae727a8d24fa10ae292b0eba13470fb7e88ab6c07458315e4f2216fbfc4d77d671d45c51fdbfa18d4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6e6f7f8c474964ea03d7c852ef752381a72bbbee98e96e772438563439d23bee71ead6ca2afebf6a1b434dfee67ea7111c5d84f7efef5b15c4578fd6ee423e3a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/056b22ebdee27a735daed741f930a0348a485db18f2d7a626ae00e44f9b196a983d82e203ab119ece99fe5f9667f344ddaa409fb1983167df9999eb0a03f8807"} 10:38:06 INFO - Running post-run listener: copy_logs_to_upload_dir 10:38:06 INFO - Copying logs to upload dir... 10:38:06 INFO - mkdir: /builds/slave/test/build/upload/logs 10:38:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1227.305028 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 27 secs) (at 2016-07-05 10:38:05.034876) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-05 10:38:05.038471) ========= 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=6d15e502d8e29d5d2676d664000001c3-1467739051.453071-18295571 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c45d45b7ba263b07799900a6069b200433b10ddfc63e24bae727a8d24fa10ae292b0eba13470fb7e88ab6c07458315e4f2216fbfc4d77d671d45c51fdbfa18d4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6e6f7f8c474964ea03d7c852ef752381a72bbbee98e96e772438563439d23bee71ead6ca2afebf6a1b434dfee67ea7111c5d84f7efef5b15c4578fd6ee423e3a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/056b22ebdee27a735daed741f930a0348a485db18f2d7a626ae00e44f9b196a983d82e203ab119ece99fe5f9667f344ddaa409fb1983167df9999eb0a03f8807"} build_url:https://queue.taskcluster.net/v1/task/KpMV4ix0QPS5l89dgmA3NQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011179 build_url: 'https://queue.taskcluster.net/v1/task/KpMV4ix0QPS5l89dgmA3NQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c45d45b7ba263b07799900a6069b200433b10ddfc63e24bae727a8d24fa10ae292b0eba13470fb7e88ab6c07458315e4f2216fbfc4d77d671d45c51fdbfa18d4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6e6f7f8c474964ea03d7c852ef752381a72bbbee98e96e772438563439d23bee71ead6ca2afebf6a1b434dfee67ea7111c5d84f7efef5b15c4578fd6ee423e3a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/056b22ebdee27a735daed741f930a0348a485db18f2d7a626ae00e44f9b196a983d82e203ab119ece99fe5f9667f344ddaa409fb1983167df9999eb0a03f8807"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-05 10:38:05.063786) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 10:38:05.064080) ========= 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=6d15e502d8e29d5d2676d664000001c3-1467739051.453071-18295571 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004535 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 10:38:05.146709) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-05 10:38:05.147001) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-05 10:38:05.147300) ========= ========= Total master_lag: 0.15 =========