builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-009 starttime: 1468721156.95 results: success (0) buildid: 20160716163003 builduid: e676697ad19e4d43b2fc0eb24fce6239 revision: e816e9199940ce2b4cbace056b9a849048bf4a63 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-16 19:05:56.947545) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-16 19:05:56.947941) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-16 19:05:56.948219) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-16 19:05:57.026915) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 19:05:57.027177) ========= 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=17051fcd5208b27b50bedfeb000001dd-1468715614.628599-2027855988 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-16 19:05:57-- 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% 103M=0s 2016-07-16 19:05:57 (103 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.071746 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 19:05:57.116474) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 19:05:57.116756) ========= 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=17051fcd5208b27b50bedfeb000001dd-1468715614.628599-2027855988 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020477 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 19:05:57.166891) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 19:05:57.167201) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev e816e9199940ce2b4cbace056b9a849048bf4a63 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev e816e9199940ce2b4cbace056b9a849048bf4a63 --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=17051fcd5208b27b50bedfeb000001dd-1468715614.628599-2027855988 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-16 19:05:57,763 truncating revision to first 12 chars 2016-07-16 19:05:57,763 Setting DEBUG logging. 2016-07-16 19:05:57,763 attempt 1/10 2016-07-16 19:05:57,763 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/e816e9199940?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-16 19:05:58,217 unpacking tar archive at: mozilla-inbound-e816e9199940/testing/mozharness/ program finished with exit code 0 elapsedTime=0.760803 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 19:05:57.942158) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-16 19:05:57.942467) ========= script_repo_revision: e816e9199940ce2b4cbace056b9a849048bf4a63 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-16 19:05:57.942840) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-16 19:05:57.943110) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-16 19:05:57.952885) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-07-16 19:05:57.953157) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=17051fcd5208b27b50bedfeb000001dd-1468715614.628599-2027855988 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:05:58 INFO - MultiFileLogger online at 20160716 19:05:58 in /builds/slave/test 19:05:58 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 19:05:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:05:58 INFO - {'append_to_log': False, 19:05:58 INFO - 'base_work_dir': '/builds/slave/test', 19:05:58 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 19:05:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:05:58 INFO - 'branch': 'Mozilla-Inbound', 19:05:58 INFO - 'buildbot_json_path': 'buildprops.json', 19:05:58 INFO - 'config_files': ('talos/linux_config.py',), 19:05:58 INFO - 'default_actions': ('clobber', 19:05:58 INFO - 'read-buildbot-config', 19:05:58 INFO - 'download-and-extract', 19:05:58 INFO - 'populate-webroot', 19:05:58 INFO - 'create-virtualenv', 19:05:58 INFO - 'install', 19:05:58 INFO - 'run-tests'), 19:05:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:05:58 INFO - 'download_minidump_stackwalk': True, 19:05:58 INFO - 'download_symbols': 'ondemand', 19:05:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:05:58 INFO - 'tooltool.py': '/tools/tooltool.py', 19:05:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:05:58 INFO - '/tools/misc-python/virtualenv.py')}, 19:05:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:05:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:05:58 INFO - 'installer_path': 'installer.exe', 19:05:58 INFO - 'log_level': 'info', 19:05:58 INFO - 'log_name': 'talos', 19:05:58 INFO - 'log_to_console': True, 19:05:58 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:05:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:05:58 INFO - 'opt_config_files': (), 19:05:58 INFO - 'pip_index': False, 19:05:58 INFO - 'sps_profile': False, 19:05:58 INFO - 'sps_profile_interval': 0, 19:05:58 INFO - 'suite': 'dromaeojs', 19:05:58 INFO - 'system_bits': '32', 19:05:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:05:58 INFO - 'title': 'talos-linux64-ix-009', 19:05:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:05:58 INFO - 'use_talos_json': True, 19:05:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:05:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:05:58 INFO - 'work_dir': 'build'} 19:05:58 INFO - ##### 19:05:58 INFO - ##### Running clobber step. 19:05:58 INFO - ##### 19:05:58 INFO - Running pre-action listener: _resource_record_pre_action 19:05:58 INFO - Running main action method: clobber 19:05:58 INFO - rmtree: /builds/slave/test/build 19:05:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:05:59 INFO - Running post-action listener: _resource_record_post_action 19:05:59 INFO - ##### 19:05:59 INFO - ##### Finished clobber step (success) 19:05:59 INFO - ##### 19:05:59 INFO - ##### 19:05:59 INFO - ##### Running read-buildbot-config step. 19:05:59 INFO - ##### 19:05:59 INFO - Running pre-action listener: _resource_record_pre_action 19:05:59 INFO - Running main action method: read_buildbot_config 19:05:59 INFO - Using buildbot properties: 19:05:59 INFO - { 19:05:59 INFO - "project": "", 19:05:59 INFO - "product": "firefox", 19:05:59 INFO - "script_repo_revision": "production", 19:05:59 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 19:05:59 INFO - "repository": "", 19:05:59 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 19:05:59 INFO - "buildid": "20160716163003", 19:05:59 INFO - "pgo_build": "True", 19:05:59 INFO - "basedir": "/builds/slave/test", 19:05:59 INFO - "buildnumber": 2071, 19:05:59 INFO - "slavename": "talos-linux64-ix-009", 19:05:59 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 19:05:59 INFO - "platform": "ubuntu64_hw", 19:05:59 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 19:05:59 INFO - "branch": "mozilla-inbound", 19:05:59 INFO - "repo_path": "integration/mozilla-inbound", 19:05:59 INFO - "revision": "e816e9199940ce2b4cbace056b9a849048bf4a63", 19:05:59 INFO - "stage_platform": "linux64-pgo", 19:05:59 INFO - "builduid": "e676697ad19e4d43b2fc0eb24fce6239", 19:05:59 INFO - "slavebuilddir": "test" 19:05:59 INFO - } 19:05:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/bAQxJ7egSL-ZHBPBzqsC3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 19:05:59 INFO - Running post-action listener: _resource_record_post_action 19:05:59 INFO - ##### 19:05:59 INFO - ##### Finished read-buildbot-config step (success) 19:05:59 INFO - ##### 19:05:59 INFO - ##### 19:05:59 INFO - ##### Running download-and-extract step. 19:05:59 INFO - ##### 19:05:59 INFO - Running pre-action listener: _resource_record_pre_action 19:05:59 INFO - Running main action method: download_and_extract 19:05:59 INFO - mkdir: /builds/slave/test/build/tests 19:05: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')]} 19:05:59 INFO - https://queue.taskcluster.net/v1/task/bAQxJ7egSL-ZHBPBzqsC3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 19:05:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bAQxJ7egSL-ZHBPBzqsC3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:05:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bAQxJ7egSL-ZHBPBzqsC3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:05:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bAQxJ7egSL-ZHBPBzqsC3w/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 19:05:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bAQxJ7egSL-ZHBPBzqsC3w/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 19:06:03 INFO - Downloaded 1361 bytes. 19:06:03 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:06:03 INFO - Using the following test package requirements: 19:06:03 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 19:06:03 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:06:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:06:03 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:06:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:06:03 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:06:03 INFO - u'jsshell-linux-x86_64.zip'], 19:06:03 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:06:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:06:03 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 19:06:03 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:06:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:06:03 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:06:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:06:03 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:06:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:06:03 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:06:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:06:03 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:06: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')]} 19:06:03 INFO - https://queue.taskcluster.net/v1/task/bAQxJ7egSL-ZHBPBzqsC3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:06:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bAQxJ7egSL-ZHBPBzqsC3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:06:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bAQxJ7egSL-ZHBPBzqsC3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:06:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bAQxJ7egSL-ZHBPBzqsC3w/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 19:06:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bAQxJ7egSL-ZHBPBzqsC3w/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 19:06:06 INFO - Downloaded 24334490 bytes. 19:06:06 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'] 19:06:06 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 19:06:07 INFO - Return code: 0 19:06:07 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 19:06:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:06:07 INFO - https://queue.taskcluster.net/v1/task/bAQxJ7egSL-ZHBPBzqsC3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:06:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bAQxJ7egSL-ZHBPBzqsC3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:06:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bAQxJ7egSL-ZHBPBzqsC3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:06:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bAQxJ7egSL-ZHBPBzqsC3w/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 19:06:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bAQxJ7egSL-ZHBPBzqsC3w/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 19:06:13 INFO - Downloaded 24334490 bytes. 19:06:13 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:06:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 19:06:15 INFO - Return code: 0 19:06:15 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')]} 19:06:15 INFO - https://queue.taskcluster.net/v1/task/bAQxJ7egSL-ZHBPBzqsC3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:06:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bAQxJ7egSL-ZHBPBzqsC3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 19:06:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bAQxJ7egSL-ZHBPBzqsC3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 19:06:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bAQxJ7egSL-ZHBPBzqsC3w/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 19:06:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bAQxJ7egSL-ZHBPBzqsC3w/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 19:06:16 INFO - Downloaded 14403317 bytes. 19:06:16 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'] 19:06:16 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 19:06:16 INFO - Return code: 0 19:06:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:06:16 INFO - https://queue.taskcluster.net/v1/task/bAQxJ7egSL-ZHBPBzqsC3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:06:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bAQxJ7egSL-ZHBPBzqsC3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:06:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bAQxJ7egSL-ZHBPBzqsC3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:06:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bAQxJ7egSL-ZHBPBzqsC3w/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 19:06:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bAQxJ7egSL-ZHBPBzqsC3w/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 19:06:17 INFO - Downloaded 60812445 bytes. 19:06:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bAQxJ7egSL-ZHBPBzqsC3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:06:17 INFO - mkdir: /builds/slave/test/properties 19:06:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:06:17 INFO - Writing to file /builds/slave/test/properties/build_url 19:06:17 INFO - Contents: 19:06:17 INFO - build_url:https://queue.taskcluster.net/v1/task/bAQxJ7egSL-ZHBPBzqsC3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:06:18 INFO - Running post-action listener: _resource_record_post_action 19:06:18 INFO - Running post-action listener: set_extra_try_arguments 19:06:18 INFO - ##### 19:06:18 INFO - ##### Finished download-and-extract step (success) 19:06:18 INFO - ##### 19:06:18 INFO - ##### 19:06:18 INFO - ##### Running populate-webroot step. 19:06:18 INFO - ##### 19:06:18 INFO - Running pre-action listener: _resource_record_pre_action 19:06:18 INFO - Running main action method: populate_webroot 19:06:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:06:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:06:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:06:18 INFO - '--tppagecycles', 19:06:18 INFO - '7'], 19:06:18 INFO - 'tests': ['tsvgm']}}, 19:06:18 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:06:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:06:18 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:06:18 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:06:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:06:18 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:06:18 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:06:18 INFO - 'talos_options': ['--disable-e10s'], 19:06:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:06:18 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:06:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:06:18 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:06:18 INFO - 'talos_options': ['--disable-e10s'], 19:06:18 INFO - 'tests': ['damp', 'tps']}, 19:06:18 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:06:18 INFO - 'tests': ['damp', 'tps']}, 19:06:18 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:06:18 INFO - 'tests': ['dromaeo_dom']}, 19:06:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:06:18 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:06:18 INFO - 'tests': ['basic_compositor_video']}, 19:06:18 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:06:18 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:06:18 INFO - 'tests': ['a11yr', 19:06:18 INFO - 'ts_paint', 19:06:18 INFO - 'tpaint', 19:06:18 INFO - 'sessionrestore', 19:06:18 INFO - 'sessionrestore_no_auto_restore', 19:06:18 INFO - 'tabpaint']}, 19:06:18 INFO - 'other-e10s': {'tests': ['a11yr', 19:06:18 INFO - 'ts_paint', 19:06:18 INFO - 'tpaint', 19:06:18 INFO - 'sessionrestore', 19:06:18 INFO - 'sessionrestore_no_auto_restore', 19:06:18 INFO - 'tabpaint']}, 19:06:18 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:06:18 INFO - 'ts_paint', 19:06:18 INFO - 'tpaint', 19:06:18 INFO - 'sessionrestore', 19:06:18 INFO - 'sessionrestore_no_auto_restore', 19:06:18 INFO - 'tabpaint']}, 19:06:18 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:06:18 INFO - 'ts_paint', 19:06:18 INFO - 'tpaint', 19:06:18 INFO - 'sessionrestore', 19:06:18 INFO - 'sessionrestore_no_auto_restore', 19:06:18 INFO - 'tabpaint']}, 19:06:18 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:06:18 INFO - 'tests': ['a11yr', 19:06:18 INFO - 'ts_paint', 19:06:18 INFO - 'tpaint', 19:06:18 INFO - 'sessionrestore', 19:06:18 INFO - 'sessionrestore_no_auto_restore', 19:06:18 INFO - 'tabpaint']}, 19:06:18 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:06:18 INFO - 'tests': ['a11yr', 19:06:18 INFO - 'ts_paint', 19:06:18 INFO - 'tpaint', 19:06:18 INFO - 'sessionrestore', 19:06:18 INFO - 'sessionrestore_no_auto_restore', 19:06:18 INFO - 'tabpaint']}, 19:06:18 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:06:18 INFO - 'tests': ['tsvgx', 19:06:18 INFO - 'tsvgr_opacity', 19:06:18 INFO - 'tart', 19:06:18 INFO - 'tscrollx', 19:06:18 INFO - 'cart']}, 19:06:18 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:06:18 INFO - 'tsvgr_opacity', 19:06:18 INFO - 'tart', 19:06:18 INFO - 'tscrollx', 19:06:18 INFO - 'cart']}, 19:06:18 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:06:18 INFO - 'talos_options': ['--disable-e10s'], 19:06:18 INFO - 'tests': ['tp5o']}, 19:06:18 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:06:18 INFO - 'tests': ['tp5o']}, 19:06:18 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:06:18 INFO - 'talos_options': ['--disable-e10s', 19:06:18 INFO - '--xperf_path', 19:06:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:06:18 INFO - 'tests': ['tp5n']}, 19:06:18 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:06:18 INFO - 'talos_options': ['--xperf_path', 19:06:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:06:18 INFO - 'tests': ['tp5n']}}, 19:06:18 INFO - 'talos.zip': {'path': '', 19:06:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:06:18 INFO - Running post-action listener: _resource_record_post_action 19:06:18 INFO - ##### 19:06:18 INFO - ##### Finished populate-webroot step (success) 19:06:18 INFO - ##### 19:06:18 INFO - ##### 19:06:18 INFO - ##### Running create-virtualenv step. 19:06:18 INFO - ##### 19:06:18 INFO - Running pre-action listener: _resource_record_pre_action 19:06:18 INFO - Running main action method: create_virtualenv 19:06:18 INFO - Creating virtualenv /builds/slave/test/build/venv 19:06:18 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 19:06:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:06:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:06:18 INFO - Using real prefix '/usr' 19:06:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:06:19 INFO - Installing distribute.............................................................................................................................................................................................done. 19:06:21 INFO - Installing pip.................done. 19:06:21 INFO - Return code: 0 19:06:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:06:21 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')]} 19:06:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:06:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:06:21 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')]} 19:06:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:06:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:06:21 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 0xee4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11a5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a33b0>, '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 0x11a42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11a4740>, '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': '17051fcd5208b27b50bedfeb000001dd-1468715614.628599-2027855988', '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 19:06:21 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 19:06:21 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 19:06:21 INFO - Using env: {'DISPLAY': ':0', 19:06:21 INFO - 'HOME': '/home/cltbld', 19:06:21 INFO - 'LANG': 'en_US.UTF-8', 19:06:21 INFO - 'LANGUAGE': 'en_US:en', 19:06:21 INFO - 'LOGNAME': 'cltbld', 19:06:21 INFO - 'MAIL': '/var/mail/cltbld', 19:06:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:06:21 INFO - 'MOZ_NO_REMOTE': '1', 19:06:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:06:21 INFO - 'NO_EM_RESTART': '1', 19:06:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:06:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:06:21 INFO - 'PWD': '/builds/slave/test', 19:06:21 INFO - 'SHELL': '/bin/bash', 19:06:21 INFO - 'SHLVL': '1', 19:06:21 INFO - 'TERM': 'linux', 19:06:21 INFO - 'TMOUT': '86400', 19:06:21 INFO - 'USER': 'cltbld', 19:06:21 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1468715614.628599-2027855988', 19:06:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:06:21 INFO - '_': '/tools/buildbot/bin/python'} 19:06:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:06:21 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 19:06:21 INFO - Cleaning up... 19:06:21 INFO - Return code: 0 19:06:21 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:06:21 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')]} 19:06:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:06:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:06:21 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')]} 19:06:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:06:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:06:21 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 0xee4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11a5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a33b0>, '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 0x11a42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11a4740>, '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': '17051fcd5208b27b50bedfeb000001dd-1468715614.628599-2027855988', '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 19:06:21 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 19:06:21 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 19:06:21 INFO - Using env: {'DISPLAY': ':0', 19:06:21 INFO - 'HOME': '/home/cltbld', 19:06:21 INFO - 'LANG': 'en_US.UTF-8', 19:06:21 INFO - 'LANGUAGE': 'en_US:en', 19:06:21 INFO - 'LOGNAME': 'cltbld', 19:06:21 INFO - 'MAIL': '/var/mail/cltbld', 19:06:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:06:21 INFO - 'MOZ_NO_REMOTE': '1', 19:06:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:06:21 INFO - 'NO_EM_RESTART': '1', 19:06:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:06:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:06:21 INFO - 'PWD': '/builds/slave/test', 19:06:21 INFO - 'SHELL': '/bin/bash', 19:06:21 INFO - 'SHLVL': '1', 19:06:21 INFO - 'TERM': 'linux', 19:06:21 INFO - 'TMOUT': '86400', 19:06:21 INFO - 'USER': 'cltbld', 19:06:21 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1468715614.628599-2027855988', 19:06:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:06:21 INFO - '_': '/tools/buildbot/bin/python'} 19:06:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:06:21 INFO - Downloading/unpacking psutil>=3.1.1 19:06:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:06:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:06:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:06:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:06:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:06:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:06:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:06:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:06:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:06:23 INFO - Installing collected packages: psutil 19:06:23 INFO - Running setup.py install for psutil 19:06:23 INFO - building 'psutil._psutil_linux' extension 19:06:23 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 19:06:23 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 19:06:23 INFO - building 'psutil._psutil_posix' extension 19:06:23 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 19:06:23 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 19:06:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:06:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:06:24 INFO - Successfully installed psutil 19:06:24 INFO - Cleaning up... 19:06:24 INFO - Return code: 0 19:06:24 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:06:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:06:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:06:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:06:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:06:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:06:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:06:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xee4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11a5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a33b0>, '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 0x11a42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11a4740>, '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': '17051fcd5208b27b50bedfeb000001dd-1468715614.628599-2027855988', '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 19:06:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 19:06:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 19:06:24 INFO - Using env: {'DISPLAY': ':0', 19:06:24 INFO - 'HOME': '/home/cltbld', 19:06:24 INFO - 'LANG': 'en_US.UTF-8', 19:06:24 INFO - 'LANGUAGE': 'en_US:en', 19:06:24 INFO - 'LOGNAME': 'cltbld', 19:06:24 INFO - 'MAIL': '/var/mail/cltbld', 19:06:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:06:24 INFO - 'MOZ_NO_REMOTE': '1', 19:06:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:06:24 INFO - 'NO_EM_RESTART': '1', 19:06:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:06:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:06:24 INFO - 'PWD': '/builds/slave/test', 19:06:24 INFO - 'SHELL': '/bin/bash', 19:06:24 INFO - 'SHLVL': '1', 19:06:24 INFO - 'TERM': 'linux', 19:06:24 INFO - 'TMOUT': '86400', 19:06:24 INFO - 'USER': 'cltbld', 19:06:24 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1468715614.628599-2027855988', 19:06:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:06:24 INFO - '_': '/tools/buildbot/bin/python'} 19:06:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:06:24 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:06:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:06:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:06:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:06:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:06:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:06:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:06:26 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:06:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:06:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:06:26 INFO - Installing collected packages: mozsystemmonitor 19:06:26 INFO - Running setup.py install for mozsystemmonitor 19:06:26 INFO - Successfully installed mozsystemmonitor 19:06:26 INFO - Cleaning up... 19:06:26 INFO - Return code: 0 19:06:26 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:06:26 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')]} 19:06:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:06:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:06:26 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')]} 19:06:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:06:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:06:26 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 0xee4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11a5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a33b0>, '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 0x11a42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11a4740>, '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': '17051fcd5208b27b50bedfeb000001dd-1468715614.628599-2027855988', '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 19:06:26 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 19:06:26 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 19:06:26 INFO - Using env: {'DISPLAY': ':0', 19:06:26 INFO - 'HOME': '/home/cltbld', 19:06:26 INFO - 'LANG': 'en_US.UTF-8', 19:06:26 INFO - 'LANGUAGE': 'en_US:en', 19:06:26 INFO - 'LOGNAME': 'cltbld', 19:06:26 INFO - 'MAIL': '/var/mail/cltbld', 19:06:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:06:26 INFO - 'MOZ_NO_REMOTE': '1', 19:06:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:06:26 INFO - 'NO_EM_RESTART': '1', 19:06:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:06:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:06:26 INFO - 'PWD': '/builds/slave/test', 19:06:26 INFO - 'SHELL': '/bin/bash', 19:06:26 INFO - 'SHLVL': '1', 19:06:26 INFO - 'TERM': 'linux', 19:06:26 INFO - 'TMOUT': '86400', 19:06:26 INFO - 'USER': 'cltbld', 19:06:26 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1468715614.628599-2027855988', 19:06:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:06:26 INFO - '_': '/tools/buildbot/bin/python'} 19:06:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:06:26 INFO - Downloading/unpacking jsonschema==2.5.1 19:06:26 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 19:06:26 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 19:06:26 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 19:06:26 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 19:06:26 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 19:06:26 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 19:06:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:06:28 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:06:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:06:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:06:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:06:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:06:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:06:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:06:28 INFO - Downloading functools32-3.2.3-2.tar.gz 19:06:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:06:28 INFO - warning: no files found matching '*.txt' 19:06:28 INFO - no previously-included directories found matching 'build' 19:06:28 INFO - no previously-included directories found matching 'dist' 19:06:28 INFO - no previously-included directories found matching '.git*' 19:06:28 INFO - Installing collected packages: jsonschema, functools32 19:06:28 INFO - Running setup.py install for functools32 19:06:28 INFO - warning: no files found matching '*.txt' 19:06:28 INFO - no previously-included directories found matching 'build' 19:06:28 INFO - no previously-included directories found matching 'dist' 19:06:28 INFO - no previously-included directories found matching '.git*' 19:06:28 INFO - Successfully installed jsonschema functools32 19:06:28 INFO - Cleaning up... 19:06:29 INFO - Return code: 0 19:06:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:06:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:06:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:06:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:06:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:06:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:06:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:06:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xee4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11a5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a33b0>, '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 0x11a42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11a4740>, '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': '17051fcd5208b27b50bedfeb000001dd-1468715614.628599-2027855988', '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 19:06:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 19:06:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:06:29 INFO - Using env: {'DISPLAY': ':0', 19:06:29 INFO - 'HOME': '/home/cltbld', 19:06:29 INFO - 'LANG': 'en_US.UTF-8', 19:06:29 INFO - 'LANGUAGE': 'en_US:en', 19:06:29 INFO - 'LOGNAME': 'cltbld', 19:06:29 INFO - 'MAIL': '/var/mail/cltbld', 19:06:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:06:29 INFO - 'MOZ_NO_REMOTE': '1', 19:06:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:06:29 INFO - 'NO_EM_RESTART': '1', 19:06:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:06:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:06:29 INFO - 'PWD': '/builds/slave/test', 19:06:29 INFO - 'SHELL': '/bin/bash', 19:06:29 INFO - 'SHLVL': '1', 19:06:29 INFO - 'TERM': 'linux', 19:06:29 INFO - 'TMOUT': '86400', 19:06:29 INFO - 'USER': 'cltbld', 19:06:29 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1468715614.628599-2027855988', 19:06:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:06:29 INFO - '_': '/tools/buildbot/bin/python'} 19:06:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:06:29 INFO - Downloading/unpacking blobuploader==1.2.4 19:06:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:06:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:06:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:06:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:06:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:06:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:06:31 INFO - Downloading blobuploader-1.2.4.tar.gz 19:06:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:06:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:06:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:06:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:06:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:06:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:06:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:06:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:06:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:06:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:06:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:06:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:06:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:06:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:06:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:06:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:06:31 INFO - Downloading docopt-0.6.1.tar.gz 19:06:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:06:31 INFO - Installing collected packages: blobuploader, requests, docopt 19:06:31 INFO - Running setup.py install for blobuploader 19:06:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:06:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:06:31 INFO - Running setup.py install for requests 19:06:32 INFO - Running setup.py install for docopt 19:06:32 INFO - Successfully installed blobuploader requests docopt 19:06:32 INFO - Cleaning up... 19:06:32 INFO - Return code: 0 19:06:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:06:32 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')]} 19:06:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:06:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:06:32 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')]} 19:06:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:06:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:06:32 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 0xee4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11a5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a33b0>, '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 0x11a42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11a4740>, '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': '17051fcd5208b27b50bedfeb000001dd-1468715614.628599-2027855988', '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 19:06:32 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 19:06:32 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 19:06:32 INFO - Using env: {'DISPLAY': ':0', 19:06:32 INFO - 'HOME': '/home/cltbld', 19:06:32 INFO - 'LANG': 'en_US.UTF-8', 19:06:32 INFO - 'LANGUAGE': 'en_US:en', 19:06:32 INFO - 'LOGNAME': 'cltbld', 19:06:32 INFO - 'MAIL': '/var/mail/cltbld', 19:06:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:06:32 INFO - 'MOZ_NO_REMOTE': '1', 19:06:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:06:32 INFO - 'NO_EM_RESTART': '1', 19:06:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:06:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:06:32 INFO - 'PWD': '/builds/slave/test', 19:06:32 INFO - 'SHELL': '/bin/bash', 19:06:32 INFO - 'SHLVL': '1', 19:06:32 INFO - 'TERM': 'linux', 19:06:32 INFO - 'TMOUT': '86400', 19:06:32 INFO - 'USER': 'cltbld', 19:06:32 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1468715614.628599-2027855988', 19:06:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:06:32 INFO - '_': '/tools/buildbot/bin/python'} 19:06:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:06:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:06:32 INFO - Running setup.py (path:/tmp/pip-xbnc7Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:06:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:06:32 INFO - Running setup.py (path:/tmp/pip-vKPPsl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:06:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:06:32 INFO - Running setup.py (path:/tmp/pip-B9hQb_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:06:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:06:32 INFO - Running setup.py (path:/tmp/pip-qXZUJK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:06:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:06:33 INFO - Running setup.py (path:/tmp/pip-Hfc1v4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:06:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:06:33 INFO - Running setup.py (path:/tmp/pip-4jdpDv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:06:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:06:33 INFO - Running setup.py (path:/tmp/pip-twq5tL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:06:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:06:33 INFO - Running setup.py (path:/tmp/pip-byTwlm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:06:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:06:33 INFO - Running setup.py (path:/tmp/pip-JTFs2d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:06:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:06:33 INFO - Running setup.py (path:/tmp/pip-2C0fHm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:06:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:06:33 INFO - Running setup.py (path:/tmp/pip-_l_jTE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:06:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:06:33 INFO - Running setup.py (path:/tmp/pip-agRgvq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:06:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:06:33 INFO - Running setup.py (path:/tmp/pip-3kdLE0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:06:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:06:33 INFO - Running setup.py (path:/tmp/pip-7H8kJt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:06:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:06:33 INFO - Running setup.py (path:/tmp/pip-cohjfr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:06:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:06:33 INFO - Running setup.py (path:/tmp/pip-rJeU3A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:06:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:06:33 INFO - Running setup.py (path:/tmp/pip-clZwj3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:06:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:06:33 INFO - Running setup.py install for manifestparser 19:06:34 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:06:34 INFO - Running setup.py install for mozcrash 19:06:34 INFO - Running setup.py install for mozdebug 19:06:34 INFO - Running setup.py install for mozdevice 19:06:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:06:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:06:34 INFO - Running setup.py install for mozfile 19:06:34 INFO - Running setup.py install for mozhttpd 19:06:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:06:34 INFO - Running setup.py install for mozinfo 19:06:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:06:34 INFO - Running setup.py install for mozInstall 19:06:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:06:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:06:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:06:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:06:34 INFO - Running setup.py install for mozleak 19:06:34 INFO - Running setup.py install for mozlog 19:06:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:06:34 INFO - Running setup.py install for moznetwork 19:06:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:06:35 INFO - Running setup.py install for mozprocess 19:06:35 INFO - Running setup.py install for mozprofile 19:06:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:06:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:06:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:06:35 INFO - Running setup.py install for mozrunner 19:06:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:06:35 INFO - Running setup.py install for mozscreenshot 19:06:35 INFO - Running setup.py install for moztest 19:06:35 INFO - Running setup.py install for mozversion 19:06:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:06:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:06:35 INFO - Cleaning up... 19:06:35 INFO - Return code: 0 19:06:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:06:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:06:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:06:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:06:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:06:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:06:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:06:35 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 0xee4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11a5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a33b0>, '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 0x11a42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11a4740>, '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': '17051fcd5208b27b50bedfeb000001dd-1468715614.628599-2027855988', '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 19:06:35 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 19:06:35 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 19:06:35 INFO - Using env: {'DISPLAY': ':0', 19:06:35 INFO - 'HOME': '/home/cltbld', 19:06:35 INFO - 'LANG': 'en_US.UTF-8', 19:06:35 INFO - 'LANGUAGE': 'en_US:en', 19:06:35 INFO - 'LOGNAME': 'cltbld', 19:06:35 INFO - 'MAIL': '/var/mail/cltbld', 19:06:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:06:35 INFO - 'MOZ_NO_REMOTE': '1', 19:06:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:06:35 INFO - 'NO_EM_RESTART': '1', 19:06:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:06:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:06:35 INFO - 'PWD': '/builds/slave/test', 19:06:35 INFO - 'SHELL': '/bin/bash', 19:06:35 INFO - 'SHLVL': '1', 19:06:35 INFO - 'TERM': 'linux', 19:06:35 INFO - 'TMOUT': '86400', 19:06:35 INFO - 'USER': 'cltbld', 19:06:35 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1468715614.628599-2027855988', 19:06:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:06:35 INFO - '_': '/tools/buildbot/bin/python'} 19:06:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:06:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:06:35 INFO - Running setup.py (path:/tmp/pip-kjHSLt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:06:36 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)) 19:06:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:06:36 INFO - Running setup.py (path:/tmp/pip-ge9HVm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:06:36 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)) 19:06:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:06:36 INFO - Running setup.py (path:/tmp/pip-HmpsOM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:06:36 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)) 19:06:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:06:36 INFO - Running setup.py (path:/tmp/pip-Iu3UaR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:06:36 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)) 19:06:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:06:36 INFO - Running setup.py (path:/tmp/pip-nINowz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:06:36 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)) 19:06:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:06:36 INFO - Running setup.py (path:/tmp/pip-Jm7HKU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:06:36 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)) 19:06:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:06:36 INFO - Running setup.py (path:/tmp/pip-CDPnjY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:06:36 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)) 19:06:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:06:36 INFO - Running setup.py (path:/tmp/pip-9Zxqmk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:06:36 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)) 19:06:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:06:36 INFO - Running setup.py (path:/tmp/pip-DQF7au-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:06:36 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)) 19:06:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:06:36 INFO - Running setup.py (path:/tmp/pip-jV0tN4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:06:36 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)) 19:06:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:06:36 INFO - Running setup.py (path:/tmp/pip-vepQSs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:06:36 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)) 19:06:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:06:36 INFO - Running setup.py (path:/tmp/pip-v20dgK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:06:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 19:06:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:06:36 INFO - Running setup.py (path:/tmp/pip-pUCIUr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:06:36 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)) 19:06:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:06:36 INFO - Running setup.py (path:/tmp/pip-6can6S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:06:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 19:06:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:06:37 INFO - Running setup.py (path:/tmp/pip-OMD7YR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:06:37 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)) 19:06:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:06:37 INFO - Running setup.py (path:/tmp/pip-5dk_7I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:06:37 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)) 19:06:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:06:37 INFO - Running setup.py (path:/tmp/pip-HAjIj0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:06:37 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)) 19:06:37 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)) 19:06:37 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)) 19:06:37 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)) 19:06:37 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)) 19:06:37 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)) 19:06:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:06:37 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 19:06:37 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 19:06:37 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 19:06:37 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 19:06:37 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 19:06:37 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 19:06:39 INFO - Downloading blessings-1.6.tar.gz 19:06:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:06:39 INFO - Installing collected packages: blessings 19:06:39 INFO - Running setup.py install for blessings 19:06:39 INFO - Successfully installed blessings 19:06:39 INFO - Cleaning up... 19:06:39 INFO - Return code: 0 19:06:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:06:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:06:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:06:39 INFO - Reading from file tmpfile_stdout 19:06:39 INFO - Current package versions: 19:06:39 INFO - argparse == 1.2.1 19:06:39 INFO - blessings == 1.6 19:06:39 INFO - blobuploader == 1.2.4 19:06:39 INFO - docopt == 0.6.1 19:06:39 INFO - functools32 == 3.2.3-2 19:06:39 INFO - jsonschema == 2.5.1 19:06:39 INFO - manifestparser == 1.1 19:06:39 INFO - mozInstall == 1.12 19:06:39 INFO - mozcrash == 0.17 19:06:39 INFO - mozdebug == 0.1 19:06:39 INFO - mozdevice == 0.48 19:06:39 INFO - mozfile == 1.2 19:06:39 INFO - mozhttpd == 0.7 19:06:39 INFO - mozinfo == 0.9 19:06:39 INFO - mozleak == 0.1 19:06:39 INFO - mozlog == 3.2 19:06:39 INFO - moznetwork == 0.27 19:06:39 INFO - mozprocess == 0.23 19:06:39 INFO - mozprofile == 0.28 19:06:39 INFO - mozrunner == 6.12 19:06:39 INFO - mozscreenshot == 0.1 19:06:39 INFO - mozsystemmonitor == 0.3 19:06:39 INFO - moztest == 0.7 19:06:39 INFO - mozversion == 1.4 19:06:39 INFO - psutil == 3.1.1 19:06:39 INFO - requests == 1.2.3 19:06:39 INFO - wsgiref == 0.1.2 19:06:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:06:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:06:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:06:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:06:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:06:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:06:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:06:39 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 0xee4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11a5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a33b0>, '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 0x11a42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11a4740>, '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': '17051fcd5208b27b50bedfeb000001dd-1468715614.628599-2027855988', '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 19:06:39 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 19:06:39 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 19:06:39 INFO - Using env: {'DISPLAY': ':0', 19:06:39 INFO - 'HOME': '/home/cltbld', 19:06:39 INFO - 'LANG': 'en_US.UTF-8', 19:06:39 INFO - 'LANGUAGE': 'en_US:en', 19:06:39 INFO - 'LOGNAME': 'cltbld', 19:06:39 INFO - 'MAIL': '/var/mail/cltbld', 19:06:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:06:39 INFO - 'MOZ_NO_REMOTE': '1', 19:06:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:06:39 INFO - 'NO_EM_RESTART': '1', 19:06:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:06:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:06:39 INFO - 'PWD': '/builds/slave/test', 19:06:39 INFO - 'SHELL': '/bin/bash', 19:06:39 INFO - 'SHLVL': '1', 19:06:39 INFO - 'TERM': 'linux', 19:06:39 INFO - 'TMOUT': '86400', 19:06:39 INFO - 'USER': 'cltbld', 19:06:39 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1468715614.628599-2027855988', 19:06:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:06:39 INFO - '_': '/tools/buildbot/bin/python'} 19:06:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:06:39 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)) 19:06:39 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)) 19:06:39 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)) 19:06:39 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)) 19:06:39 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)) 19:06:39 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)) 19:06:39 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)) 19:06:39 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)) 19:06:39 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)) 19:06:39 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)) 19:06:39 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)) 19:06:39 INFO - Cleaning up... 19:06:39 INFO - Return code: 0 19:06:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:06:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:06:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:06:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:06:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:06:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:06:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:06:39 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 0xee4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11a5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a33b0>, '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 0x11a42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11a4740>, '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': '17051fcd5208b27b50bedfeb000001dd-1468715614.628599-2027855988', '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 19:06:39 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 19:06:39 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 19:06:39 INFO - Using env: {'DISPLAY': ':0', 19:06:39 INFO - 'HOME': '/home/cltbld', 19:06:39 INFO - 'LANG': 'en_US.UTF-8', 19:06:39 INFO - 'LANGUAGE': 'en_US:en', 19:06:39 INFO - 'LOGNAME': 'cltbld', 19:06:39 INFO - 'MAIL': '/var/mail/cltbld', 19:06:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:06:39 INFO - 'MOZ_NO_REMOTE': '1', 19:06:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:06:39 INFO - 'NO_EM_RESTART': '1', 19:06:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:06:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:06:39 INFO - 'PWD': '/builds/slave/test', 19:06:39 INFO - 'SHELL': '/bin/bash', 19:06:39 INFO - 'SHLVL': '1', 19:06:39 INFO - 'TERM': 'linux', 19:06:39 INFO - 'TMOUT': '86400', 19:06:39 INFO - 'USER': 'cltbld', 19:06:39 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1468715614.628599-2027855988', 19:06:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:06:39 INFO - '_': '/tools/buildbot/bin/python'} 19:06:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:06:39 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:06:39 INFO - Cleaning up... 19:06:40 INFO - Return code: 0 19:06:40 INFO - Running post-action listener: _resource_record_post_action 19:06:40 INFO - Running post-action listener: _start_resource_monitoring 19:06:40 INFO - Starting resource monitoring. 19:06:40 INFO - ##### 19:06:40 INFO - ##### Finished create-virtualenv step (success) 19:06:40 INFO - ##### 19:06:40 INFO - ##### 19:06:40 INFO - ##### Running install step. 19:06:40 INFO - ##### 19:06:40 INFO - Running pre-action listener: _resource_record_pre_action 19:06:40 INFO - Running main action method: install 19:06:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:06:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:06:40 INFO - Reading from file tmpfile_stdout 19:06:40 INFO - Detecting whether we're running mozinstall >=1.0... 19:06:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:06:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:06:40 INFO - Reading from file tmpfile_stdout 19:06:40 INFO - Output received: 19:06:40 INFO - Usage: mozinstall [options] installer 19:06:40 INFO - Options: 19:06:40 INFO - -h, --help show this help message and exit 19:06:40 INFO - -d DEST, --destination=DEST 19:06:40 INFO - Directory to install application into. [default: 19:06:40 INFO - "/builds/slave/test"] 19:06:40 INFO - --app=APP Application being installed. [default: firefox] 19:06:40 INFO - mkdir: /builds/slave/test/build/application 19:06:40 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'] 19:06:40 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 19:06:57 INFO - Reading from file tmpfile_stdout 19:06:57 INFO - Output received: 19:06:57 INFO - /builds/slave/test/build/application/firefox/firefox 19:06:57 INFO - Running post-action listener: _resource_record_post_action 19:06:57 INFO - ##### 19:06:57 INFO - ##### Finished install step (success) 19:06:57 INFO - ##### 19:06:57 INFO - ##### 19:06:57 INFO - ##### Running run-tests step. 19:06:57 INFO - ##### 19:06:57 INFO - Running pre-action listener: _resource_record_pre_action 19:06:57 INFO - Running main action method: run_tests 19:06:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:06:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:06:57 INFO - Python 2.7.3 19:06:57 INFO - Return code: 0 19:06:57 INFO - grabbing minidump binary from tooltool 19:06: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')]} 19:06:57 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 0x11a33b0>, '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 0x11a42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11a4740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:06:57 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 19:06:57 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 19:06:57 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 19:06:57 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:06:57 INFO - Return code: 0 19:06:57 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:06:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:06:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:06:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:06:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:06:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bAQxJ7egSL-ZHBPBzqsC3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 19:06:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bAQxJ7egSL-ZHBPBzqsC3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-009 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 19:06:57 INFO - Using env: {'DISPLAY': ':0', 19:06:57 INFO - 'HOME': '/home/cltbld', 19:06:57 INFO - 'LANG': 'en_US.UTF-8', 19:06:57 INFO - 'LANGUAGE': 'en_US:en', 19:06:57 INFO - 'LOGNAME': 'cltbld', 19:06:57 INFO - 'MAIL': '/var/mail/cltbld', 19:06:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:06:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:06:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:06:57 INFO - 'MOZ_NO_REMOTE': '1', 19:06:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:06:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:06:57 INFO - 'NO_EM_RESTART': '1', 19:06:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:06:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:06:57 INFO - 'PWD': '/builds/slave/test', 19:06:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:06:57 INFO - 'SHELL': '/bin/bash', 19:06:57 INFO - 'SHLVL': '1', 19:06:57 INFO - 'TERM': 'linux', 19:06:57 INFO - 'TMOUT': '86400', 19:06:57 INFO - 'USER': 'cltbld', 19:06:57 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1468715614.628599-2027855988', 19:06:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:06:57 INFO - '_': '/tools/buildbot/bin/python'} 19:06:57 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bAQxJ7egSL-ZHBPBzqsC3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 19:06:57 INFO - mozversion application_buildid: 20160716163003 19:06:57 INFO - mozversion application_changeset: e816e9199940ce2b4cbace056b9a849048bf4a63 19:06:57 INFO - mozversion application_display_name: Nightly 19:06:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:06:57 INFO - mozversion application_name: Firefox 19:06:57 INFO - mozversion application_remotingname: firefox 19:06:57 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 19:06:57 INFO - mozversion application_vendor: Mozilla 19:06:57 INFO - mozversion application_version: 50.0a1 19:06:57 INFO - mozversion platform_buildid: 20160716163003 19:06:57 INFO - mozversion platform_changeset: e816e9199940ce2b4cbace056b9a849048bf4a63 19:06:57 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 19:06:57 INFO - mozversion platform_version: 50.0a1 19:06:57 INFO - using testdate: 1468721217 19:06:57 INFO - actual date: 1468721217 19:06:57 INFO - starting webserver on 'localhost:36461' 19:06:57 INFO - SUITE-START | Running 2 tests 19:06:57 INFO - TEST-START | dromaeo_css 19:06:57 INFO - operating with platform_type : linux_ 19:06:57 INFO - Initialising browser for dromaeo_css test... 19:06:57 INFO - TEST-INFO | started process 3241 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmputt5yx/profile http://localhost:36461/getInfo.html) 19:07:01 INFO - PROCESS | 3241 | JavaScript error: , line 0: uncaught exception: undefined 19:07:01 INFO - PROCESS | 3241 | __metrics Screen width/height:1600/1200 19:07:01 INFO - PROCESS | 3241 | colorDepth:24 19:07:01 INFO - PROCESS | 3241 | Browser inner width/height: 1024/697 19:07:01 INFO - PROCESS | 3241 | __metrics 19:07:02 INFO - PROCESS | 3241 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 19:07:02 INFO - PROCESS | 3241 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:07:03 INFO - TEST-INFO | 3241: exit 0 19:07:03 INFO - Browser initialized. 19:07:03 INFO - Running cycle 1/1 for dromaeo_css test... 19:07:03 INFO - TEST-INFO | started process 3322 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmputt5yx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:07:15 INFO - PROCESS | 3322 | RSS: Main: 157753344 19:07:15 INFO - PROCESS | 3322 | 19:08:07 INFO - PROCESS | 3322 | 1468721287119 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] 19:10:14 INFO - PROCESS | 3322 | Cycle 1(1): loaded http://localhost:36461/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36461/tests/dromaeo/cssquery-ext.html) 19:10:15 INFO - PROCESS | 3322 | RSS: Main: 249372672 19:10:15 INFO - PROCESS | 3322 | 19:13:18 INFO - PROCESS | 3322 | Cycle 1(1): loaded http://localhost:36461/tests/dromaeo/cssquery-ext.html (next: http://localhost:36461/tests/dromaeo/cssquery-jquery.html) 19:13:18 INFO - PROCESS | 3322 | RSS: Main: 251559936 19:13:18 INFO - PROCESS | 3322 | 19:16:20 INFO - PROCESS | 3322 | Cycle 1(1): loaded http://localhost:36461/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36461/tests/dromaeo/cssquery-mootools.html) 19:16:21 INFO - PROCESS | 3322 | RSS: Main: 253673472 19:16:21 INFO - PROCESS | 3322 | 19:19:23 INFO - PROCESS | 3322 | Cycle 1(1): loaded http://localhost:36461/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36461/tests/dromaeo/cssquery-prototype.html) 19:19:24 INFO - PROCESS | 3322 | RSS: Main: 245575680 19:19:24 INFO - PROCESS | 3322 | 19:22:26 INFO - PROCESS | 3322 | Cycle 1(1): loaded http://localhost:36461/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36461/tests/dromaeo/cssquery-yui.html) 19:22:27 INFO - PROCESS | 3322 | RSS: Main: 230940672 19:22:27 INFO - PROCESS | 3322 | 19:25:30 INFO - PROCESS | 3322 | Cycle 1(1): loaded http://localhost:36461/tests/dromaeo/cssquery-yui.html (next: http://localhost:36461/tests/dromaeo/cssquery-dojo.html) 19:25:30 INFO - PROCESS | 3322 | RSS: Main: 285241344 19:25:30 INFO - PROCESS | 3322 | 19:25:30 INFO - PROCESS | 3322 | __start_tp_report 19:25:30 INFO - PROCESS | 3322 | _x_x_mozilla_page_load 19:25:30 INFO - PROCESS | 3322 | _x_x_mozilla_page_load_details 19:25:30 INFO - PROCESS | 3322 | |i|pagename|runs| 19:25:30 INFO - PROCESS | 3322 | |0;dojo.html;3043.315254067835;3047.466693328667;3074.6925307469255;3100.0699790062977;3119.25137966888;5241.266222728821;5255.054090263751;5314.016906872226;5403.459654034595;5438.184272359148;5378.973105134479;5408.864778380543;5416.972915135429;5424.050791111559;5449.56403487721;4833.7341446220535;4901.289313049606;4930.211166213407;4943.431505376874;5125.871853203663;5021.548060674539;5032.396112466509;5067.6452648314635;5089.694618322913;5100.464451232623;4809.0862736080035;4859.73271470069;4902.166631672606;4976.925346119811;4978.576820970222;4859.781309841065;4869.245266983623;4876.097921884463;4937.629677774145;4969.726665033421;4884.072026314989;4903.362562866804;4906.730129842857;4910.288008238821;4963.40439147301;5217;5333.57331413486;5356.4375740547075;5366.382865970385;5371.086915224421;5784;5836.64980101191;5841.474267315962;5852.414758524156;5854;5830.183774271605;5862.736176872051;5891.351951285355;5914.97042514789;5916.497097746696;5245.842624721265;5336.226247194135;5339.012282727708;5362.981033603642;5454.127339625641;5893.322267939242;5910.852228694231;5923.851903702442;5925.140854576062;5927.2590926134235;5554.389017208104;5706.771729130871;5734.111212762028;5736.225609542742;5739.7704091836695;5732.426757324234;5756.050251708505;5787.826365209051;5857.062869940874;5857.794977175864;5784.739686714024;5791.362950075489;5792.044312688359;5794.768209271582;5830.737616807254;5603.579731520071;5735.168400581976;5745.1382292656435;5789.073748200268;5807.796727114531;4405.29515277554;4426.845060422934;4435.733855968588;4469.955300447019;4472.753998530047;3933.1740334529495;3959.544652364957;3962.980185099056;3969.4442778011103;4005.439238506611;5330.120530112566;5429;5471.5896307777075;5548.306461692288;5590.24531688225;5825.766969321265;5876.559258055578;5889.499392551681;5893;5944.256967879015;5551.528120109836;5561.638493497991;5565;5570.749316280777;5572.247746554244;4938.135826230396;5011.047900898818;5025.346704928409;5038;5043.36957880265;6050.788222412194;6058.1518587397795;6064.3935606439;6066.66633335162;6101.877962440726;5913.497352725067;5914.290285165807;5914.7338369774325;5917.970410147922;5918.881622367442;5851.1515830205235;5932;5953.047512397996;5981.581289309706;6021.518278537794;5733.31200255972;5778.479936805539;5784.537237021113;5792.739326730223;5794.362620111869;5885.146653735099;5899.46904778572;5901.262342207224;5902.586818922806;5913.231279933581;5480.205370221216;5628;5653.660780353192;5698.373178950229;5729.3124825019595;5721.056025755704;5730.799422020209;5733.054046082517;5735.139729040678;5742;5410.972945135407;5660.264165658438;5662.433756624469;5679.659220446786;5680.346760122474;5692.601517893873;5740.167675687086;5744.770209191585;5824.475797178275;5830.912536311874;5585.413531579125;5621.606487545832;5630.74661640219;5634.126710359901;5643.407442218672 19:25:30 INFO - PROCESS | 3322 | |1;ext.html;603.471962033221;639.5523133806337;653.6045692356124;666.1273731411848;673.252689514639;46464.76767616165;48974.26538601924;48990.510094899044;49085.50914490854;49107;46537.534624653745;46981.530184698146;46985.765071174596;47041.29438058432;47053.529464705425;8997.280217582611;9133.588988495501;9140.085991400872;9141.862872056925;9144.222741066984;8992.595333209989;9099.818003639923;9103.135202155818;9104.226140778042;9107.40801847881;9158.084191580821;9185.770355741126;9186.173244408003;9195.172434480895;9204.493752843591;9087.363884528086;9129.224015958618;9141.54292285383;9156.038615945296;9167.358284920025;9000.909990900072;9044.81910361789;9067.591958361889;9076;9084.68203612877;45079;45197.32204016909;45278.32082518765;45402.31896521555;45405.54594454046;3443.27691184849;3543.6633519815578;3679.6688298053305;3783.4135708965155;4196.328587426027;35103.648963510546;35240;35417.645823541694;35446;37027.81486092552;4499.482559505666;4541.886452838672;4648.953510464886;4655.208614535537;4701.952980470186;364737;366903;367646;368712;369851;62586;62606.37393626096;62736.37263627305;63035.369646303865;63133.36866631367;65877.34122658808;65887;65894;65913;66001;17376.21807018662;17420.47738567845;17548.38580649671;17599.38402155944;17608.82391176072;13418;13431;13502.729945401037;13506.189628622315;13568.253746043865;16255.431059912846;18238.63522729538;18378.172982215834;18400.723989140173;18501.44495665132;5470.261514695545;6309.652969086745;6365.49076073913;6444.806655800334;6684.331566843277;1027.4605831938293;1151.8329842172839;1168.0071938851909;1173.935433551163;1202.3287630194038;33770.831145844604;33890.32219355599;34058.82970585181;34243.82878085594;34485.48271775925;1123.741539445932;1137.3289759042204;1178.7996040673106;1202.074402709926;1208.178438661701;17290.394836180923;17772.46682599524;17969;17975.022747497766;18041.368552100612;567821;571113;572458;572930;573862;60844;62514.374856251765;62590.687046565385;62686.686566566874;62754.68622656949;1246.464020471188;1276.7829468990294;1291.5866922584682;1390.2631605249235;1402.2918426194706;24443;37230;37601.97343831716;37875.242495150495;37880.810595946845;58690;59252.70373648104;59278;59311.70344148424;59347.40652593419;531392;543895;544521;544867;545592;28297;29360;29617.25956851096;44085;44629.33056004097;50209.74895125501;51100.74449627728;51327.230091547906;51924.22113668222;52059.479405205464;43595.78202108969;43883.78058109689;44007;44427.33358999553;45500.772496138634;44307.55692443034;44923;45200.547994519635;46549.53450465587;46852.7657361711;43214.78392608017;43837.12325753403;43998.78000610104;44422.55577444184;44855.32717009313;38418.615813841505;38895.6110438892;39200.80399597984;39807.40288895611;40122.79938600288;29575.85212074012;29607;30061.398772024873;30195;30289.848550757106 19:25:30 INFO - PROCESS | 3322 | |2;jquery.html;381.7194362143822;392.23122679548084;404.40350483037525;413.9648129908958;420.5941266677655;11691.473883675233;13567.737845988368;20134;20163.798362016376;20219.090140943656;21205;21473.67789483155;21679.132834686592;21935.341939741793;21954.121835126614;6447.54867159299;6453.677316134198;6470.320616335288;6568.474522038226;6633.237177724551;6499.545031847772;6506.024096385557;6509.1863517060365;6528.6409247491365;6541.967290163567;6985.755498557552;7326.157491888421;7327.194008659043;7410.407167426593;7419.183889772121;7179.964100179492;7403.74086906961;7409.296116868889;7415.443841711839;7416.184219735852;7163.391111755507;7449.180590135081;7453.664585093629;7463.477556571042;7465.104187497535;25739.61390579143;26406.207813765617;27425.86287068572;27590.5861412079;28299.292517687016;2596.376869551313;2696.3933115049153;2698.3793727442603;2824.477471667748;2938.4857649911396;15584.532464026097;15832.28754706041;15960.840391596052;16004.839951600568;16166.75749863753;2101.338078505266;2130.1692339987417;2151;2181.345596321097;2247.9100835966706;76329.61835190844;79444;80477.59761201157;91843.54078229633;98148;18103.275868965356;18404.723929141073;18519.44441666752;18679.159437825332;18951.336703215322;33104.66895331064;33323.16692082717;33329.33341333208;33410.16474588106;33423.498647520304;9377.812443751087;9442.38624489406;9881.209503239723;9889.143234138692;10090.596376144871;8198.877016844752;8285.710000149966;8318.500889946623;8397.370197235232;8461.40770146084;9045.728628141167;9085.545722713838;9244.8613270801;9257.398269112486;9287.396319239228;3262.755293353008;3401.4387626041425;3567.6075631680496;3576.588692300367;3622.130688634709;868.3485941615492;964.0696727657844;992.454150217392;1001.5843424978698;1070.5985255529176;19857.205711771367;20439.386818395473;20592.382228533166;20709.792902071087;20720.689189662167;953.2135987810084;964.8408012677829;978.9706308810747;991.4745185051934;992.5186284651938;8778.517181555077;11333.206675532798;11449.198556101159;11566.710832229262;11633.243839150427;485507;492271;498897;500553;503545;90856;93050.53474732583;94899.52550237342;95141;97844;993.7813680990171;1003.6687892995294;1016.2378216337598;1020.8672872526524;1021.6577446555488;17451.38920137789;17964.19161137778;18329.26682932721;18416.631667366844;18516.72224916654;41798.791006044776;42759.7862010688;42946;43348.56651433445;44112.117757644024;57796;59508.107378390225;59763.40236597752;60116;61275.387246128754;7800.1419843816;8079.515229086273;8108.554029528196;8174.713885013996;9202.861957070783;12036.217645852992;13774;14149.575512734635;14333.713325733635;14573.198474084027;12180.330081845583;12277.447514862031;12387.75224495487;12406.317652529198;12637.304948227937;11674.533018679158;12057.336846473529;12276.386180691108;12278.570250041206;12406.317652529198;12271.75456490883;12299.815502767287;12341.444634991627;12462.875371246171;12498.437570309175;8642.78393040179;9070.863937041082;9103.135202155785;9288.95355523245;9340.673076442292;11690.88309116898;12113.273203607812;12211.450484728031;12232.755344892874;12455.190412623151 19:25:30 INFO - PROCESS | 3322 | |3;mootools.html;1360.761866673332;1434.1036851967517;1508.8340282568915;1632.8448797364254;1787.8748487605874;8574.271186949109;8892.466452012868;8906.198442140214;8909.242714369278;9185.862212066824;8585.527795971235;8899.866502002475;9106.499142547158;9113.726588202348;9113.863292050608;2379.4170428245106;2421.8667973261554;2423.1397853761923;2423.321469988406;2424.442378253003;2417.721961974378;2430.8541487510806;2463.7289898111194;2465.469923966347;2474.418511649761;2418.3591348292716;2422.1522467136538;2444.633305004255;2450.1669432392982;2450.4486490539666;2373.738888722239;2381.940451488709;2398.0887262840097;2399.892004859777;2406.831521793475;2350.5063936573342;2380.976190238093;2382.463945612241;2384.1655420602824;2388.379021454417;8881.06748791374;8967.865482017774;8981.595828187747;8983.730488085368;9008.324375671851;5433.673979561199;5526.143447765603;5538.501534861882;5546.944530554683;5566.471185237396;3534.7525673202886;3581.1405262737017;3621.5110960020324;3625.9456108158397;3642.1805093853673;1212.2968678166642;1231.9815202771965;1232.2421710647977;1242.3415589737454;1246.6883279180206;12509.812352814715;12691.873081269161;12719.046071544579;12720.491180352867;12811.743765124738;4814.8796280093275;4826.95173048272;4866.878328041827;4922.852314430573;5000.874978125576;10801.78396432067;10845.186611004206;10847.240693151562;10847.945760271148;10860.13118950482;5492.47821456961;5501.119820828648;5502.312210973629;5503.394626591072;5507.504324610724;4366.235908715962;4485.775711214426;4626.1210370029585;5026.723530205801;5060.7722652480725;4109.732867363612;4160.602432978808;4198.9370159447635;4200.833981764138;4218.451601291812;1321.1148530484597;1344.6235054184845;1344.7982802579495;1359.1029920252586;1364.2564802182835;1034.7723500829804;1035.2080658296409;1037.9636712715019;1043.108142538119;1047.4762618690654;6249.593776404519;6441.130447389636;6444.742210311535;6474.967625161844;6557.934420655828;1021.923355748307;1024.36489376587;1025.610268098118;1038.776663017455;1046.817096680761;4371.69398142127;4458.308962110878;4493.631113283333;4578.88552786183;4627.074585082997;11293.435328233556;11701.707457313636;11757.118216133824;11771.293722376684;11772.882271177179;10857.837132443019;11229.831552526719;11237;11253.66239012831;11603.709907252387;8395.454295470774;8453.492790432594;8472.19514146155;8536.8719469208;8804.955975220211;6335.3981371769605;6438.420542151229;6570.8357291068105;6599.769008084694;6607.669616519059;10464.476776161313;10883.074938630305;10903.073238774792;10907.509162087883;10911;9946.602135914773;10171.23715721309;11087.39019353911;11107.500162492868;11186.04918581897;7586.544807311579;8194.467359621605;8741.213290803858;8811.691590794291;9037.77405564866;8947.328950328621;8998;9017.90982090197;9019.594118264826;9034.367594268339;7695.6536955836;7844.4901081429525;7949.92050079515;8055.7583272501915;8189.303909167787;7294.452916031213;7360.484766066324;7835.216478352119;7956.323712484504;8059.717909873127;7405.333519983227;7505.774826755206;7531.661075251736;7592.8861067082935;7597.810054748676;5184.170532714747;5236.633435659467;5468.644538105011;5472.480114389126;5482.259894914136;5371.650842695212;5452.100403433389;5506.366767821592;5633.774649014157;5672.829815105553 19:25:30 INFO - PROCESS | 3322 | |4;prototype.html;333.1787144688343;336.8383176075484;339.0692548953124;341.5986216195969;343.9157406435423;5286.629935904488;5301.575873930086;5311.92032119518;5312.840614781558;5327.547158491533;5257.158854583267;5294.549963253128;5295.920561191585;5299.125644268691;5309.433717053469;3945.4081887716857;4016.417619445179;4143.647789937859;4170.374443833419;4175.248455278049;4115.8765237042935;4119.526254480728;4133.318002529579;4154.4183814266025;4162.250794856925;3923.784191869446;4089.141280331119;4108;4116.608922152405;4136.614234231536;3997.3004724173297;4021.7532564904973;4041.4746083009313;4175.478065241845;4196.706230563862;3628.8569100733184;3676.455888526825;3705.74059815813;3724.9627503724887;3732.64539868712;5110.5400513953555;5120.513551212629;5122.206058061007;5125.897482050338;5139.17773156297;4486.573775491323;4712.269598212282;4713.481517033124;4720.905581888377;4748.382710247645;5493.571671365474;5500.092484740013;5534.142207957773;5537.889242215173;5548.972255138739;3967.8016099194924;3974.880753577397;4002.779847108408;4007.0984028593334;4012.678985681168;5535.640183388067;5696.971515142439;5697.344805347397;5721.77112915487;5732.684702341369;4038.4749982502085;4048.716589838683;4053.5541090480024;4059.2490389278078;4059.573744756817;4078.9184216315507;4086.2440448516527;4087.9182416351505;4137.358709400048;4140.3375459926265;4553.203189441834;4638.605718513964;4646.558576935186;4691.366665500182;4704.976475117603;5453.3639908027435;5477.780888764405;5491.807786727445;5498.395176530578;5548.500634942875;1410.4146779086768;1416.1361569442631;1429.9142051476945;1431.119861285302;1433.3621538415305;891.839468895605;901.1394118616705;910.6749679216724;910.7677542226689;914.5838643417229;4692.929606055912;4700.271457924027;4713.2458806590785;4751.857444276678;4777.546133117348;5007.273945277914;5023.262322034427;5060.316857224301;5060.924086138711;5151.819686311036;4576.970181709089;4700.9059818803435;4710.952890471051;4748.884012257116;4845.733484658378;2658.5480468320434;2675.7557735653013;2678.5982102684366;2698.7706044986003;2700.041485272739;5106.310648062464;5132.563732082815;5155.149400348975;5155.9742201288755;5161.509656582619;4916.410030796327;5092.541671249605;5107.084843183806;5113.693178409308;5167.9224811627855;5092.567131793839;5113.900511389995;5119.795208191631;5121.334226550524;5152.355955505562;4994.026164897955;5002.5987525987;5020.648554601289;5023.6985780853265;5042.621803364689;4729.739864307496;4890.388696443071;4927.2754535912145;5068.163752980864;5096.872578185575;5205.531502164823;5218.6868787872845;5221.295125158207;5223.817166399158;5239.69007748063;3671.5227020487164;3703.240835628636;3718.3121122592406;3718.665320121202;3731.869384571527;4793.472718000948;4981.302617633607;5062.645614806928;5081.288619593186;5400.432954539874;5330.547947943989;5548.781706610237;5549.556035517229;5570.468121266684;5580.414056524007;5512.586556008396;5528.668279903219;5530.308711411074;5546.611737178358;5583.637063590853;5188.533032027136;5424.620276580601;5442.156465747816;5470;5472.315960504937;5528.226048353154;5548.723793527592;5570.972145139248;5577.470140336662;5578.2748242728185;5430.805222850967;5446.346438427414;5472.589555783412;5489.584582783563;5498.937898288142 19:25:30 INFO - PROCESS | 3322 | |5;yui.html;731.7694926098279;779.5829231361223;779.5829231361223;820.147047071046;826.5825757992213;14362.569122926316;14580.927095364521;14730.263486825643;15447.922760386182;15477.226138693062;13944.790828137586;14117.71764564708;14124;14128.15231086133;14128.505502307422;674.4334758802605;812.10262659761;833.6373677450298;840.277361469136;842.4608250719544;802.1336956087441;838.5220424358118;838.7861095420659;839.4291881520563;840.2647683277132;874.2437791310534;874.2787200559532;875.7329014650529;876.5047748022379;879.5734068976541;689.4381079420257;821.7288294862681;870.83889480446;875.2035647560721;875.6497401039571;631.9431251187415;632.0929466215995;632.610944269271;632.8196464007735;634.4543692424511;14909.776353354708;14911.925440372837;14913.552593422215;14946.252687365697;14948.177850218233;14000.22998735069;14119.647008824759;14395.640108997253;14705.926470367687;15113.54659360221;13476.932615336958;13580.728385432334;13683.24742139182;13959.79060314096;14123.858761412357;4585.770711464414;4613.515580863995;4631.258998560214;4788.018456216468;4801.879953001168;80130.59934700347;80497.19502804955;80503.19496805074;87231.56384218039;87600;10769.62306319275;10839.945800270949;10859.78280434387;10911.890881091247;10933.507992140372;19741;19745.901270493556;19777.802221977883;19802.20791168337;19861.404157874997;8387.119352468026;8550.871736923951;8583.313334933315;8599.484030958163;8662.78343041429;4363.170997510463;4487.977560112244;4492.573205545468;4524.683272170916;4527.207738645724;3355.4631258998443;3572.3034008368118;3580.337637537064;3582.6775590196485;3584.605693373727;601.7923816283375;605.2555356911024;612.5773216480615;616.654673382907;624.2758400255682;559.9944000560024;621.3444815719369;627.9529035322369;650.1710319342781;682.2374604058621;9701.223902087957;9759.170470510086;9944;10036.792932566343;10199.337043092324;583.3961849485762;613.5061275673125;673.4444083631024;678.5589366911448;714.3570786292274;4691.249400095969;4888.633352498506;4905;4963.975180124076;5001.199808030698;123834.38082809528;128582;132712;133076;137050.31474842562;110194;112602.43698781454;112674.43662781798;113200;114732;60070.69964650149;60242.69878650579;60769.39230607637;96153;97832.51083744536;9056.230220431074;9163.35856490066;9177.724668259963;9218.723438296862;9229.630814767603;56857.43142568687;57338.7133064332;57586.7120664394;57821;59075.409245906994;81797;83991;84486.57756711177;84785.92164367429;90087;11664.6500604982;11773.646790596296;11777.293362398283;11908.76182476363;11981.700457488632;13388.330583470983;13591.592252232449;13666.385012674653;13673.31633418345;13717.588472345846;12592.866642001898;12674.809877852023;12724.745505090032;12990.610281691565;13126.671833203864;11961.461734221806;11963.342016189194;12063.707895499827;12212.938935305267;12370.195937264049;12372.319522425993;12725.61823145307;13083.869161308265;13147.408366623717;13164.736705266032;10457.42484163348;10656.094231990368;10815.242932994615;10927.421755611667;11211.943940280247;9299.535023248674;9374.859377109213;9860.950695246478;10416.166706663296;10463.676902656345 19:25:30 INFO - PROCESS | 3322 | __end_tp_report 19:25:30 INFO - PROCESS | 3322 | __start_cc_report 19:25:30 INFO - PROCESS | 3322 | _x_x_mozilla_cycle_collect,777 19:25:30 INFO - PROCESS | 3322 | __end_cc_report 19:25:30 INFO - PROCESS | 3322 | __startTimestamp1468722330266__endTimestamp 19:25:30 INFO - PROCESS | 3322 | 19:25:30 INFO - PROCESS | 3322 | ------- Summary: start ------- 19:25:30 INFO - PROCESS | 3322 | Number of tests: 6 19:25:30 INFO - PROCESS | 3322 | 19:25:30 INFO - PROCESS | 3322 | [#0] dojo.html Cycles:165 Average:5400.66 Median:5630.75 stddev:628.25 (11.2%) stddev-sans-first:602.34 19:25:30 INFO - PROCESS | 3322 | Values: 3043.3 3047.5 3074.7 3100.1 3119.3 5241.3 5255.1 5314.0 5403.5 5438.2 5379.0 5408.9 5417.0 5424.1 5449.6 4833.7 4901.3 4930.2 4943.4 5125.9 5021.5 5032.4 5067.6 5089.7 5100.5 4809.1 4859.7 4902.2 4976.9 4978.6 4859.8 4869.2 4876.1 4937.6 4969.7 4884.1 4903.4 4906.7 4910.3 4963.4 5217.0 5333.6 5356.4 5366.4 5371.1 5784.0 5836.6 5841.5 5852.4 5854.0 5830.2 5862.7 5891.4 5915.0 5916.5 5245.8 5336.2 5339.0 5363.0 5454.1 5893.3 5910.9 5923.9 5925.1 5927.3 5554.4 5706.8 5734.1 5736.2 5739.8 5732.4 5756.1 5787.8 5857.1 5857.8 5784.7 5791.4 5792.0 5794.8 5830.7 5603.6 5735.2 5745.1 5789.1 5807.8 4405.3 4426.8 4435.7 4470.0 4472.8 3933.2 3959.5 3963.0 3969.4 4005.4 5330.1 5429.0 5471.6 5548.3 5590.2 5825.8 5876.6 5889.5 5893.0 5944.3 5551.5 5561.6 5565.0 5570.7 5572.2 4938.1 5011.0 5025.3 5038.0 5043.4 6050.8 6058.2 6064.4 6066.7 6101.9 5913.5 5914.3 5914.7 5918.0 5918.9 5851.2 5932.0 5953.0 5981.6 6021.5 5733.3 5778.5 5784.5 5792.7 5794.4 5885.1 5899.5 5901.3 5902.6 5913.2 5480.2 5628.0 5653.7 5698.4 5729.3 5721.1 5730.8 5733.1 5735.1 5742.0 5411.0 5660.3 5662.4 5679.7 5680.3 5692.6 5740.2 5744.8 5824.5 5830.9 5585.4 5621.6 5630.7 5634.1 5643.4 19:25:30 INFO - PROCESS | 3322 | 19:25:30 INFO - PROCESS | 3322 | [#1] ext.html Cycles:180 Average:66605.21 Median:45340.32 stddev:133283.58 (294.0%) stddev-sans-first:133565.35 19:25:30 INFO - PROCESS | 3322 | Values: 603.5 639.6 653.6 666.1 673.3 46464.8 48974.3 48990.5 49085.5 49107.0 46537.5 46981.5 46985.8 47041.3 47053.5 8997.3 9133.6 9140.1 9141.9 9144.2 8992.6 9099.8 9103.1 9104.2 9107.4 9158.1 9185.8 9186.2 9195.2 9204.5 9087.4 9129.2 9141.5 9156.0 9167.4 9000.9 9044.8 9067.6 9076.0 9084.7 45079.0 45197.3 45278.3 45402.3 45405.5 3443.3 3543.7 3679.7 3783.4 4196.3 35103.6 35240.0 35417.6 35446.0 37027.8 4499.5 4541.9 4649.0 4655.2 4702.0 364737.0 366903.0 367646.0 368712.0 369851.0 62586.0 62606.4 62736.4 63035.4 63133.4 65877.3 65887.0 65894.0 65913.0 66001.0 17376.2 17420.5 17548.4 17599.4 17608.8 13418.0 13431.0 13502.7 13506.2 13568.3 16255.4 18238.6 18378.2 18400.7 18501.4 5470.3 6309.7 6365.5 6444.8 6684.3 1027.5 1151.8 1168.0 1173.9 1202.3 33770.8 33890.3 34058.8 34243.8 34485.5 1123.7 1137.3 1178.8 1202.1 1208.2 17290.4 17772.5 17969.0 17975.0 18041.4 567821.0 571113.0 572458.0 572930.0 573862.0 60844.0 62514.4 62590.7 62686.7 62754.7 1246.5 1276.8 1291.6 1390.3 1402.3 24443.0 37230.0 37602.0 37875.2 37880.8 58690.0 59252.7 59278.0 59311.7 59347.4 531392.0 543895.0 544521.0 544867.0 545592.0 28297.0 29360.0 29617.3 44085.0 44629.3 50209.7 51100.7 51327.2 51924.2 52059.5 43595.8 43883.8 44007.0 44427.3 45500.8 44307.6 44923.0 45200.5 46549.5 46852.8 43214.8 43837.1 43998.8 44422.6 44855.3 38418.6 38895.6 39200.8 39807.4 40122.8 29575.9 29607.0 30061.4 30195.0 30289.8 19:25:30 INFO - PROCESS | 3322 | 19:25:30 INFO - PROCESS | 3322 | [#2] jquery.html Cycles:180 Average:30998.14 Median:2001.93 stddev:81678.01 (4080.0%) stddev-sans-first:81874.79 19:25:30 INFO - PROCESS | 3322 | Values: 381.7 392.2 404.4 414.0 420.6 11691.5 13567.7 20134.0 20163.8 20219.1 21205.0 21473.7 21679.1 21935.3 21954.1 6447.5 6453.7 6470.3 6568.5 6633.2 6499.5 6506.0 6509.2 6528.6 6542.0 6985.8 7326.2 7327.2 7410.4 7419.2 7180.0 7403.7 7409.3 7415.4 7416.2 7163.4 7449.2 7453.7 7463.5 7465.1 25739.6 26406.2 27425.9 27590.6 28299.3 2596.4 2696.4 2698.4 2824.5 2938.5 15584.5 15832.3 15960.8 16004.8 16166.8 2101.3 2130.2 2151.0 2181.3 2247.9 76329.6 79444.0 80477.6 91843.5 98148.0 18103.3 18404.7 18519.4 18679.2 18951.3 33104.7 33323.2 33329.3 33410.2 33423.5 9377.8 9442.4 9881.2 9889.1 10090.6 8198.9 8285.7 8318.5 8397.4 8461.4 9045.7 9085.5 9244.9 9257.4 9287.4 3262.8 3401.4 3567.6 3576.6 3622.1 868.3 964.1 992.5 1001.6 1070.6 19857.2 20439.4 20592.4 20709.8 20720.7 953.2 964.8 979.0 991.5 992.5 8778.5 11333.2 11449.2 11566.7 11633.2 485507.0 492271.0 498897.0 500553.0 503545.0 90856.0 93050.5 94899.5 95141.0 97844.0 993.8 1003.7 1016.2 1020.9 1021.7 17451.4 17964.2 18329.3 18416.6 18516.7 41798.8 42759.8 42946.0 43348.6 44112.1 57796.0 59508.1 59763.4 60116.0 61275.4 7800.1 8079.5 8108.6 8174.7 9202.9 12036.2 13774.0 14149.6 14333.7 14573.2 12180.3 12277.4 12387.8 12406.3 12637.3 11674.5 12057.3 12276.4 12278.6 12406.3 12271.8 12299.8 12341.4 12462.9 12498.4 8642.8 9070.9 9103.1 9289.0 9340.7 11690.9 12113.3 12211.5 12232.8 12455.2 19:25:30 INFO - PROCESS | 3322 | 19:25:30 INFO - PROCESS | 3322 | [#3] mootools.html Cycles:180 Average:6082.32 Median:4415.00 stddev:3440.75 (77.9%) stddev-sans-first:3432.10 19:25:30 INFO - PROCESS | 3322 | Values: 1360.8 1434.1 1508.8 1632.8 1787.9 8574.3 8892.5 8906.2 8909.2 9185.9 8585.5 8899.9 9106.5 9113.7 9113.9 2379.4 2421.9 2423.1 2423.3 2424.4 2417.7 2430.9 2463.7 2465.5 2474.4 2418.4 2422.2 2444.6 2450.2 2450.4 2373.7 2381.9 2398.1 2399.9 2406.8 2350.5 2381.0 2382.5 2384.2 2388.4 8881.1 8967.9 8981.6 8983.7 9008.3 5433.7 5526.1 5538.5 5546.9 5566.5 3534.8 3581.1 3621.5 3625.9 3642.2 1212.3 1232.0 1232.2 1242.3 1246.7 12509.8 12691.9 12719.0 12720.5 12811.7 4814.9 4827.0 4866.9 4922.9 5000.9 10801.8 10845.2 10847.2 10847.9 10860.1 5492.5 5501.1 5502.3 5503.4 5507.5 4366.2 4485.8 4626.1 5026.7 5060.8 4109.7 4160.6 4198.9 4200.8 4218.5 1321.1 1344.6 1344.8 1359.1 1364.3 1034.8 1035.2 1038.0 1043.1 1047.5 6249.6 6441.1 6444.7 6475.0 6557.9 1021.9 1024.4 1025.6 1038.8 1046.8 4371.7 4458.3 4493.6 4578.9 4627.1 11293.4 11701.7 11757.1 11771.3 11772.9 10857.8 11229.8 11237.0 11253.7 11603.7 8395.5 8453.5 8472.2 8536.9 8805.0 6335.4 6438.4 6570.8 6599.8 6607.7 10464.5 10883.1 10903.1 10907.5 10911.0 9946.6 10171.2 11087.4 11107.5 11186.0 7586.5 8194.5 8741.2 8811.7 9037.8 8947.3 8998.0 9017.9 9019.6 9034.4 7695.7 7844.5 7949.9 8055.8 8189.3 7294.5 7360.5 7835.2 7956.3 8059.7 7405.3 7505.8 7531.7 7592.9 7597.8 5184.2 5236.6 5468.6 5472.5 5482.3 5371.7 5452.1 5506.4 5633.8 5672.8 19:25:30 INFO - PROCESS | 3322 | 19:25:30 INFO - PROCESS | 3322 | [#4] prototype.html Cycles:180 Average:4461.36 Median:5023.48 stddev:1279.39 (25.5%) stddev-sans-first:1244.89 19:25:30 INFO - PROCESS | 3322 | Values: 333.2 336.8 339.1 341.6 343.9 5286.6 5301.6 5311.9 5312.8 5327.5 5257.2 5294.5 5295.9 5299.1 5309.4 3945.4 4016.4 4143.6 4170.4 4175.2 4115.9 4119.5 4133.3 4154.4 4162.3 3923.8 4089.1 4108.0 4116.6 4136.6 3997.3 4021.8 4041.5 4175.5 4196.7 3628.9 3676.5 3705.7 3725.0 3732.6 5110.5 5120.5 5122.2 5125.9 5139.2 4486.6 4712.3 4713.5 4720.9 4748.4 5493.6 5500.1 5534.1 5537.9 5549.0 3967.8 3974.9 4002.8 4007.1 4012.7 5535.6 5697.0 5697.3 5721.8 5732.7 4038.5 4048.7 4053.6 4059.2 4059.6 4078.9 4086.2 4087.9 4137.4 4140.3 4553.2 4638.6 4646.6 4691.4 4705.0 5453.4 5477.8 5491.8 5498.4 5548.5 1410.4 1416.1 1429.9 1431.1 1433.4 891.8 901.1 910.7 910.8 914.6 4692.9 4700.3 4713.2 4751.9 4777.5 5007.3 5023.3 5060.3 5060.9 5151.8 4577.0 4700.9 4711.0 4748.9 4845.7 2658.5 2675.8 2678.6 2698.8 2700.0 5106.3 5132.6 5155.1 5156.0 5161.5 4916.4 5092.5 5107.1 5113.7 5167.9 5092.6 5113.9 5119.8 5121.3 5152.4 4994.0 5002.6 5020.6 5023.7 5042.6 4729.7 4890.4 4927.3 5068.2 5096.9 5205.5 5218.7 5221.3 5223.8 5239.7 3671.5 3703.2 3718.3 3718.7 3731.9 4793.5 4981.3 5062.6 5081.3 5400.4 5330.5 5548.8 5549.6 5570.5 5580.4 5512.6 5528.7 5530.3 5546.6 5583.6 5188.5 5424.6 5442.2 5470.0 5472.3 5528.2 5548.7 5571.0 5577.5 5578.3 5430.8 5446.3 5472.6 5489.6 5498.9 19:25:30 INFO - PROCESS | 3322 | 19:25:30 INFO - PROCESS | 3322 | [#5] yui.html Cycles:180 Average:21760.25 Median:4622.39 stddev:33094.84 (716.0%) stddev-sans-first:33150.01 19:25:30 INFO - PROCESS | 3322 | Values: 731.8 779.6 779.6 820.1 826.6 14362.6 14580.9 14730.3 15447.9 15477.2 13944.8 14117.7 14124.0 14128.2 14128.5 674.4 812.1 833.6 840.3 842.5 802.1 838.5 838.8 839.4 840.3 874.2 874.3 875.7 876.5 879.6 689.4 821.7 870.8 875.2 875.6 631.9 632.1 632.6 632.8 634.5 14909.8 14911.9 14913.6 14946.3 14948.2 14000.2 14119.6 14395.6 14705.9 15113.5 13476.9 13580.7 13683.2 13959.8 14123.9 4585.8 4613.5 4631.3 4788.0 4801.9 80130.6 80497.2 80503.2 87231.6 87600.0 10769.6 10839.9 10859.8 10911.9 10933.5 19741.0 19745.9 19777.8 19802.2 19861.4 8387.1 8550.9 8583.3 8599.5 8662.8 4363.2 4488.0 4492.6 4524.7 4527.2 3355.5 3572.3 3580.3 3582.7 3584.6 601.8 605.3 612.6 616.7 624.3 560.0 621.3 628.0 650.2 682.2 9701.2 9759.2 9944.0 10036.8 10199.3 583.4 613.5 673.4 678.6 714.4 4691.2 4888.6 4905.0 4964.0 5001.2 123834.4 128582.0 132712.0 133076.0 137050.3 110194.0 112602.4 112674.4 113200.0 114732.0 60070.7 60242.7 60769.4 96153.0 97832.5 9056.2 9163.4 9177.7 9218.7 9229.6 56857.4 57338.7 57586.7 57821.0 59075.4 81797.0 83991.0 84486.6 84785.9 90087.0 11664.7 11773.6 11777.3 11908.8 11981.7 13388.3 13591.6 13666.4 13673.3 13717.6 12592.9 12674.8 12724.7 12990.6 13126.7 11961.5 11963.3 12063.7 12212.9 12370.2 12372.3 12725.6 13083.9 13147.4 13164.7 10457.4 10656.1 10815.2 10927.4 11211.9 9299.5 9374.9 9861.0 10416.2 10463.7 19:25:30 INFO - PROCESS | 3322 | -------- Summary: end -------- 19:25:30 INFO - PROCESS | 3322 | 19:25:31 INFO - TEST-INFO | 3322: exit 0 19:25:31 INFO - TEST-OK | dromaeo_css | took 1113257ms 19:25:31 INFO - TEST-START | kraken 19:25:31 INFO - operating with platform_type : linux_ 19:25:31 INFO - Initialising browser for kraken test... 19:25:31 INFO - TEST-INFO | started process 3517 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYILakE/profile http://localhost:36461/getInfo.html) 19:25:34 INFO - PROCESS | 3517 | JavaScript error: , line 0: uncaught exception: undefined 19:25:35 INFO - PROCESS | 3517 | __metrics Screen width/height:1600/1200 19:25:35 INFO - PROCESS | 3517 | colorDepth:24 19:25:35 INFO - PROCESS | 3517 | Browser inner width/height: 1024/697 19:25:35 INFO - PROCESS | 3517 | __metrics 19:25:35 INFO - PROCESS | 3517 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 19:25:35 INFO - PROCESS | 3517 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:25:36 INFO - TEST-INFO | 3517: exit 0 19:25:36 INFO - Browser initialized. 19:25:36 INFO - Running cycle 1/1 for kraken test... 19:25:36 INFO - TEST-INFO | started process 3605 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYILakE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:25:48 INFO - PROCESS | 3605 | RSS: Main: 157814784 19:25:48 INFO - PROCESS | 3605 | 19:25:51 INFO - PROCESS | 3605 | Cycle 1(1): loaded http://localhost:36461/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36461/tests/kraken/driver.html?testName=audio-beat-detection) 19:25:52 INFO - PROCESS | 3605 | RSS: Main: 216813568 19:25:52 INFO - PROCESS | 3605 | 19:25:54 INFO - PROCESS | 3605 | Cycle 1(1): loaded http://localhost:36461/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36461/tests/kraken/driver.html?testName=audio-dft) 19:25:55 INFO - PROCESS | 3605 | RSS: Main: 199823360 19:25:55 INFO - PROCESS | 3605 | 19:25:58 INFO - PROCESS | 3605 | Cycle 1(1): loaded http://localhost:36461/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36461/tests/kraken/driver.html?testName=audio-fft) 19:25:59 INFO - PROCESS | 3605 | RSS: Main: 270618624 19:25:59 INFO - PROCESS | 3605 | 19:26:01 INFO - PROCESS | 3605 | Cycle 1(1): loaded http://localhost:36461/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36461/tests/kraken/driver.html?testName=audio-oscillator) 19:26:01 INFO - PROCESS | 3605 | RSS: Main: 180150272 19:26:01 INFO - PROCESS | 3605 | 19:26:03 INFO - PROCESS | 3605 | Cycle 1(1): loaded http://localhost:36461/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36461/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:26:04 INFO - PROCESS | 3605 | RSS: Main: 184721408 19:26:04 INFO - PROCESS | 3605 | 19:26:07 INFO - PROCESS | 3605 | Cycle 1(1): loaded http://localhost:36461/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36461/tests/kraken/driver.html?testName=imaging-darkroom) 19:26:08 INFO - PROCESS | 3605 | RSS: Main: 219561984 19:26:08 INFO - PROCESS | 3605 | 19:26:11 INFO - PROCESS | 3605 | Cycle 1(1): loaded http://localhost:36461/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36461/tests/kraken/driver.html?testName=imaging-desaturate) 19:26:12 INFO - PROCESS | 3605 | RSS: Main: 221667328 19:26:12 INFO - PROCESS | 3605 | 19:26:14 INFO - PROCESS | 3605 | Cycle 1(1): loaded http://localhost:36461/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36461/tests/kraken/driver.html?testName=json-parse-financial) 19:26:15 INFO - PROCESS | 3605 | RSS: Main: 221388800 19:26:15 INFO - PROCESS | 3605 | 19:26:16 INFO - PROCESS | 3605 | Cycle 1(1): loaded http://localhost:36461/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36461/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:26:17 INFO - PROCESS | 3605 | RSS: Main: 213561344 19:26:17 INFO - PROCESS | 3605 | 19:26:19 INFO - PROCESS | 3605 | Cycle 1(1): loaded http://localhost:36461/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36461/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:26:19 INFO - PROCESS | 3605 | RSS: Main: 212779008 19:26:19 INFO - PROCESS | 3605 | 19:26:21 INFO - PROCESS | 3605 | Cycle 1(1): loaded http://localhost:36461/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36461/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:26:22 INFO - PROCESS | 3605 | RSS: Main: 212111360 19:26:22 INFO - PROCESS | 3605 | 19:26:25 INFO - PROCESS | 3605 | Cycle 1(1): loaded http://localhost:36461/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36461/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:26:25 INFO - PROCESS | 3605 | RSS: Main: 225267712 19:26:25 INFO - PROCESS | 3605 | 19:26:28 INFO - PROCESS | 3605 | Cycle 1(1): loaded http://localhost:36461/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36461/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:26:28 INFO - PROCESS | 3605 | RSS: Main: 224215040 19:26:28 INFO - PROCESS | 3605 | 19:26:30 INFO - PROCESS | 3605 | Cycle 1(1): loaded http://localhost:36461/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36461/tests/kraken/driver.html?testName=ai-astar) 19:26:30 INFO - PROCESS | 3605 | RSS: Main: 266248192 19:26:30 INFO - PROCESS | 3605 | 19:26:30 INFO - PROCESS | 3605 | __start_tp_report 19:26:30 INFO - PROCESS | 3605 | _x_x_mozilla_page_load 19:26:30 INFO - PROCESS | 3605 | _x_x_mozilla_page_load_details 19:26:30 INFO - PROCESS | 3605 | |i|pagename|runs| 19:26:30 INFO - PROCESS | 3605 | |0;ai-astar;104;111;111;111;112;111;111;113;112;115 19:26:30 INFO - PROCESS | 3605 | |1;audio-beat-detection;153;117;119;176;121;121;151;119;163;117 19:26:30 INFO - PROCESS | 3605 | |2;audio-dft;161;161;161;162;163;160;161;161;161;160 19:26:30 INFO - PROCESS | 3605 | |3;audio-fft;74;75;76;111;75;75;74;74;103;75 19:26:30 INFO - PROCESS | 3605 | |4;audio-oscillator;82;83;111;83;83;83;129;82;83;132 19:26:30 INFO - PROCESS | 3605 | |5;imaging-gaussian-blur;116;117;117;117;117;117;117;116;117;117 19:26:30 INFO - PROCESS | 3605 | |6;imaging-darkroom;146;145;146;146;146;145;145;146;145;144 19:26:30 INFO - PROCESS | 3605 | |7;imaging-desaturate;94;94;95;95;94;94;95;95;95;95 19:26:30 INFO - PROCESS | 3605 | |8;json-parse-financial;51;50;49;50;51;49;50;50;49;57 19:26:30 INFO - PROCESS | 3605 | |9;json-stringify-tinderbox;62;61;61;62;62;61;61;62;62;62 19:26:30 INFO - PROCESS | 3605 | |10;stanford-crypto-aes;76;76;75;75;75;74;75;75;83;79 19:26:30 INFO - PROCESS | 3605 | |11;stanford-crypto-ccm;126;125;126;119;122;120;127;127;168;119 19:26:30 INFO - PROCESS | 3605 | |12;stanford-crypto-pbkdf2;163;158;162;155;162;160;156;155;156;158 19:26:30 INFO - PROCESS | 3605 | |13;stanford-crypto-sha256-iterative;64;62;64;63;67;63;65;62;61;59 19:26:30 INFO - PROCESS | 3605 | __end_tp_report 19:26:30 INFO - PROCESS | 3605 | __start_cc_report 19:26:30 INFO - PROCESS | 3605 | _x_x_mozilla_cycle_collect,1674 19:26:30 INFO - PROCESS | 3605 | __end_cc_report 19:26:30 INFO - PROCESS | 3605 | __startTimestamp1468722390854__endTimestamp 19:26:30 INFO - PROCESS | 3605 | 19:26:30 INFO - PROCESS | 3605 | ------- Summary: start ------- 19:26:30 INFO - PROCESS | 3605 | Number of tests: 14 19:26:30 INFO - PROCESS | 3605 | 19:26:30 INFO - PROCESS | 3605 | [#0] ai-astar Cycles:10 Average:111.10 Median:111.50 stddev:2.81 (2.5%) stddev-sans-first:1.36 19:26:30 INFO - PROCESS | 3605 | Values: 104.0 111.0 111.0 111.0 112.0 111.0 111.0 113.0 112.0 115.0 19:26:30 INFO - PROCESS | 3605 | 19:26:30 INFO - PROCESS | 3605 | [#1] audio-beat-detection Cycles:10 Average:135.70 Median:136.00 stddev:22.59 (16.6%) stddev-sans-first:23.07 19:26:30 INFO - PROCESS | 3605 | Values: 153.0 117.0 119.0 176.0 121.0 121.0 151.0 119.0 163.0 117.0 19:26:30 INFO - PROCESS | 3605 | 19:26:30 INFO - PROCESS | 3605 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.00 stddev:0.88 (0.5%) stddev-sans-first:0.93 19:26:30 INFO - PROCESS | 3605 | Values: 161.0 161.0 161.0 162.0 163.0 160.0 161.0 161.0 161.0 160.0 19:26:30 INFO - PROCESS | 3605 | 19:26:30 INFO - PROCESS | 3605 | [#3] audio-fft Cycles:10 Average:81.20 Median:75.00 stddev:13.74 (18.3%) stddev-sans-first:14.33 19:26:30 INFO - PROCESS | 3605 | Values: 74.0 75.0 76.0 111.0 75.0 75.0 74.0 74.0 103.0 75.0 19:26:30 INFO - PROCESS | 3605 | 19:26:30 INFO - PROCESS | 3605 | [#4] audio-oscillator Cycles:10 Average:95.10 Median:83.00 stddev:20.65 (24.9%) stddev-sans-first:21.35 19:26:30 INFO - PROCESS | 3605 | Values: 82.0 83.0 111.0 83.0 83.0 83.0 129.0 82.0 83.0 132.0 19:26:30 INFO - PROCESS | 3605 | 19:26:30 INFO - PROCESS | 3605 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 19:26:30 INFO - PROCESS | 3605 | Values: 116.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 19:26:30 INFO - PROCESS | 3605 | 19:26:30 INFO - PROCESS | 3605 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 19:26:30 INFO - PROCESS | 3605 | Values: 146.0 145.0 146.0 146.0 146.0 145.0 145.0 146.0 145.0 144.0 19:26:30 INFO - PROCESS | 3605 | 19:26:30 INFO - PROCESS | 3605 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 19:26:30 INFO - PROCESS | 3605 | Values: 94.0 94.0 95.0 95.0 94.0 94.0 95.0 95.0 95.0 95.0 19:26:30 INFO - PROCESS | 3605 | 19:26:30 INFO - PROCESS | 3605 | [#8] json-parse-financial Cycles:10 Average:50.60 Median:50.00 stddev:2.37 (4.7%) stddev-sans-first:2.51 19:26:30 INFO - PROCESS | 3605 | Values: 51.0 50.0 49.0 50.0 51.0 49.0 50.0 50.0 49.0 57.0 19:26:30 INFO - PROCESS | 3605 | 19:26:30 INFO - PROCESS | 3605 | [#9] json-stringify-tinderbox Cycles:10 Average:61.60 Median:62.00 stddev:0.52 (0.8%) stddev-sans-first:0.53 19:26:30 INFO - PROCESS | 3605 | Values: 62.0 61.0 61.0 62.0 62.0 61.0 61.0 62.0 62.0 62.0 19:26:30 INFO - PROCESS | 3605 | 19:26:30 INFO - PROCESS | 3605 | [#10] stanford-crypto-aes Cycles:10 Average:76.30 Median:75.50 stddev:2.71 (3.6%) stddev-sans-first:2.87 19:26:30 INFO - PROCESS | 3605 | Values: 76.0 76.0 75.0 75.0 75.0 74.0 75.0 75.0 83.0 79.0 19:26:30 INFO - PROCESS | 3605 | 19:26:30 INFO - PROCESS | 3605 | [#11] stanford-crypto-ccm Cycles:10 Average:127.90 Median:126.00 stddev:14.46 (11.5%) stddev-sans-first:15.32 19:26:30 INFO - PROCESS | 3605 | Values: 126.0 125.0 126.0 119.0 122.0 120.0 127.0 127.0 168.0 119.0 19:26:30 INFO - PROCESS | 3605 | 19:26:30 INFO - PROCESS | 3605 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.50 Median:159.00 stddev:3.06 (1.9%) stddev-sans-first:2.78 19:26:30 INFO - PROCESS | 3605 | Values: 163.0 158.0 162.0 155.0 162.0 160.0 156.0 155.0 156.0 158.0 19:26:30 INFO - PROCESS | 3605 | 19:26:30 INFO - PROCESS | 3605 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.00 Median:63.50 stddev:2.21 (3.5%) stddev-sans-first:2.32 19:26:30 INFO - PROCESS | 3605 | Values: 64.0 62.0 64.0 63.0 67.0 63.0 65.0 62.0 61.0 59.0 19:26:30 INFO - PROCESS | 3605 | -------- Summary: end -------- 19:26:30 INFO - PROCESS | 3605 | 19:26:31 INFO - TEST-INFO | 3605: exit 0 19:26:31 INFO - TEST-OK | kraken | took 60804ms 19:26:31 INFO - SUITE-END | took 1174s 19:26:32 INFO - Completed test suite (00:19:34) 19:26:32 INFO - javascript benchmark 19:26:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3043.315254067835, 3047.466693328667, 3074.6925307469255, 3100.0699790062977, 3119.25137966888, 5241.266222728821, 5255.054090263751, 5314.016906872226, 5403.459654034595, 5438.184272359148, 5378.973105134479, 5408.864778380543, 5416.972915135429, 5424.050791111559, 5449.56403487721, 4833.7341446220535, 4901.289313049606, 4930.211166213407, 4943.431505376874, 5125.871853203663, 5021.548060674539, 5032.396112466509, 5067.6452648314635, 5089.694618322913, 5100.464451232623, 4809.0862736080035, 4859.73271470069, 4902.166631672606, 4976.925346119811, 4978.576820970222, 4859.781309841065, 4869.245266983623, 4876.097921884463, 4937.629677774145, 4969.726665033421, 4884.072026314989, 4903.362562866804, 4906.730129842857, 4910.288008238821, 4963.40439147301, 5217.0, 5333.57331413486, 5356.4375740547075, 5366.382865970385, 5371.086915224421, 5784.0, 5836.64980101191, 5841.474267315962, 5852.414758524156, 5854.0, 5830.183774271605, 5862.736176872051, 5891.351951285355, 5914.97042514789, 5916.497097746696, 5245.842624721265, 5336.226247194135, 5339.012282727708, 5362.981033603642, 5454.127339625641, 5893.322267939242, 5910.852228694231, 5923.851903702442, 5925.140854576062, 5927.2590926134235, 5554.389017208104, 5706.771729130871, 5734.111212762028, 5736.225609542742, 5739.7704091836695, 5732.426757324234, 5756.050251708505, 5787.826365209051, 5857.062869940874, 5857.794977175864, 5784.739686714024, 5791.362950075489, 5792.044312688359, 5794.768209271582, 5830.737616807254, 5603.579731520071, 5735.168400581976, 5745.1382292656435, 5789.073748200268, 5807.796727114531, 4405.29515277554, 4426.845060422934, 4435.733855968588, 4469.955300447019, 4472.753998530047, 3933.1740334529495, 3959.544652364957, 3962.980185099056, 3969.4442778011103, 4005.439238506611, 5330.120530112566, 5429.0, 5471.5896307777075, 5548.306461692288, 5590.24531688225, 5825.766969321265, 5876.559258055578, 5889.499392551681, 5893.0, 5944.256967879015, 5551.528120109836, 5561.638493497991, 5565.0, 5570.749316280777, 5572.247746554244, 4938.135826230396, 5011.047900898818, 5025.346704928409, 5038.0, 5043.36957880265, 6050.788222412194, 6058.1518587397795, 6064.3935606439, 6066.66633335162, 6101.877962440726, 5913.497352725067, 5914.290285165807, 5914.7338369774325, 5917.970410147922, 5918.881622367442, 5851.1515830205235, 5932.0, 5953.047512397996, 5981.581289309706, 6021.518278537794, 5733.31200255972, 5778.479936805539, 5784.537237021113, 5792.739326730223, 5794.362620111869, 5885.146653735099, 5899.46904778572, 5901.262342207224, 5902.586818922806, 5913.231279933581, 5480.205370221216, 5628.0, 5653.660780353192, 5698.373178950229, 5729.3124825019595, 5721.056025755704, 5730.799422020209, 5733.054046082517, 5735.139729040678, 5742.0, 5410.972945135407, 5660.264165658438, 5662.433756624469, 5679.659220446786, 5680.346760122474, 5692.601517893873, 5740.167675687086, 5744.770209191585, 5824.475797178275, 5830.912536311874, 5585.413531579125, 5621.606487545832, 5630.74661640219, 5634.126710359901, 5643.407442218672], "value": 5356.918238190228, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [603.471962033221, 639.5523133806337, 653.6045692356124, 666.1273731411848, 673.252689514639, 46464.76767616165, 48974.26538601924, 48990.510094899044, 49085.50914490854, 49107.0, 46537.534624653745, 46981.530184698146, 46985.765071174596, 47041.29438058432, 47053.529464705425, 8997.280217582611, 9133.588988495501, 9140.085991400872, 9141.862872056925, 9144.222741066984, 8992.595333209989, 9099.818003639923, 9103.135202155818, 9104.226140778042, 9107.40801847881, 9158.084191580821, 9185.770355741126, 9186.173244408003, 9195.172434480895, 9204.493752843591, 9087.363884528086, 9129.224015958618, 9141.54292285383, 9156.038615945296, 9167.358284920025, 9000.909990900072, 9044.81910361789, 9067.591958361889, 9076.0, 9084.68203612877, 45079.0, 45197.32204016909, 45278.32082518765, 45402.31896521555, 45405.54594454046, 3443.27691184849, 3543.6633519815578, 3679.6688298053305, 3783.4135708965155, 4196.328587426027, 35103.648963510546, 35240.0, 35417.645823541694, 35446.0, 37027.81486092552, 4499.482559505666, 4541.886452838672, 4648.953510464886, 4655.208614535537, 4701.952980470186, 364737.0, 366903.0, 367646.0, 368712.0, 369851.0, 62586.0, 62606.37393626096, 62736.37263627305, 63035.369646303865, 63133.36866631367, 65877.34122658808, 65887.0, 65894.0, 65913.0, 66001.0, 17376.21807018662, 17420.47738567845, 17548.38580649671, 17599.38402155944, 17608.82391176072, 13418.0, 13431.0, 13502.729945401037, 13506.189628622315, 13568.253746043865, 16255.431059912846, 18238.63522729538, 18378.172982215834, 18400.723989140173, 18501.44495665132, 5470.261514695545, 6309.652969086745, 6365.49076073913, 6444.806655800334, 6684.331566843277, 1027.4605831938293, 1151.8329842172839, 1168.0071938851909, 1173.935433551163, 1202.3287630194038, 33770.831145844604, 33890.32219355599, 34058.82970585181, 34243.82878085594, 34485.48271775925, 1123.741539445932, 1137.3289759042204, 1178.7996040673106, 1202.074402709926, 1208.178438661701, 17290.394836180923, 17772.46682599524, 17969.0, 17975.022747497766, 18041.368552100612, 567821.0, 571113.0, 572458.0, 572930.0, 573862.0, 60844.0, 62514.374856251765, 62590.687046565385, 62686.686566566874, 62754.68622656949, 1246.464020471188, 1276.7829468990294, 1291.5866922584682, 1390.2631605249235, 1402.2918426194706, 24443.0, 37230.0, 37601.97343831716, 37875.242495150495, 37880.810595946845, 58690.0, 59252.70373648104, 59278.0, 59311.70344148424, 59347.40652593419, 531392.0, 543895.0, 544521.0, 544867.0, 545592.0, 28297.0, 29360.0, 29617.25956851096, 44085.0, 44629.33056004097, 50209.74895125501, 51100.74449627728, 51327.230091547906, 51924.22113668222, 52059.479405205464, 43595.78202108969, 43883.78058109689, 44007.0, 44427.33358999553, 45500.772496138634, 44307.55692443034, 44923.0, 45200.547994519635, 46549.53450465587, 46852.7657361711, 43214.78392608017, 43837.12325753403, 43998.78000610104, 44422.55577444184, 44855.32717009313, 38418.615813841505, 38895.6110438892, 39200.80399597984, 39807.40288895611, 40122.79938600288, 29575.85212074012, 29607.0, 30061.398772024873, 30195.0, 30289.848550757106], "value": 21444.331021578866, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [381.7194362143822, 392.23122679548084, 404.40350483037525, 413.9648129908958, 420.5941266677655, 11691.473883675233, 13567.737845988368, 20134.0, 20163.798362016376, 20219.090140943656, 21205.0, 21473.67789483155, 21679.132834686592, 21935.341939741793, 21954.121835126614, 6447.54867159299, 6453.677316134198, 6470.320616335288, 6568.474522038226, 6633.237177724551, 6499.545031847772, 6506.024096385557, 6509.1863517060365, 6528.6409247491365, 6541.967290163567, 6985.755498557552, 7326.157491888421, 7327.194008659043, 7410.407167426593, 7419.183889772121, 7179.964100179492, 7403.74086906961, 7409.296116868889, 7415.443841711839, 7416.184219735852, 7163.391111755507, 7449.180590135081, 7453.664585093629, 7463.477556571042, 7465.104187497535, 25739.61390579143, 26406.207813765617, 27425.86287068572, 27590.5861412079, 28299.292517687016, 2596.376869551313, 2696.3933115049153, 2698.3793727442603, 2824.477471667748, 2938.4857649911396, 15584.532464026097, 15832.28754706041, 15960.840391596052, 16004.839951600568, 16166.75749863753, 2101.338078505266, 2130.1692339987417, 2151.0, 2181.345596321097, 2247.9100835966706, 76329.61835190844, 79444.0, 80477.59761201157, 91843.54078229633, 98148.0, 18103.275868965356, 18404.723929141073, 18519.44441666752, 18679.159437825332, 18951.336703215322, 33104.66895331064, 33323.16692082717, 33329.33341333208, 33410.16474588106, 33423.498647520304, 9377.812443751087, 9442.38624489406, 9881.209503239723, 9889.143234138692, 10090.596376144871, 8198.877016844752, 8285.710000149966, 8318.500889946623, 8397.370197235232, 8461.40770146084, 9045.728628141167, 9085.545722713838, 9244.8613270801, 9257.398269112486, 9287.396319239228, 3262.755293353008, 3401.4387626041425, 3567.6075631680496, 3576.588692300367, 3622.130688634709, 868.3485941615492, 964.0696727657844, 992.454150217392, 1001.5843424978698, 1070.5985255529176, 19857.205711771367, 20439.386818395473, 20592.382228533166, 20709.792902071087, 20720.689189662167, 953.2135987810084, 964.8408012677829, 978.9706308810747, 991.4745185051934, 992.5186284651938, 8778.517181555077, 11333.206675532798, 11449.198556101159, 11566.710832229262, 11633.243839150427, 485507.0, 492271.0, 498897.0, 500553.0, 503545.0, 90856.0, 93050.53474732583, 94899.52550237342, 95141.0, 97844.0, 993.7813680990171, 1003.6687892995294, 1016.2378216337598, 1020.8672872526524, 1021.6577446555488, 17451.38920137789, 17964.19161137778, 18329.26682932721, 18416.631667366844, 18516.72224916654, 41798.791006044776, 42759.7862010688, 42946.0, 43348.56651433445, 44112.117757644024, 57796.0, 59508.107378390225, 59763.40236597752, 60116.0, 61275.387246128754, 7800.1419843816, 8079.515229086273, 8108.554029528196, 8174.713885013996, 9202.861957070783, 12036.217645852992, 13774.0, 14149.575512734635, 14333.713325733635, 14573.198474084027, 12180.330081845583, 12277.447514862031, 12387.75224495487, 12406.317652529198, 12637.304948227937, 11674.533018679158, 12057.336846473529, 12276.386180691108, 12278.570250041206, 12406.317652529198, 12271.75456490883, 12299.815502767287, 12341.444634991627, 12462.875371246171, 12498.437570309175, 8642.78393040179, 9070.863937041082, 9103.135202155785, 9288.95355523245, 9340.673076442292, 11690.88309116898, 12113.273203607812, 12211.450484728031, 12232.755344892874, 12455.190412623151], "value": 10655.025202608591, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1360.761866673332, 1434.1036851967517, 1508.8340282568915, 1632.8448797364254, 1787.8748487605874, 8574.271186949109, 8892.466452012868, 8906.198442140214, 8909.242714369278, 9185.862212066824, 8585.527795971235, 8899.866502002475, 9106.499142547158, 9113.726588202348, 9113.863292050608, 2379.4170428245106, 2421.8667973261554, 2423.1397853761923, 2423.321469988406, 2424.442378253003, 2417.721961974378, 2430.8541487510806, 2463.7289898111194, 2465.469923966347, 2474.418511649761, 2418.3591348292716, 2422.1522467136538, 2444.633305004255, 2450.1669432392982, 2450.4486490539666, 2373.738888722239, 2381.940451488709, 2398.0887262840097, 2399.892004859777, 2406.831521793475, 2350.5063936573342, 2380.976190238093, 2382.463945612241, 2384.1655420602824, 2388.379021454417, 8881.06748791374, 8967.865482017774, 8981.595828187747, 8983.730488085368, 9008.324375671851, 5433.673979561199, 5526.143447765603, 5538.501534861882, 5546.944530554683, 5566.471185237396, 3534.7525673202886, 3581.1405262737017, 3621.5110960020324, 3625.9456108158397, 3642.1805093853673, 1212.2968678166642, 1231.9815202771965, 1232.2421710647977, 1242.3415589737454, 1246.6883279180206, 12509.812352814715, 12691.873081269161, 12719.046071544579, 12720.491180352867, 12811.743765124738, 4814.8796280093275, 4826.95173048272, 4866.878328041827, 4922.852314430573, 5000.874978125576, 10801.78396432067, 10845.186611004206, 10847.240693151562, 10847.945760271148, 10860.13118950482, 5492.47821456961, 5501.119820828648, 5502.312210973629, 5503.394626591072, 5507.504324610724, 4366.235908715962, 4485.775711214426, 4626.1210370029585, 5026.723530205801, 5060.7722652480725, 4109.732867363612, 4160.602432978808, 4198.9370159447635, 4200.833981764138, 4218.451601291812, 1321.1148530484597, 1344.6235054184845, 1344.7982802579495, 1359.1029920252586, 1364.2564802182835, 1034.7723500829804, 1035.2080658296409, 1037.9636712715019, 1043.108142538119, 1047.4762618690654, 6249.593776404519, 6441.130447389636, 6444.742210311535, 6474.967625161844, 6557.934420655828, 1021.923355748307, 1024.36489376587, 1025.610268098118, 1038.776663017455, 1046.817096680761, 4371.69398142127, 4458.308962110878, 4493.631113283333, 4578.88552786183, 4627.074585082997, 11293.435328233556, 11701.707457313636, 11757.118216133824, 11771.293722376684, 11772.882271177179, 10857.837132443019, 11229.831552526719, 11237.0, 11253.66239012831, 11603.709907252387, 8395.454295470774, 8453.492790432594, 8472.19514146155, 8536.8719469208, 8804.955975220211, 6335.3981371769605, 6438.420542151229, 6570.8357291068105, 6599.769008084694, 6607.669616519059, 10464.476776161313, 10883.074938630305, 10903.073238774792, 10907.509162087883, 10911.0, 9946.602135914773, 10171.23715721309, 11087.39019353911, 11107.500162492868, 11186.04918581897, 7586.544807311579, 8194.467359621605, 8741.213290803858, 8811.691590794291, 9037.77405564866, 8947.328950328621, 8998.0, 9017.90982090197, 9019.594118264826, 9034.367594268339, 7695.6536955836, 7844.4901081429525, 7949.92050079515, 8055.7583272501915, 8189.303909167787, 7294.452916031213, 7360.484766066324, 7835.216478352119, 7956.323712484504, 8059.717909873127, 7405.333519983227, 7505.774826755206, 7531.661075251736, 7592.8861067082935, 7597.810054748676, 5184.170532714747, 5236.633435659467, 5468.644538105011, 5472.480114389126, 5482.259894914136, 5371.650842695212, 5452.100403433389, 5506.366767821592, 5633.774649014157, 5672.829815105553], "value": 4877.557442978573, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [333.1787144688343, 336.8383176075484, 339.0692548953124, 341.5986216195969, 343.9157406435423, 5286.629935904488, 5301.575873930086, 5311.92032119518, 5312.840614781558, 5327.547158491533, 5257.158854583267, 5294.549963253128, 5295.920561191585, 5299.125644268691, 5309.433717053469, 3945.4081887716857, 4016.417619445179, 4143.647789937859, 4170.374443833419, 4175.248455278049, 4115.8765237042935, 4119.526254480728, 4133.318002529579, 4154.4183814266025, 4162.250794856925, 3923.784191869446, 4089.141280331119, 4108.0, 4116.608922152405, 4136.614234231536, 3997.3004724173297, 4021.7532564904973, 4041.4746083009313, 4175.478065241845, 4196.706230563862, 3628.8569100733184, 3676.455888526825, 3705.74059815813, 3724.9627503724887, 3732.64539868712, 5110.5400513953555, 5120.513551212629, 5122.206058061007, 5125.897482050338, 5139.17773156297, 4486.573775491323, 4712.269598212282, 4713.481517033124, 4720.905581888377, 4748.382710247645, 5493.571671365474, 5500.092484740013, 5534.142207957773, 5537.889242215173, 5548.972255138739, 3967.8016099194924, 3974.880753577397, 4002.779847108408, 4007.0984028593334, 4012.678985681168, 5535.640183388067, 5696.971515142439, 5697.344805347397, 5721.77112915487, 5732.684702341369, 4038.4749982502085, 4048.716589838683, 4053.5541090480024, 4059.2490389278078, 4059.573744756817, 4078.9184216315507, 4086.2440448516527, 4087.9182416351505, 4137.358709400048, 4140.3375459926265, 4553.203189441834, 4638.605718513964, 4646.558576935186, 4691.366665500182, 4704.976475117603, 5453.3639908027435, 5477.780888764405, 5491.807786727445, 5498.395176530578, 5548.500634942875, 1410.4146779086768, 1416.1361569442631, 1429.9142051476945, 1431.119861285302, 1433.3621538415305, 891.839468895605, 901.1394118616705, 910.6749679216724, 910.7677542226689, 914.5838643417229, 4692.929606055912, 4700.271457924027, 4713.2458806590785, 4751.857444276678, 4777.546133117348, 5007.273945277914, 5023.262322034427, 5060.316857224301, 5060.924086138711, 5151.819686311036, 4576.970181709089, 4700.9059818803435, 4710.952890471051, 4748.884012257116, 4845.733484658378, 2658.5480468320434, 2675.7557735653013, 2678.5982102684366, 2698.7706044986003, 2700.041485272739, 5106.310648062464, 5132.563732082815, 5155.149400348975, 5155.9742201288755, 5161.509656582619, 4916.410030796327, 5092.541671249605, 5107.084843183806, 5113.693178409308, 5167.9224811627855, 5092.567131793839, 5113.900511389995, 5119.795208191631, 5121.334226550524, 5152.355955505562, 4994.026164897955, 5002.5987525987, 5020.648554601289, 5023.6985780853265, 5042.621803364689, 4729.739864307496, 4890.388696443071, 4927.2754535912145, 5068.163752980864, 5096.872578185575, 5205.531502164823, 5218.6868787872845, 5221.295125158207, 5223.817166399158, 5239.69007748063, 3671.5227020487164, 3703.240835628636, 3718.3121122592406, 3718.665320121202, 3731.869384571527, 4793.472718000948, 4981.302617633607, 5062.645614806928, 5081.288619593186, 5400.432954539874, 5330.547947943989, 5548.781706610237, 5549.556035517229, 5570.468121266684, 5580.414056524007, 5512.586556008396, 5528.668279903219, 5530.308711411074, 5546.611737178358, 5583.637063590853, 5188.533032027136, 5424.620276580601, 5442.156465747816, 5470.0, 5472.315960504937, 5528.226048353154, 5548.723793527592, 5570.972145139248, 5577.470140336662, 5578.2748242728185, 5430.805222850967, 5446.346438427414, 5472.589555783412, 5489.584582783563, 5498.937898288142], "value": 4059.918551376083, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [731.7694926098279, 779.5829231361223, 779.5829231361223, 820.147047071046, 826.5825757992213, 14362.569122926316, 14580.927095364521, 14730.263486825643, 15447.922760386182, 15477.226138693062, 13944.790828137586, 14117.71764564708, 14124.0, 14128.15231086133, 14128.505502307422, 674.4334758802605, 812.10262659761, 833.6373677450298, 840.277361469136, 842.4608250719544, 802.1336956087441, 838.5220424358118, 838.7861095420659, 839.4291881520563, 840.2647683277132, 874.2437791310534, 874.2787200559532, 875.7329014650529, 876.5047748022379, 879.5734068976541, 689.4381079420257, 821.7288294862681, 870.83889480446, 875.2035647560721, 875.6497401039571, 631.9431251187415, 632.0929466215995, 632.610944269271, 632.8196464007735, 634.4543692424511, 14909.776353354708, 14911.925440372837, 14913.552593422215, 14946.252687365697, 14948.177850218233, 14000.22998735069, 14119.647008824759, 14395.640108997253, 14705.926470367687, 15113.54659360221, 13476.932615336958, 13580.728385432334, 13683.24742139182, 13959.79060314096, 14123.858761412357, 4585.770711464414, 4613.515580863995, 4631.258998560214, 4788.018456216468, 4801.879953001168, 80130.59934700347, 80497.19502804955, 80503.19496805074, 87231.56384218039, 87600.0, 10769.62306319275, 10839.945800270949, 10859.78280434387, 10911.890881091247, 10933.507992140372, 19741.0, 19745.901270493556, 19777.802221977883, 19802.20791168337, 19861.404157874997, 8387.119352468026, 8550.871736923951, 8583.313334933315, 8599.484030958163, 8662.78343041429, 4363.170997510463, 4487.977560112244, 4492.573205545468, 4524.683272170916, 4527.207738645724, 3355.4631258998443, 3572.3034008368118, 3580.337637537064, 3582.6775590196485, 3584.605693373727, 601.7923816283375, 605.2555356911024, 612.5773216480615, 616.654673382907, 624.2758400255682, 559.9944000560024, 621.3444815719369, 627.9529035322369, 650.1710319342781, 682.2374604058621, 9701.223902087957, 9759.170470510086, 9944.0, 10036.792932566343, 10199.337043092324, 583.3961849485762, 613.5061275673125, 673.4444083631024, 678.5589366911448, 714.3570786292274, 4691.249400095969, 4888.633352498506, 4905.0, 4963.975180124076, 5001.199808030698, 123834.38082809528, 128582.0, 132712.0, 133076.0, 137050.31474842562, 110194.0, 112602.43698781454, 112674.43662781798, 113200.0, 114732.0, 60070.69964650149, 60242.69878650579, 60769.39230607637, 96153.0, 97832.51083744536, 9056.230220431074, 9163.35856490066, 9177.724668259963, 9218.723438296862, 9229.630814767603, 56857.43142568687, 57338.7133064332, 57586.7120664394, 57821.0, 59075.409245906994, 81797.0, 83991.0, 84486.57756711177, 84785.92164367429, 90087.0, 11664.6500604982, 11773.646790596296, 11777.293362398283, 11908.76182476363, 11981.700457488632, 13388.330583470983, 13591.592252232449, 13666.385012674653, 13673.31633418345, 13717.588472345846, 12592.866642001898, 12674.809877852023, 12724.745505090032, 12990.610281691565, 13126.671833203864, 11961.461734221806, 11963.342016189194, 12063.707895499827, 12212.938935305267, 12370.195937264049, 12372.319522425993, 12725.61823145307, 13083.869161308265, 13147.408366623717, 13164.736705266032, 10457.42484163348, 10656.094231990368, 10815.242932994615, 10927.421755611667, 11211.943940280247, 9299.535023248674, 9374.859377109213, 9860.950695246478, 10416.166706663296, 10463.676902656345], "value": 7526.101548170962, "unit": "score"}], "name": "dromaeo_css", "value": 7531.016430624741, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 111.0, 111.0, 111.0, 112.0, 111.0, 111.0, 113.0, 112.0, 115.0], "value": 111.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 117.0, 119.0, 176.0, 121.0, 121.0, 151.0, 119.0, 163.0, 117.0], "value": 135.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 162.0, 163.0, 160.0, 161.0, 161.0, 161.0, 160.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 76.0, 111.0, 75.0, 75.0, 74.0, 74.0, 103.0, 75.0], "value": 81.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 111.0, 83.0, 83.0, 83.0, 129.0, 82.0, 83.0, 132.0], "value": 95.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 146.0, 146.0, 146.0, 145.0, 145.0, 146.0, 145.0, 144.0], "value": 145.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 95.0, 94.0, 94.0, 95.0, 95.0, 95.0, 95.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 50.0, 49.0, 50.0, 51.0, 49.0, 50.0, 50.0, 49.0, 57.0], "value": 50.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 61.0, 62.0, 62.0, 61.0, 61.0, 62.0, 62.0, 62.0], "value": 61.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 75.0, 75.0, 74.0, 75.0, 75.0, 83.0, 79.0], "value": 76.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 125.0, 126.0, 119.0, 122.0, 120.0, 127.0, 127.0, 168.0, 119.0], "value": 127.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 158.0, 162.0, 155.0, 162.0, 160.0, 156.0, 155.0, 156.0, 158.0], "value": 158.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 62.0, 64.0, 63.0, 67.0, 63.0, 65.0, 62.0, 61.0, 59.0], "value": 63.0, "unit": "score"}], "name": "kraken", "value": 1478.8999999999999, "alertThreshold": 2.0}]} 19:26:32 INFO - Return code: 0 19:26:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:26:32 INFO - # TBPL SUCCESS # 19:26:32 INFO - Running post-action listener: _resource_record_post_action 19:26:32 INFO - ##### 19:26:32 INFO - ##### Finished run-tests step (success) 19:26:32 INFO - ##### 19:26:32 INFO - Running post-run listener: _resource_record_post_run 19:26:32 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 0; Write bytes: 553779200; Read time: 0; Write time: 596160 19:26:32 INFO - TinderboxPrint: CPU usage
13.1% 19:26:32 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 19:26:32 INFO - TinderboxPrint: I/O write bytes / time
553,779,200 / 596,160 19:26:32 INFO - TinderboxPrint: CPU idle
8,267.0 (86.9%) 19:26:32 INFO - TinderboxPrint: CPU user
1,201.9 (12.6%) 19:26:32 INFO - TinderboxPrint: Swap in / out
0 / 0 19:26:32 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 257118208; Read time: 0; Write time: 349600 19:26:32 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 296484864; Read time: 0; Write time: 246536 19:26:32 INFO - Running post-run listener: _upload_blobber_files 19:26:32 INFO - Blob upload gear active. 19:26:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:26:32 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 19:26:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:26:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:26:33 INFO - (blobuploader) - INFO - Open directory for files ... 19:26:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:26:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:26:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:26:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:26:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:26:33 INFO - (blobuploader) - INFO - Done attempting. 19:26:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:26:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:26:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:26:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:26:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:26:34 INFO - (blobuploader) - INFO - Done attempting. 19:26:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:26:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:26:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:26:43 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:26:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:26:43 INFO - (blobuploader) - INFO - Done attempting. 19:26:43 INFO - (blobuploader) - INFO - Iteration through files over. 19:26:43 INFO - Return code: 0 19:26:43 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:26:43 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:26:43 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7d83595bcacf505c1f0261abc50fe3141afc5c032a14c4eec1d93ed52745ef6635bf64887224ec1a3da82167315520387751f78e5ee602c233ce1ccb9b1a498c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/88172bdffe1262ed7bd38ed62b1dab9b8d76b0c06b46c6ffd85faedc653fbc827f24a4a93ffa730b34b6b7014b61ce08ec6dc253e807d24df68bf7400c5af197", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/20b9827bb079d695bc6f1fe4b30d31437463c320ce437cf5f5585e0d9b5c46af5b416f6475d496e35872e6149a127dbbc0e45b918e6d8daa9a53e835cf452701"} 19:26:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:26:43 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:26:43 INFO - Contents: 19:26:43 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7d83595bcacf505c1f0261abc50fe3141afc5c032a14c4eec1d93ed52745ef6635bf64887224ec1a3da82167315520387751f78e5ee602c233ce1ccb9b1a498c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/88172bdffe1262ed7bd38ed62b1dab9b8d76b0c06b46c6ffd85faedc653fbc827f24a4a93ffa730b34b6b7014b61ce08ec6dc253e807d24df68bf7400c5af197", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/20b9827bb079d695bc6f1fe4b30d31437463c320ce437cf5f5585e0d9b5c46af5b416f6475d496e35872e6149a127dbbc0e45b918e6d8daa9a53e835cf452701"} 19:26:43 INFO - Running post-run listener: copy_logs_to_upload_dir 19:26:43 INFO - Copying logs to upload dir... 19:26:43 INFO - mkdir: /builds/slave/test/build/upload/logs 19:26:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.185011 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-07-16 19:26:43.153916) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-16 19:26:43.157033) ========= 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=17051fcd5208b27b50bedfeb000001dd-1468715614.628599-2027855988 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7d83595bcacf505c1f0261abc50fe3141afc5c032a14c4eec1d93ed52745ef6635bf64887224ec1a3da82167315520387751f78e5ee602c233ce1ccb9b1a498c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/88172bdffe1262ed7bd38ed62b1dab9b8d76b0c06b46c6ffd85faedc653fbc827f24a4a93ffa730b34b6b7014b61ce08ec6dc253e807d24df68bf7400c5af197", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/20b9827bb079d695bc6f1fe4b30d31437463c320ce437cf5f5585e0d9b5c46af5b416f6475d496e35872e6149a127dbbc0e45b918e6d8daa9a53e835cf452701"} build_url:https://queue.taskcluster.net/v1/task/bAQxJ7egSL-ZHBPBzqsC3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011485 build_url: 'https://queue.taskcluster.net/v1/task/bAQxJ7egSL-ZHBPBzqsC3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7d83595bcacf505c1f0261abc50fe3141afc5c032a14c4eec1d93ed52745ef6635bf64887224ec1a3da82167315520387751f78e5ee602c233ce1ccb9b1a498c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/88172bdffe1262ed7bd38ed62b1dab9b8d76b0c06b46c6ffd85faedc653fbc827f24a4a93ffa730b34b6b7014b61ce08ec6dc253e807d24df68bf7400c5af197", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/20b9827bb079d695bc6f1fe4b30d31437463c320ce437cf5f5585e0d9b5c46af5b416f6475d496e35872e6149a127dbbc0e45b918e6d8daa9a53e835cf452701"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-16 19:26:43.181888) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 19:26:43.182178) ========= 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=17051fcd5208b27b50bedfeb000001dd-1468715614.628599-2027855988 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004486 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 19:26:43.266503) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-16 19:26:43.266827) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-16 19:26:43.267152) ========= ========= Total master_lag: 0.17 =========