builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-026 starttime: 1468610825.99 results: success (0) buildid: 20160715101139 builduid: 085db5ae27964394bf0c6d852b7c9826 revision: 4e3c16ea8fced03ab4ef572f16d4aa4464981e2c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-15 12:27:05.989820) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-15 12:27:05.990315) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-15 12:27:05.990635) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-15 12:27:06.005334) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 12:27:06.005623) ========= 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=41bf3e9aed84707956354da8000001c5-1468610824.650182-239027312 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-15 12:27:06-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.1M=0s 2016-07-15 12:27:06 (46.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.077910 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 12:27:06.100804) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 12:27:06.101510) ========= 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=41bf3e9aed84707956354da8000001c5-1468610824.650182-239027312 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014121 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 12:27:06.156672) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 12:27:06.157418) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 4e3c16ea8fced03ab4ef572f16d4aa4464981e2c --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 4e3c16ea8fced03ab4ef572f16d4aa4464981e2c --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=41bf3e9aed84707956354da8000001c5-1468610824.650182-239027312 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-15 12:27:06,400 truncating revision to first 12 chars 2016-07-15 12:27:06,400 Setting DEBUG logging. 2016-07-15 12:27:06,400 attempt 1/10 2016-07-15 12:27:06,400 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/4e3c16ea8fce?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-15 12:27:06,709 unpacking tar archive at: mozilla-inbound-4e3c16ea8fce/testing/mozharness/ program finished with exit code 0 elapsedTime=0.688556 ========= master_lag: 0.14 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 12:27:06.983726) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-15 12:27:06.984076) ========= script_repo_revision: 4e3c16ea8fced03ab4ef572f16d4aa4464981e2c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-15 12:27:06.984499) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-15 12:27:06.984791) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-15 12:27:06.995596) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-07-15 12:27:06.995925) ========= /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=41bf3e9aed84707956354da8000001c5-1468610824.650182-239027312 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:27:07 INFO - MultiFileLogger online at 20160715 12:27:07 in /builds/slave/test 12:27:07 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 12:27:07 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:27:07 INFO - {'append_to_log': False, 12:27:07 INFO - 'base_work_dir': '/builds/slave/test', 12:27:07 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 12:27:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:27:07 INFO - 'branch': 'Mozilla-Inbound', 12:27:07 INFO - 'buildbot_json_path': 'buildprops.json', 12:27:07 INFO - 'config_files': ('talos/linux_config.py',), 12:27:07 INFO - 'default_actions': ('clobber', 12:27:07 INFO - 'read-buildbot-config', 12:27:07 INFO - 'download-and-extract', 12:27:07 INFO - 'populate-webroot', 12:27:07 INFO - 'create-virtualenv', 12:27:07 INFO - 'install', 12:27:07 INFO - 'run-tests'), 12:27:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:27:07 INFO - 'download_minidump_stackwalk': True, 12:27:07 INFO - 'download_symbols': 'ondemand', 12:27:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:27:07 INFO - 'tooltool.py': '/tools/tooltool.py', 12:27:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:27:07 INFO - '/tools/misc-python/virtualenv.py')}, 12:27:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:27:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:27:07 INFO - 'installer_path': 'installer.exe', 12:27:07 INFO - 'log_level': 'info', 12:27:07 INFO - 'log_name': 'talos', 12:27:07 INFO - 'log_to_console': True, 12:27:07 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:27:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:27:07 INFO - 'opt_config_files': (), 12:27:07 INFO - 'pip_index': False, 12:27:07 INFO - 'sps_profile': False, 12:27:07 INFO - 'sps_profile_interval': 0, 12:27:07 INFO - 'suite': 'dromaeojs', 12:27:07 INFO - 'system_bits': '32', 12:27:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:27:07 INFO - 'title': 'talos-linux64-ix-026', 12:27:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:27:07 INFO - 'use_talos_json': True, 12:27:07 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:27:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:27:07 INFO - 'work_dir': 'build'} 12:27:07 INFO - ##### 12:27:07 INFO - ##### Running clobber step. 12:27:07 INFO - ##### 12:27:07 INFO - Running pre-action listener: _resource_record_pre_action 12:27:07 INFO - Running main action method: clobber 12:27:07 INFO - rmtree: /builds/slave/test/build 12:27:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:27:07 INFO - Running post-action listener: _resource_record_post_action 12:27:07 INFO - ##### 12:27:07 INFO - ##### Finished clobber step (success) 12:27:07 INFO - ##### 12:27:07 INFO - ##### 12:27:07 INFO - ##### Running read-buildbot-config step. 12:27:07 INFO - ##### 12:27:07 INFO - Running pre-action listener: _resource_record_pre_action 12:27:07 INFO - Running main action method: read_buildbot_config 12:27:07 INFO - Using buildbot properties: 12:27:07 INFO - { 12:27:07 INFO - "project": "", 12:27:07 INFO - "product": "firefox", 12:27:07 INFO - "script_repo_revision": "production", 12:27:07 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 12:27:07 INFO - "repository": "", 12:27:07 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 12:27:07 INFO - "buildid": "20160715101139", 12:27:07 INFO - "pgo_build": "True", 12:27:07 INFO - "basedir": "/builds/slave/test", 12:27:07 INFO - "buildnumber": 1347, 12:27:07 INFO - "slavename": "talos-linux64-ix-026", 12:27:07 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 12:27:07 INFO - "platform": "ubuntu64_hw", 12:27:07 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 12:27:07 INFO - "branch": "mozilla-inbound", 12:27:07 INFO - "repo_path": "integration/mozilla-inbound", 12:27:07 INFO - "revision": "4e3c16ea8fced03ab4ef572f16d4aa4464981e2c", 12:27:07 INFO - "stage_platform": "linux64-pgo", 12:27:07 INFO - "builduid": "085db5ae27964394bf0c6d852b7c9826", 12:27:07 INFO - "slavebuilddir": "test" 12:27:07 INFO - } 12:27:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/b6ou9dPDQpalcDoAEKkR8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 12:27:07 INFO - Running post-action listener: _resource_record_post_action 12:27:07 INFO - ##### 12:27:07 INFO - ##### Finished read-buildbot-config step (success) 12:27:07 INFO - ##### 12:27:07 INFO - ##### 12:27:07 INFO - ##### Running download-and-extract step. 12:27:07 INFO - ##### 12:27:07 INFO - Running pre-action listener: _resource_record_pre_action 12:27:07 INFO - Running main action method: download_and_extract 12:27:07 INFO - mkdir: /builds/slave/test/build/tests 12:27: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')]} 12:27:07 INFO - https://queue.taskcluster.net/v1/task/b6ou9dPDQpalcDoAEKkR8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 12:27:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b6ou9dPDQpalcDoAEKkR8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 12:27:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b6ou9dPDQpalcDoAEKkR8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 12:27:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b6ou9dPDQpalcDoAEKkR8A/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 12:27:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b6ou9dPDQpalcDoAEKkR8A/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 12:27:08 INFO - Downloaded 1361 bytes. 12:27:08 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 12:27:08 INFO - Using the following test package requirements: 12:27:08 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 12:27:08 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:27:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:27:08 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:27:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 12:27:08 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:27:08 INFO - u'jsshell-linux-x86_64.zip'], 12:27:08 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:27:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:27:08 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 12:27:08 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:27:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:27:08 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:27:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:27:08 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:27:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:27:08 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:27:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:27:08 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:27:08 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')]} 12:27:08 INFO - https://queue.taskcluster.net/v1/task/b6ou9dPDQpalcDoAEKkR8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:27:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b6ou9dPDQpalcDoAEKkR8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 12:27:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b6ou9dPDQpalcDoAEKkR8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 12:27:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b6ou9dPDQpalcDoAEKkR8A/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 12:27:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b6ou9dPDQpalcDoAEKkR8A/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 12:27:09 INFO - Downloaded 24303887 bytes. 12:27:09 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:27:09 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 12:27:10 INFO - Return code: 0 12:27:10 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 12:27:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:27:10 INFO - https://queue.taskcluster.net/v1/task/b6ou9dPDQpalcDoAEKkR8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:27:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b6ou9dPDQpalcDoAEKkR8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 12:27:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b6ou9dPDQpalcDoAEKkR8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 12:27:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b6ou9dPDQpalcDoAEKkR8A/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 12:27:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b6ou9dPDQpalcDoAEKkR8A/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 12:27:11 INFO - Downloaded 24303887 bytes. 12:27:11 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'] 12:27:11 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 12:27:13 INFO - Return code: 0 12:27:13 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')]} 12:27:13 INFO - https://queue.taskcluster.net/v1/task/b6ou9dPDQpalcDoAEKkR8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:27:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b6ou9dPDQpalcDoAEKkR8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 12:27:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b6ou9dPDQpalcDoAEKkR8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 12:27:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b6ou9dPDQpalcDoAEKkR8A/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 12:27:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b6ou9dPDQpalcDoAEKkR8A/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 12:27:14 INFO - Downloaded 14403333 bytes. 12:27:14 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'] 12:27:14 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 12:27:14 INFO - Return code: 0 12:27:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:27:14 INFO - https://queue.taskcluster.net/v1/task/b6ou9dPDQpalcDoAEKkR8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:27:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b6ou9dPDQpalcDoAEKkR8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 12:27:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b6ou9dPDQpalcDoAEKkR8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 12:27:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b6ou9dPDQpalcDoAEKkR8A/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 12:27:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b6ou9dPDQpalcDoAEKkR8A/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 12:27:15 INFO - Downloaded 60465087 bytes. 12:27:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/b6ou9dPDQpalcDoAEKkR8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 12:27:15 INFO - mkdir: /builds/slave/test/properties 12:27:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:27:15 INFO - Writing to file /builds/slave/test/properties/build_url 12:27:15 INFO - Contents: 12:27:15 INFO - build_url:https://queue.taskcluster.net/v1/task/b6ou9dPDQpalcDoAEKkR8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 12:27:16 INFO - Running post-action listener: _resource_record_post_action 12:27:16 INFO - Running post-action listener: set_extra_try_arguments 12:27:16 INFO - ##### 12:27:16 INFO - ##### Finished download-and-extract step (success) 12:27:16 INFO - ##### 12:27:16 INFO - ##### 12:27:16 INFO - ##### Running populate-webroot step. 12:27:16 INFO - ##### 12:27:16 INFO - Running pre-action listener: _resource_record_pre_action 12:27:16 INFO - Running main action method: populate_webroot 12:27:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:27:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:27:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:27:16 INFO - '--tppagecycles', 12:27:16 INFO - '7'], 12:27:16 INFO - 'tests': ['tsvgm']}}, 12:27:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:27:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:27:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:27:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:27:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:27:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:27:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:27:16 INFO - 'talos_options': ['--disable-e10s'], 12:27:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:27:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:27:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:27:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:27:16 INFO - 'talos_options': ['--disable-e10s'], 12:27:16 INFO - 'tests': ['damp', 'tps']}, 12:27:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:27:16 INFO - 'tests': ['damp', 'tps']}, 12:27:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:27:16 INFO - 'tests': ['dromaeo_dom']}, 12:27:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:27:16 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:27:16 INFO - 'tests': ['basic_compositor_video']}, 12:27:16 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:27:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:27:16 INFO - 'tests': ['a11yr', 12:27:16 INFO - 'ts_paint', 12:27:16 INFO - 'tpaint', 12:27:16 INFO - 'sessionrestore', 12:27:16 INFO - 'sessionrestore_no_auto_restore', 12:27:16 INFO - 'tabpaint']}, 12:27:16 INFO - 'other-e10s': {'tests': ['a11yr', 12:27:16 INFO - 'ts_paint', 12:27:16 INFO - 'tpaint', 12:27:16 INFO - 'sessionrestore', 12:27:16 INFO - 'sessionrestore_no_auto_restore', 12:27:16 INFO - 'tabpaint']}, 12:27:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:27:16 INFO - 'ts_paint', 12:27:16 INFO - 'tpaint', 12:27:16 INFO - 'sessionrestore', 12:27:16 INFO - 'sessionrestore_no_auto_restore', 12:27:16 INFO - 'tabpaint']}, 12:27:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:27:16 INFO - 'ts_paint', 12:27:16 INFO - 'tpaint', 12:27:16 INFO - 'sessionrestore', 12:27:16 INFO - 'sessionrestore_no_auto_restore', 12:27:16 INFO - 'tabpaint']}, 12:27:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:27:16 INFO - 'tests': ['a11yr', 12:27:16 INFO - 'ts_paint', 12:27:16 INFO - 'tpaint', 12:27:16 INFO - 'sessionrestore', 12:27:16 INFO - 'sessionrestore_no_auto_restore', 12:27:16 INFO - 'tabpaint']}, 12:27:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:27:16 INFO - 'tests': ['a11yr', 12:27:16 INFO - 'ts_paint', 12:27:16 INFO - 'tpaint', 12:27:16 INFO - 'sessionrestore', 12:27:16 INFO - 'sessionrestore_no_auto_restore', 12:27:16 INFO - 'tabpaint']}, 12:27:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:27:16 INFO - 'tests': ['tsvgx', 12:27:16 INFO - 'tsvgr_opacity', 12:27:16 INFO - 'tart', 12:27:16 INFO - 'tscrollx', 12:27:16 INFO - 'cart']}, 12:27:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:27:16 INFO - 'tsvgr_opacity', 12:27:16 INFO - 'tart', 12:27:16 INFO - 'tscrollx', 12:27:16 INFO - 'cart']}, 12:27:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:27:16 INFO - 'talos_options': ['--disable-e10s'], 12:27:16 INFO - 'tests': ['tp5o']}, 12:27:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:27:16 INFO - 'tests': ['tp5o']}, 12:27:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:27:16 INFO - 'talos_options': ['--disable-e10s', 12:27:16 INFO - '--xperf_path', 12:27:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:27:16 INFO - 'tests': ['tp5n']}, 12:27:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:27:16 INFO - 'talos_options': ['--xperf_path', 12:27:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:27:16 INFO - 'tests': ['tp5n']}}, 12:27:16 INFO - 'talos.zip': {'path': '', 12:27:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:27:16 INFO - Running post-action listener: _resource_record_post_action 12:27:16 INFO - ##### 12:27:16 INFO - ##### Finished populate-webroot step (success) 12:27:16 INFO - ##### 12:27:16 INFO - ##### 12:27:16 INFO - ##### Running create-virtualenv step. 12:27:16 INFO - ##### 12:27:16 INFO - Running pre-action listener: _resource_record_pre_action 12:27:16 INFO - Running main action method: create_virtualenv 12:27:16 INFO - Creating virtualenv /builds/slave/test/build/venv 12:27:16 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 12:27:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:27:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:27:16 INFO - Using real prefix '/usr' 12:27:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:27:17 INFO - Installing distribute.............................................................................................................................................................................................done. 12:27:19 INFO - Installing pip.................done. 12:27:19 INFO - Return code: 0 12:27:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:27:19 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')]} 12:27:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:27:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:27:19 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')]} 12:27:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:27:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:27:19 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 0x1ec8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x202b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2189180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21873b0>, '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 0x21882b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2188740>, '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': '41bf3e9aed84707956354da8000001c5-1468610824.650182-239027312', '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 12:27:19 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 12:27:19 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 12:27:19 INFO - Using env: {'DISPLAY': ':0', 12:27:19 INFO - 'HOME': '/home/cltbld', 12:27:19 INFO - 'LANG': 'en_US.UTF-8', 12:27:19 INFO - 'LANGUAGE': 'en_US:en', 12:27:19 INFO - 'LOGNAME': 'cltbld', 12:27:19 INFO - 'MAIL': '/var/mail/cltbld', 12:27:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:27:19 INFO - 'MOZ_NO_REMOTE': '1', 12:27:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:27:19 INFO - 'NO_EM_RESTART': '1', 12:27:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:27:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:27:19 INFO - 'PWD': '/builds/slave/test', 12:27:19 INFO - 'SHELL': '/bin/bash', 12:27:19 INFO - 'SHLVL': '1', 12:27:19 INFO - 'TERM': 'linux', 12:27:19 INFO - 'TMOUT': '86400', 12:27:19 INFO - 'USER': 'cltbld', 12:27:19 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1468610824.650182-239027312', 12:27:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:27:19 INFO - '_': '/tools/buildbot/bin/python'} 12:27:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:27:19 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 12:27:19 INFO - Cleaning up... 12:27:19 INFO - Return code: 0 12:27:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:27:19 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')]} 12:27:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:27:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:27:19 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')]} 12:27:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:27:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:27:19 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 0x1ec8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x202b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2189180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21873b0>, '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 0x21882b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2188740>, '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': '41bf3e9aed84707956354da8000001c5-1468610824.650182-239027312', '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 12:27:19 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 12:27:19 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 12:27:19 INFO - Using env: {'DISPLAY': ':0', 12:27:19 INFO - 'HOME': '/home/cltbld', 12:27:19 INFO - 'LANG': 'en_US.UTF-8', 12:27:19 INFO - 'LANGUAGE': 'en_US:en', 12:27:19 INFO - 'LOGNAME': 'cltbld', 12:27:19 INFO - 'MAIL': '/var/mail/cltbld', 12:27:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:27:19 INFO - 'MOZ_NO_REMOTE': '1', 12:27:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:27:19 INFO - 'NO_EM_RESTART': '1', 12:27:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:27:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:27:19 INFO - 'PWD': '/builds/slave/test', 12:27:19 INFO - 'SHELL': '/bin/bash', 12:27:19 INFO - 'SHLVL': '1', 12:27:19 INFO - 'TERM': 'linux', 12:27:19 INFO - 'TMOUT': '86400', 12:27:19 INFO - 'USER': 'cltbld', 12:27:19 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1468610824.650182-239027312', 12:27:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:27:19 INFO - '_': '/tools/buildbot/bin/python'} 12:27:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:27:19 INFO - Downloading/unpacking psutil>=3.1.1 12:27:19 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 12:27:19 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 12:27:19 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 12:27:19 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 12:27:19 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 12:27:19 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 12:27:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:27:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:27:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:27:21 INFO - Installing collected packages: psutil 12:27:21 INFO - Running setup.py install for psutil 12:27:22 INFO - building 'psutil._psutil_linux' extension 12:27:22 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 12:27:22 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 12:27:22 INFO - building 'psutil._psutil_posix' extension 12:27:22 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 12:27:22 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 12:27:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:27:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:27:22 INFO - Successfully installed psutil 12:27:22 INFO - Cleaning up... 12:27:22 INFO - Return code: 0 12:27:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:27:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:27:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:27:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:27:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:27:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:27:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:27:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ec8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x202b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2189180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21873b0>, '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 0x21882b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2188740>, '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': '41bf3e9aed84707956354da8000001c5-1468610824.650182-239027312', '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 12:27:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 12:27:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 12:27:22 INFO - Using env: {'DISPLAY': ':0', 12:27:22 INFO - 'HOME': '/home/cltbld', 12:27:22 INFO - 'LANG': 'en_US.UTF-8', 12:27:22 INFO - 'LANGUAGE': 'en_US:en', 12:27:22 INFO - 'LOGNAME': 'cltbld', 12:27:22 INFO - 'MAIL': '/var/mail/cltbld', 12:27:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:27:22 INFO - 'MOZ_NO_REMOTE': '1', 12:27:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:27:22 INFO - 'NO_EM_RESTART': '1', 12:27:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:27:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:27:22 INFO - 'PWD': '/builds/slave/test', 12:27:22 INFO - 'SHELL': '/bin/bash', 12:27:22 INFO - 'SHLVL': '1', 12:27:22 INFO - 'TERM': 'linux', 12:27:22 INFO - 'TMOUT': '86400', 12:27:22 INFO - 'USER': 'cltbld', 12:27:22 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1468610824.650182-239027312', 12:27:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:27:22 INFO - '_': '/tools/buildbot/bin/python'} 12:27:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:27:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:27:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:27:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:27:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:27:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:27:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:27:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:27:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:27:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:27:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:27:24 INFO - Installing collected packages: mozsystemmonitor 12:27:24 INFO - Running setup.py install for mozsystemmonitor 12:27:24 INFO - Successfully installed mozsystemmonitor 12:27:24 INFO - Cleaning up... 12:27:24 INFO - Return code: 0 12:27:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:27: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')]} 12:27:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:27:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:27: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')]} 12:27:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:27:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:27:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ec8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x202b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2189180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21873b0>, '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 0x21882b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2188740>, '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': '41bf3e9aed84707956354da8000001c5-1468610824.650182-239027312', '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 12:27:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 12:27:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 12:27:24 INFO - Using env: {'DISPLAY': ':0', 12:27:24 INFO - 'HOME': '/home/cltbld', 12:27:24 INFO - 'LANG': 'en_US.UTF-8', 12:27:24 INFO - 'LANGUAGE': 'en_US:en', 12:27:24 INFO - 'LOGNAME': 'cltbld', 12:27:24 INFO - 'MAIL': '/var/mail/cltbld', 12:27:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:27:24 INFO - 'MOZ_NO_REMOTE': '1', 12:27:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:27:24 INFO - 'NO_EM_RESTART': '1', 12:27:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:27:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:27:24 INFO - 'PWD': '/builds/slave/test', 12:27:24 INFO - 'SHELL': '/bin/bash', 12:27:24 INFO - 'SHLVL': '1', 12:27:24 INFO - 'TERM': 'linux', 12:27:24 INFO - 'TMOUT': '86400', 12:27:24 INFO - 'USER': 'cltbld', 12:27:24 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1468610824.650182-239027312', 12:27:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:27:24 INFO - '_': '/tools/buildbot/bin/python'} 12:27:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:27:25 INFO - Downloading/unpacking jsonschema==2.5.1 12:27:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:27:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:27:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:27:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:27:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:27:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:27:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:27:26 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:27: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 12:27: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 12:27: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 12:27: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 12:27: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 12:27: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 12:27:27 INFO - Downloading functools32-3.2.3-2.tar.gz 12:27:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:27:27 INFO - warning: no files found matching '*.txt' 12:27:27 INFO - no previously-included directories found matching 'build' 12:27:27 INFO - no previously-included directories found matching 'dist' 12:27:27 INFO - no previously-included directories found matching '.git*' 12:27:27 INFO - Installing collected packages: jsonschema, functools32 12:27:27 INFO - Running setup.py install for functools32 12:27:27 INFO - warning: no files found matching '*.txt' 12:27:27 INFO - no previously-included directories found matching 'build' 12:27:27 INFO - no previously-included directories found matching 'dist' 12:27:27 INFO - no previously-included directories found matching '.git*' 12:27:27 INFO - Successfully installed jsonschema functools32 12:27:27 INFO - Cleaning up... 12:27:27 INFO - Return code: 0 12:27:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:27:27 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')]} 12:27:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:27:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:27:27 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')]} 12:27:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:27:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:27:27 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 0x1ec8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x202b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2189180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21873b0>, '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 0x21882b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2188740>, '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': '41bf3e9aed84707956354da8000001c5-1468610824.650182-239027312', '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 12:27:27 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 12:27:27 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 12:27:27 INFO - Using env: {'DISPLAY': ':0', 12:27:27 INFO - 'HOME': '/home/cltbld', 12:27:27 INFO - 'LANG': 'en_US.UTF-8', 12:27:27 INFO - 'LANGUAGE': 'en_US:en', 12:27:27 INFO - 'LOGNAME': 'cltbld', 12:27:27 INFO - 'MAIL': '/var/mail/cltbld', 12:27:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:27:27 INFO - 'MOZ_NO_REMOTE': '1', 12:27:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:27:27 INFO - 'NO_EM_RESTART': '1', 12:27:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:27:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:27:27 INFO - 'PWD': '/builds/slave/test', 12:27:27 INFO - 'SHELL': '/bin/bash', 12:27:27 INFO - 'SHLVL': '1', 12:27:27 INFO - 'TERM': 'linux', 12:27:27 INFO - 'TMOUT': '86400', 12:27:27 INFO - 'USER': 'cltbld', 12:27:27 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1468610824.650182-239027312', 12:27:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:27:27 INFO - '_': '/tools/buildbot/bin/python'} 12:27:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:27:27 INFO - Downloading/unpacking blobuploader==1.2.4 12:27:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:27:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:27:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:27:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:27:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:27:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:27:29 INFO - Downloading blobuploader-1.2.4.tar.gz 12:27:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:27:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:27: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 12:27: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 12:27: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 12:27: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 12:27: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 12:27: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 12:27:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:27:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:27:30 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 12:27:30 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 12:27:30 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 12:27:30 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 12:27:30 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 12:27:30 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 12:27:30 INFO - Downloading docopt-0.6.1.tar.gz 12:27:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:27:30 INFO - Installing collected packages: blobuploader, requests, docopt 12:27:30 INFO - Running setup.py install for blobuploader 12:27:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:27:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:27:30 INFO - Running setup.py install for requests 12:27:30 INFO - Running setup.py install for docopt 12:27:30 INFO - Successfully installed blobuploader requests docopt 12:27:30 INFO - Cleaning up... 12:27:31 INFO - Return code: 0 12:27:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:27:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:27:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:27:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:27:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:27:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:27:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:27:31 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 0x1ec8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x202b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2189180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21873b0>, '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 0x21882b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2188740>, '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': '41bf3e9aed84707956354da8000001c5-1468610824.650182-239027312', '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 12:27:31 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 12:27:31 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 12:27:31 INFO - Using env: {'DISPLAY': ':0', 12:27:31 INFO - 'HOME': '/home/cltbld', 12:27:31 INFO - 'LANG': 'en_US.UTF-8', 12:27:31 INFO - 'LANGUAGE': 'en_US:en', 12:27:31 INFO - 'LOGNAME': 'cltbld', 12:27:31 INFO - 'MAIL': '/var/mail/cltbld', 12:27:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:27:31 INFO - 'MOZ_NO_REMOTE': '1', 12:27:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:27:31 INFO - 'NO_EM_RESTART': '1', 12:27:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:27:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:27:31 INFO - 'PWD': '/builds/slave/test', 12:27:31 INFO - 'SHELL': '/bin/bash', 12:27:31 INFO - 'SHLVL': '1', 12:27:31 INFO - 'TERM': 'linux', 12:27:31 INFO - 'TMOUT': '86400', 12:27:31 INFO - 'USER': 'cltbld', 12:27:31 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1468610824.650182-239027312', 12:27:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:27:31 INFO - '_': '/tools/buildbot/bin/python'} 12:27:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:27:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:27:31 INFO - Running setup.py (path:/tmp/pip-3SJNrg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:27:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:27:31 INFO - Running setup.py (path:/tmp/pip-XGp_I7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:27:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:27:31 INFO - Running setup.py (path:/tmp/pip-3L2w9o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:27:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:27:31 INFO - Running setup.py (path:/tmp/pip-tFzOyt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:27:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:27:31 INFO - Running setup.py (path:/tmp/pip-RMxcs8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:27:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:27:31 INFO - Running setup.py (path:/tmp/pip-k2rR4i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:27:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:27:31 INFO - Running setup.py (path:/tmp/pip-p3GK7b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:27:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:27:31 INFO - Running setup.py (path:/tmp/pip-H1w1Br-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:27:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:27:31 INFO - Running setup.py (path:/tmp/pip-vVHMot-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:27:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:27:31 INFO - Running setup.py (path:/tmp/pip-THjmnm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:27:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:27:31 INFO - Running setup.py (path:/tmp/pip-yaQAQ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:27:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:27:32 INFO - Running setup.py (path:/tmp/pip-mNc27H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:27:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:27:32 INFO - Running setup.py (path:/tmp/pip-i7h1wu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:27:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:27:32 INFO - Running setup.py (path:/tmp/pip-6dF6HV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:27:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:27:32 INFO - Running setup.py (path:/tmp/pip-y5DP6S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:27:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:27:32 INFO - Running setup.py (path:/tmp/pip-pGIlna-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:27:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:27:32 INFO - Running setup.py (path:/tmp/pip-P05Zap-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:27:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:27:32 INFO - Running setup.py install for manifestparser 12:27:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:27:32 INFO - Running setup.py install for mozcrash 12:27:32 INFO - Running setup.py install for mozdebug 12:27:32 INFO - Running setup.py install for mozdevice 12:27:32 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:27:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:27:32 INFO - Running setup.py install for mozfile 12:27:32 INFO - Running setup.py install for mozhttpd 12:27:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:27:33 INFO - Running setup.py install for mozinfo 12:27:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:27:33 INFO - Running setup.py install for mozInstall 12:27:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:27:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:27:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:27:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:27:33 INFO - Running setup.py install for mozleak 12:27:33 INFO - Running setup.py install for mozlog 12:27:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:27:33 INFO - Running setup.py install for moznetwork 12:27:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:27:33 INFO - Running setup.py install for mozprocess 12:27:33 INFO - Running setup.py install for mozprofile 12:27:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:27:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:27:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:27:33 INFO - Running setup.py install for mozrunner 12:27:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:27:33 INFO - Running setup.py install for mozscreenshot 12:27:34 INFO - Running setup.py install for moztest 12:27:34 INFO - Running setup.py install for mozversion 12:27:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:27:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:27:34 INFO - Cleaning up... 12:27:34 INFO - Return code: 0 12:27:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:27:34 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')]} 12:27:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:27:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:27:34 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')]} 12:27:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:27:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:27:34 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 0x1ec8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x202b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2189180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21873b0>, '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 0x21882b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2188740>, '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': '41bf3e9aed84707956354da8000001c5-1468610824.650182-239027312', '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 12:27:34 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 12:27:34 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 12:27:34 INFO - Using env: {'DISPLAY': ':0', 12:27:34 INFO - 'HOME': '/home/cltbld', 12:27:34 INFO - 'LANG': 'en_US.UTF-8', 12:27:34 INFO - 'LANGUAGE': 'en_US:en', 12:27:34 INFO - 'LOGNAME': 'cltbld', 12:27:34 INFO - 'MAIL': '/var/mail/cltbld', 12:27:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:27:34 INFO - 'MOZ_NO_REMOTE': '1', 12:27:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:27:34 INFO - 'NO_EM_RESTART': '1', 12:27:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:27:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:27:34 INFO - 'PWD': '/builds/slave/test', 12:27:34 INFO - 'SHELL': '/bin/bash', 12:27:34 INFO - 'SHLVL': '1', 12:27:34 INFO - 'TERM': 'linux', 12:27:34 INFO - 'TMOUT': '86400', 12:27:34 INFO - 'USER': 'cltbld', 12:27:34 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1468610824.650182-239027312', 12:27:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:27:34 INFO - '_': '/tools/buildbot/bin/python'} 12:27:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:27:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:27:34 INFO - Running setup.py (path:/tmp/pip-O2Dk5k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:27:34 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)) 12:27:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:27:34 INFO - Running setup.py (path:/tmp/pip-6dUgEC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:27:34 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)) 12:27:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:27:34 INFO - Running setup.py (path:/tmp/pip-sCoRUv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:27:34 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)) 12:27:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:27:34 INFO - Running setup.py (path:/tmp/pip-P7dQzD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:27:34 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)) 12:27:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:27:34 INFO - Running setup.py (path:/tmp/pip-tsJeWl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:27:34 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)) 12:27:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:27:34 INFO - Running setup.py (path:/tmp/pip-qU3DKZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:27:34 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)) 12:27:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:27:34 INFO - Running setup.py (path:/tmp/pip-dXGpGI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:27:34 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)) 12:27:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:27:34 INFO - Running setup.py (path:/tmp/pip-pt6_5Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:27:35 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)) 12:27:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:27:35 INFO - Running setup.py (path:/tmp/pip-KdAJpb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:27:35 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)) 12:27:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:27:35 INFO - Running setup.py (path:/tmp/pip-IF4MsN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:27:35 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)) 12:27:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:27:35 INFO - Running setup.py (path:/tmp/pip-3Aqqc5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:27:35 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)) 12:27:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:27:35 INFO - Running setup.py (path:/tmp/pip-l36HWj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:27:35 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)) 12:27:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:27:35 INFO - Running setup.py (path:/tmp/pip-Ecs2Ia-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:27:35 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)) 12:27:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:27:35 INFO - Running setup.py (path:/tmp/pip-WhgkNT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:27:35 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)) 12:27:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:27:35 INFO - Running setup.py (path:/tmp/pip-x7XN9g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:27:35 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)) 12:27:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:27:35 INFO - Running setup.py (path:/tmp/pip-QyzjLe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:27:35 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)) 12:27:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:27:35 INFO - Running setup.py (path:/tmp/pip-7wFDt4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:27:35 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)) 12:27:35 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)) 12:27:35 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)) 12:27:35 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)) 12:27:35 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)) 12:27:35 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)) 12:27:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:27:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:27:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:27:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:27:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:27:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:27:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:27:37 INFO - Downloading blessings-1.6.tar.gz 12:27:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:27:37 INFO - Installing collected packages: blessings 12:27:37 INFO - Running setup.py install for blessings 12:27:37 INFO - Successfully installed blessings 12:27:37 INFO - Cleaning up... 12:27:37 INFO - Return code: 0 12:27:37 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:27:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:27:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:27:38 INFO - Reading from file tmpfile_stdout 12:27:38 INFO - Current package versions: 12:27:38 INFO - argparse == 1.2.1 12:27:38 INFO - blessings == 1.6 12:27:38 INFO - blobuploader == 1.2.4 12:27:38 INFO - docopt == 0.6.1 12:27:38 INFO - functools32 == 3.2.3-2 12:27:38 INFO - jsonschema == 2.5.1 12:27:38 INFO - manifestparser == 1.1 12:27:38 INFO - mozInstall == 1.12 12:27:38 INFO - mozcrash == 0.17 12:27:38 INFO - mozdebug == 0.1 12:27:38 INFO - mozdevice == 0.48 12:27:38 INFO - mozfile == 1.2 12:27:38 INFO - mozhttpd == 0.7 12:27:38 INFO - mozinfo == 0.9 12:27:38 INFO - mozleak == 0.1 12:27:38 INFO - mozlog == 3.2 12:27:38 INFO - moznetwork == 0.27 12:27:38 INFO - mozprocess == 0.23 12:27:38 INFO - mozprofile == 0.28 12:27:38 INFO - mozrunner == 6.12 12:27:38 INFO - mozscreenshot == 0.1 12:27:38 INFO - mozsystemmonitor == 0.3 12:27:38 INFO - moztest == 0.7 12:27:38 INFO - mozversion == 1.4 12:27:38 INFO - psutil == 3.1.1 12:27:38 INFO - requests == 1.2.3 12:27:38 INFO - wsgiref == 0.1.2 12:27:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:27:38 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')]} 12:27:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:27:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:27:38 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')]} 12:27:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:27:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:27:38 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 0x1ec8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x202b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2189180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21873b0>, '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 0x21882b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2188740>, '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': '41bf3e9aed84707956354da8000001c5-1468610824.650182-239027312', '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 12:27:38 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 12:27:38 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 12:27:38 INFO - Using env: {'DISPLAY': ':0', 12:27:38 INFO - 'HOME': '/home/cltbld', 12:27:38 INFO - 'LANG': 'en_US.UTF-8', 12:27:38 INFO - 'LANGUAGE': 'en_US:en', 12:27:38 INFO - 'LOGNAME': 'cltbld', 12:27:38 INFO - 'MAIL': '/var/mail/cltbld', 12:27:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:27:38 INFO - 'MOZ_NO_REMOTE': '1', 12:27:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:27:38 INFO - 'NO_EM_RESTART': '1', 12:27:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:27:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:27:38 INFO - 'PWD': '/builds/slave/test', 12:27:38 INFO - 'SHELL': '/bin/bash', 12:27:38 INFO - 'SHLVL': '1', 12:27:38 INFO - 'TERM': 'linux', 12:27:38 INFO - 'TMOUT': '86400', 12:27:38 INFO - 'USER': 'cltbld', 12:27:38 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1468610824.650182-239027312', 12:27:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:27:38 INFO - '_': '/tools/buildbot/bin/python'} 12:27:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:27:38 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)) 12:27:38 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)) 12:27:38 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)) 12:27:38 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)) 12:27:38 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)) 12:27:38 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)) 12:27:38 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)) 12:27:38 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)) 12:27:38 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)) 12:27:38 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)) 12:27:38 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)) 12:27:38 INFO - Cleaning up... 12:27:38 INFO - Return code: 0 12:27:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:27:38 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')]} 12:27:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:27:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:27:38 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')]} 12:27:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:27:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:27:38 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 0x1ec8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x202b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2189180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21873b0>, '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 0x21882b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2188740>, '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': '41bf3e9aed84707956354da8000001c5-1468610824.650182-239027312', '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 12:27:38 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 12:27:38 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 12:27:38 INFO - Using env: {'DISPLAY': ':0', 12:27:38 INFO - 'HOME': '/home/cltbld', 12:27:38 INFO - 'LANG': 'en_US.UTF-8', 12:27:38 INFO - 'LANGUAGE': 'en_US:en', 12:27:38 INFO - 'LOGNAME': 'cltbld', 12:27:38 INFO - 'MAIL': '/var/mail/cltbld', 12:27:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:27:38 INFO - 'MOZ_NO_REMOTE': '1', 12:27:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:27:38 INFO - 'NO_EM_RESTART': '1', 12:27:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:27:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:27:38 INFO - 'PWD': '/builds/slave/test', 12:27:38 INFO - 'SHELL': '/bin/bash', 12:27:38 INFO - 'SHLVL': '1', 12:27:38 INFO - 'TERM': 'linux', 12:27:38 INFO - 'TMOUT': '86400', 12:27:38 INFO - 'USER': 'cltbld', 12:27:38 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1468610824.650182-239027312', 12:27:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:27:38 INFO - '_': '/tools/buildbot/bin/python'} 12:27:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:27:38 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:27:38 INFO - Cleaning up... 12:27:38 INFO - Return code: 0 12:27:38 INFO - Running post-action listener: _resource_record_post_action 12:27:38 INFO - Running post-action listener: _start_resource_monitoring 12:27:38 INFO - Starting resource monitoring. 12:27:38 INFO - ##### 12:27:38 INFO - ##### Finished create-virtualenv step (success) 12:27:38 INFO - ##### 12:27:38 INFO - ##### 12:27:38 INFO - ##### Running install step. 12:27:38 INFO - ##### 12:27:38 INFO - Running pre-action listener: _resource_record_pre_action 12:27:38 INFO - Running main action method: install 12:27:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:27:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:27:38 INFO - Reading from file tmpfile_stdout 12:27:38 INFO - Detecting whether we're running mozinstall >=1.0... 12:27:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:27:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:27:38 INFO - Reading from file tmpfile_stdout 12:27:38 INFO - Output received: 12:27:38 INFO - Usage: mozinstall [options] installer 12:27:38 INFO - Options: 12:27:38 INFO - -h, --help show this help message and exit 12:27:38 INFO - -d DEST, --destination=DEST 12:27:38 INFO - Directory to install application into. [default: 12:27:38 INFO - "/builds/slave/test"] 12:27:38 INFO - --app=APP Application being installed. [default: firefox] 12:27:38 INFO - mkdir: /builds/slave/test/build/application 12:27:38 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'] 12:27:38 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 12:27:56 INFO - Reading from file tmpfile_stdout 12:27:56 INFO - Output received: 12:27:56 INFO - /builds/slave/test/build/application/firefox/firefox 12:27:56 INFO - Running post-action listener: _resource_record_post_action 12:27:56 INFO - ##### 12:27:56 INFO - ##### Finished install step (success) 12:27:56 INFO - ##### 12:27:56 INFO - ##### 12:27:56 INFO - ##### Running run-tests step. 12:27:56 INFO - ##### 12:27:56 INFO - Running pre-action listener: _resource_record_pre_action 12:27:56 INFO - Running main action method: run_tests 12:27:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:27:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:27:56 INFO - Python 2.7.3 12:27:56 INFO - Return code: 0 12:27:56 INFO - grabbing minidump binary from tooltool 12:27:56 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')]} 12:27:56 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 0x21873b0>, '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 0x21882b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2188740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:27:56 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 12:27:56 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 12:27:56 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 12:27:56 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:27:56 INFO - Return code: 0 12:27:56 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:27:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:27:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:27:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:27:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:27:56 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/b6ou9dPDQpalcDoAEKkR8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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 12:27:56 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/b6ou9dPDQpalcDoAEKkR8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-026 --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 12:27:56 INFO - Using env: {'DISPLAY': ':0', 12:27:56 INFO - 'HOME': '/home/cltbld', 12:27:56 INFO - 'LANG': 'en_US.UTF-8', 12:27:56 INFO - 'LANGUAGE': 'en_US:en', 12:27:56 INFO - 'LOGNAME': 'cltbld', 12:27:56 INFO - 'MAIL': '/var/mail/cltbld', 12:27:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:27:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:27:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:27:56 INFO - 'MOZ_NO_REMOTE': '1', 12:27:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:27:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:27:56 INFO - 'NO_EM_RESTART': '1', 12:27:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:27:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:27:56 INFO - 'PWD': '/builds/slave/test', 12:27:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:27:56 INFO - 'SHELL': '/bin/bash', 12:27:56 INFO - 'SHLVL': '1', 12:27:56 INFO - 'TERM': 'linux', 12:27:56 INFO - 'TMOUT': '86400', 12:27:56 INFO - 'USER': 'cltbld', 12:27:56 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1468610824.650182-239027312', 12:27:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:27:56 INFO - '_': '/tools/buildbot/bin/python'} 12:27:56 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/b6ou9dPDQpalcDoAEKkR8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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 12:27:56 INFO - mozversion application_buildid: 20160715101139 12:27:56 INFO - mozversion application_changeset: 4e3c16ea8fced03ab4ef572f16d4aa4464981e2c 12:27:56 INFO - mozversion application_display_name: Nightly 12:27:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:27:56 INFO - mozversion application_name: Firefox 12:27:56 INFO - mozversion application_remotingname: firefox 12:27:56 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 12:27:56 INFO - mozversion application_vendor: Mozilla 12:27:56 INFO - mozversion application_version: 50.0a1 12:27:56 INFO - mozversion platform_buildid: 20160715101139 12:27:56 INFO - mozversion platform_changeset: 4e3c16ea8fced03ab4ef572f16d4aa4464981e2c 12:27:56 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 12:27:56 INFO - mozversion platform_version: 50.0a1 12:27:56 INFO - using testdate: 1468610876 12:27:56 INFO - actual date: 1468610876 12:27:56 INFO - starting webserver on 'localhost:38119' 12:27:56 INFO - SUITE-START | Running 2 tests 12:27:56 INFO - TEST-START | dromaeo_css 12:27:56 INFO - operating with platform_type : linux_ 12:27:56 INFO - Initialising browser for dromaeo_css test... 12:27:56 INFO - TEST-INFO | started process 3829 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8P9crT/profile http://localhost:38119/getInfo.html) 12:28:00 INFO - PROCESS | 3829 | __metrics Screen width/height:1600/1200 12:28:00 INFO - PROCESS | 3829 | colorDepth:24 12:28:00 INFO - PROCESS | 3829 | Browser inner width/height: 1024/697 12:28:00 INFO - PROCESS | 3829 | __metrics 12:28:01 INFO - PROCESS | 3829 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:28:02 INFO - TEST-INFO | 3829: exit 0 12:28:02 INFO - Browser initialized. 12:28:02 INFO - Running cycle 1/1 for dromaeo_css test... 12:28:02 INFO - TEST-INFO | started process 3911 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8P9crT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:28:13 INFO - PROCESS | 3911 | RSS: Main: 157491200 12:28:13 INFO - PROCESS | 3911 | 12:29:05 INFO - PROCESS | 3911 | 1468610945596 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] 12:31:13 INFO - PROCESS | 3911 | Cycle 1(1): loaded http://localhost:38119/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38119/tests/dromaeo/cssquery-ext.html) 12:31:14 INFO - PROCESS | 3911 | RSS: Main: 289853440 12:31:14 INFO - PROCESS | 3911 | 12:34:17 INFO - PROCESS | 3911 | Cycle 1(1): loaded http://localhost:38119/tests/dromaeo/cssquery-ext.html (next: http://localhost:38119/tests/dromaeo/cssquery-jquery.html) 12:34:17 INFO - PROCESS | 3911 | RSS: Main: 239693824 12:34:17 INFO - PROCESS | 3911 | 12:37:19 INFO - PROCESS | 3911 | Cycle 1(1): loaded http://localhost:38119/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38119/tests/dromaeo/cssquery-mootools.html) 12:37:20 INFO - PROCESS | 3911 | RSS: Main: 242192384 12:37:20 INFO - PROCESS | 3911 | 12:40:22 INFO - PROCESS | 3911 | Cycle 1(1): loaded http://localhost:38119/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38119/tests/dromaeo/cssquery-prototype.html) 12:40:23 INFO - PROCESS | 3911 | RSS: Main: 240025600 12:40:23 INFO - PROCESS | 3911 | 12:43:25 INFO - PROCESS | 3911 | Cycle 1(1): loaded http://localhost:38119/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38119/tests/dromaeo/cssquery-yui.html) 12:43:26 INFO - PROCESS | 3911 | RSS: Main: 227188736 12:43:26 INFO - PROCESS | 3911 | 12:46:29 INFO - PROCESS | 3911 | Cycle 1(1): loaded http://localhost:38119/tests/dromaeo/cssquery-yui.html (next: http://localhost:38119/tests/dromaeo/cssquery-dojo.html) 12:46:29 INFO - PROCESS | 3911 | RSS: Main: 285937664 12:46:29 INFO - PROCESS | 3911 | 12:46:29 INFO - PROCESS | 3911 | __start_tp_report 12:46:29 INFO - PROCESS | 3911 | _x_x_mozilla_page_load 12:46:29 INFO - PROCESS | 3911 | _x_x_mozilla_page_load_details 12:46:29 INFO - PROCESS | 3911 | |i|pagename|runs| 12:46:29 INFO - PROCESS | 3911 | |0;dojo.html;3053.832039237842;3078.5843911071997;3104.5498402731605;3112.4708799504083;3126.2809553802626;5347.1177255752855;5376.247325374446;5390.838274851756;5448.128299472085;5464.0711079116545;5335;5359.598030147735;5437.782488700447;5462.863428414292;5465.207544905987;4814.879628009301;4859.198232291667;4861.489543597924;4939.086269040221;5031.874203144914;4904.5340692634145;4923.236898280755;5028.647994640377;5041.621878359119;5053.36832895888;4858.052679727454;4902.044101400228;4929.728864912428;4969.080720066781;5021.573166280852;4851.611871050308;4860.125177468054;4863.392075990501;4867.8783030424165;4923.040007198598;4843.782029808667;4884.780184891689;4891.070696567676;4897.534734200245;4931.408231012266;5315.681059136464;5320.574354051667;5344.412114667383;5427.728613569345;5430.158325459521;5749.798757043483;5807.925533776222;5815.709214539298;5818.156367326714;5824.825255242349;5789.884202315972;5841.357450680422;5850.3564607893095;5855.473007429309;5857.85355366115;5268.683878967274;5304;5364.329458817648;5440.700761458118;5442.183672449164;5919.082542205965;5939.13882487037;5940.524758019348;5941.881162376728;5947.702614869239;5623.493885550239;5644.125160600113;5682.40334764852;5692.23154874095;5699.772009119672;5667.234923285304;5676.205331253628;5749.223854779635;5753.51095156908;5784.566157538117;5738.8278351649515;5744.655320680772;5746.138079288056;5746.942530574641;5750.482456578844;5698.202251684767;5722.971385143048;5726.3700992890745;5735.8852822944145;5747.942520574825;4337.8481753138485;4376.256036473807;4381.605655490957;4418.580234877746;4423.358613001161;3924.372100463912;3926.2130704578453;3927.666148377363;3966.087799806061;3971.7616942983514;5427.348718153847;5487.6981766003255;5487.972560137254;5490.478404551562;5490.752916118784;5694.715264236772;5779.450952159538;5794;5848.035074212792;5858.853528661817;5495.917561236584;5499.890002199933;5502.9174562381595;5505.03661859173;5507.862303442366;4780.330753694486;4889.144399730033;4896.706197628154;4902.558769710672;4948.826791062295;5943.375945525744;6039.78860739872;6040.486558642477;6045.425684559959;6061.121137435047;5830.5044071254415;5841.065429531254;5841.824745257649;5848.152017957287;5849.1226316052935;5874.412558744091;6010.4891084258325;6044.0933859919605;6058.182145410489;6062.666553339609;5764.625299355528;5776.942230577641;5782.739776709974;5792.4497172768515;5847.473727364558;5764.625299355528;5843.211166492639;5845.09401042839;5863.560232982458;5874.089516125007;5506.2841830563375;5587.636803607753;5681.431856814285;5700.315962084576;5707.828765137053;5684.431556844283;5696.088625819849;5696.515796157208;5698.116791897262;5742.7702891883855;5584.441555844383;5628.296462942132;5642.943570564242;5646.0683987141665;5649.322081350264;5569.610127291213;5685.175649530877;5725.599208055396;5775.393583673822;5776.884462310814;5480.287562616834;5534.557235421076;5543.445655434424;5564.721763911707;5627.7467513961155 12:46:29 INFO - PROCESS | 3911 | |1;ext.html;587.0929414055284;622.212900680639;626.8307556959621;634.7238951056291;643.6749441532025;42884;44337.99999999992;44401;44471.5552844471;48074.27888581674;45191.09617807642;45525.54474455263;45592.3161152583;45656.08687826242;45690.543094569126;8109.878351824727;9055.909440905589;9203.309751768644;9210.171084602385;10685.145188384911;10578;10987.670369888916;11019.228653994223;11021.559137634486;11024.944875275613;11081.556737730481;11115.221934464591;11132.443377831116;11138.610148644799;11140.33158010518;8322.791930201733;8487.40588158829;10917.23579349446;10982.615608453705;11176.664700059011;10596.205284603686;10995.835062474069;11001.394923279217;11011.944940275247;11016.283941543774;42068.579314207076;42539.36190957138;42582.78708606468;42599;42616.147677046596;2952.985235073811;3798.5631652360057;3826.885193444201;3907.6924608210625;4108.4864391951005;32312.5153122701;33123.171920701934;33201;33490.83254583736;34899.6510034899;4426.822927082912;4457.398251236074;4495.483019452739;4524.434445694288;4589.875480507264;353470;354110.99999999744;355387.44612553803;355431;356910;63033.36966630367;63512;63544.68227658832;63574.68212658907;63621.36378636247;36540.81729591335;37326.62673373286;37365.626343736214;38941.221175576895;67646.66176669086;17287.82712172862;17377.73933391;17426.564335891704;17444.651106978043;17468.5632859177;12053.457594408274;13111.803322950163;13290.933545332211;13333.399997000159;13522.391492382867;20893.89553052225;20934.58130837375;20993.16027358919;21078.262260820797;21195.78804211938;7697.538147711155;7935.960320198362;7969;7969.521828690297;7974.641141148662;998.236349192868;1027.5222021759917;1094.6497120921229;1145.450183911727;1146.4668928948079;33002.83498582492;33505;33556.1610959728;33721.15697107592;34302.485462718076;1069.0111646726746;1144.8282757586428;1164.9825252621217;1169.7309618787726;1239.6776440155315;17603.647927041642;17622.471325860246;17654.470365889043;17692.734608980874;17748.112594370228;574611;585975;587504;588320;589080;59172.40827591755;59707.70146149241;59718.70140649269;59732;59758.701206493686;1244.2783185752423;1296.5397283964057;1339.7789364754901;1388.8263967004125;1395.2465668539078;30098.920863309704;34039.65960340365;34109.14727131841;34236.82881585576;34558.82720586381;50756.238656419446;50909.74545127251;51433.74283128561;51441;51473.22790158076;400852;401161;401435;401987;402054;25309.367265818502;27702.584461233502;28186.2953426166;28824.279393015342;29010.27474313159;48933;48985.265221022426;49484;49771.75114124551;50353.74823125861;38532.614673852906;41635;42367.3644895333;42425;42975.355369670106;41416.37875431931;41661.166776664904;42029.78985105055;42131;42344;41863.50860321088;42381.576184239;42582.787086064374;42907.78546107374;43203.35194972015;35414.82292588521;37827.810860945516;38604;38683.80658096691;38884.80557597307;28966.27584310409;28979.710202897702;29324.560131597616;29364.559531606617;29500.704992950654 12:46:29 INFO - PROCESS | 3911 | |2;jquery.html;394.5462717874446;395.18788888833456;395.76254247451516;405.7606012452652;411.808509043295;14465.783013254782;18943.147558359873;19253.711194332096;20292.797072029294;20316.492087697814;15018.249087545633;18253.90873045636;18622.720659190123;19292.3247686331;19953.501162470944;5978.163057171989;6128.356522565134;6146.047362658773;6156;6157.168782214411;4277.935830962538;6114.2357205349335;6149.600275982069;6606.570572912769;6944.201416837078;7002.229754727002;7009.544379615334;7052.224255331909;7056.1179852518435;7063.399611033043;6710.396064354207;6932.7226910923755;6935.133108361455;6935.167779866398;6941.618210998393;6265.091561723524;6449.419552240321;6458.93541064588;6517.902231466532;6527.673616319165;20445.386638400872;20587.279445219345;22101.33695989123;23251.651225231635;23853.88073059641;2447.853128812259;2470.876456177184;2480.8759562022005;2563.9871800640876;2609.2172348295435;14599.635009124751;14796.70406591862;15186;15217.239138043053;15597.064176149468;2003.2688068854764;2068.2657656531865;2081.8126368626745;2083.6041152181037;2185.071344678521;92483.53758231233;93024.53487732586;95000.52499737527;95205.5239723797;95950.52024739832;14163.459135216195;14186.71626567463;14207.71584568303;14267.64330891736;14289.285535723173;11099.44502774858;21850.562988740137;21883.12467501314;21909.342719718436;21963.780362196172;7489.28851759082;7716.92283077162;7792.142864284924;7882.448228623941;7882.645280962371;7035.085438892911;8312.5428101455;8388.8741668875;8498.320134389234;8499.872501912476;4481.887952801141;4650.767461626905;4748.525147485224;4770.7596025033745;4825.1555977703765;1885.2741694447461;1936.6998115292151;1970.4581240158784;1971.3790156100783;1995.9900200499194;911.3301723233418;931.38993958957;936.7423958411355;990.3265779270022;1041.57295508841;18707.812921870605;18780;19786.33540372671;20088.799112008986;20235.19059237614;987.8863930648067;999.8550210219478;1006.4917216805612;1006.9395836249848;1051.9000694933968;10600.469976501145;10688.412137332522;10997.945010274898;11081.889181108085;11082.722931926766;484458;505983;512622;516398.4180079076;518889;91306.54346728224;91491.54254228686;93029.5348523253;93335.53332233295;102146;1007.6271779441654;1020.1838529176778;1059.1579694143174;1067.503610820972;1067.503610820972;17819.910900445415;17843.553911152325;18321.3587524436;18522.259109635463;18808.905955470134;41876;44724.32913506235;44820.55179448164;45111.774441127585;45324.09351813011;61977.69011154916;62681.68659156675;63673;64734.35265647283;64834.675826620565;6141.07883817431;6785.1518560179975;8350.164983501601;8725.607347669496;8778.956105219433;11286.266392684449;13052.869471305545;13583.52457663977;13756.65608359799;13890.444382225001;11702.88297117018;11877.46551405206;12019.939900300442;12078.094142939139;12150.817737733763;11691.240069395462;11770.3526306054;11841;12028.699282518008;12102.878971210528;11458.94270528642;11647.417629118341;12118.939405302917;12225.44985475638;12250.142490025613;8367.748967530984;8414.158584141536;8446.831063378575;8461.40770146084;8478.448900821428;11181.440927953407;11227.326360418401;11582.131340149692;11638.476268567765;11646.184767066225 12:46:29 INFO - PROCESS | 3911 | |3;mootools.html;1333.4999375234288;1450.4633285684295;1484.1169504145034;1563.4918651438286;1739.3216645508253;8098.514089154647;8497.532635705034;8523.616437260323;8725.694600688978;8747.12528747125;8526.104759000309;8526.87209691855;8549.658013679446;8623.267022303111;8655.610497527627;2004.8897310647908;2232.8660280383147;2312.1098377124845;2341.8243631727605;2341.988290058547;2316.073570571768;2329.860208387502;2337.8947947342413;2339.2982105368405;2345.0502546468706;2296.9770302297015;2319.512902290521;2321.976780232193;2322.907083716649;2339.6958395408574;1966.8918209498472;2152.9354119376444;2216.0581752755015;2225.143319821864;2227.610168220563;2255.0979608156704;2268.65970104484;2270.5345404192103;2271.8864056797092;2274.465500607356;8524.914750852475;8592.441491303045;8601.31189504838;8601.526916019617;8604.52675102869;4943.802247910079;5062.063518249136;5066.392032956032;5069.999999999963;5072.873178170538;3248.512723091555;3310.5034244863223;3390.1524618845287;3410.352033113725;3411.9764070778665;1107.213878146517;1121.9887801122047;1123.617969890233;1125.881782412843;1127.520803658442;11898.107641926803;11905.107116966263;11925.463354149084;11940.104492163122;11943.044556435465;4410.647148228134;4433.268510695763;4611.100835337077;4615.3999980003055;4625.907481850411;10126.493675316206;10126.949365253275;10140.847887281696;10163.4918254087;10172.338797978107;5121.948780512147;5131.640785145079;5147.819826306061;5162.096633089194;5170.508801663836;4257.254980378421;4431.446069241345;4513.458384993756;4526.366308716782;4728.88177795551;3877.0501227199516;3987.980060099739;4003.559608443069;4025;4065.308897487434;1190.6487586162102;1287.3241548187088;1293.9223646581236;1305.8563558008611;1316.486570237608;879.5514287713185;946.8674385585886;962.3504134709043;998.7103739915489;1021.2697920986382;5771.480566749013;5803.854903627359;5824.301083869878;5888.646681199141;6020.9162350776405;942.2556180617372;943.1464524605243;949.8290307744672;953.0802775321848;964.7346979580672;4206.684498662551;4255.1915136124035;4283.914321713611;4285.657147428198;4319.3952846601505;10383.688489345332;10552.894471055344;10799.082078023455;10807.783844323227;10819.13446924244;10682.465876706134;10687.41219232934;10695.893041069645;10696.732581685364;10700.78598428027;7669.079710434784;8034.196580341919;8044.115147333789;8052.315553177928;8178.631961561625;5856.326522449973;5966.731497082728;6016.161936263351;6055.485283750931;6085.604435711664;9968.451735154636;10016.549255283675;10125.64560240388;10132.138768204784;10137.543810528692;9805.2646051545;10043.799124017625;10330.225233107698;10346.172306215636;10505.212109091695;7224.89162662571;7868.84262314762;7915.0897646771355;8029.197080292158;8200.302974247255;8314.584270786558;8493.787655308419;8522.957385213282;8576.699815506427;8580.485170889766;7459.37226161084;7686.769396918102;7705.267999540035;7730;7777.144514103557;7434.33091021789;7515.8496830061995;7567.508111972704;7611.238876112345;7647.923520764721;6955.234924158237;6980.6509674515055;7011.878099504259;7020.964895175695;7025.613591252531;4838.153323168361;5074.3657042869645;5149.948500514947;5189.714565698923;5237.502437268454;5072.492750724898;5087.23691446286;5102.209157580581;5182.352205974254;5239.790408383775 12:46:29 INFO - PROCESS | 3911 | |4;prototype.html;304.6953046953047;317.6569305150437;320.1675643327349;324.5261917600304;326.0755757427692;5306.336707911511;5344.385395679493;5395.406505284421;5423.888102938898;5440.564754819615;5332.866678333034;5341.626086173969;5341.866453338668;5346.27825243593;5360.142377219646;4156.044109854735;4159.168166366723;4159.604837540429;4163.3130533461945;4174.248635245654;4055.1484188320487;4152.460180176573;4163.7501749894955;4171.124063946575;4173.979130104361;4108.4864391951005;4114.074333275019;4125.628693417591;4132.400801883725;4133.2353514599745;4115.670746340301;4116.320807066861;4119.073208528087;4125.133721918401;4128.710990230685;3636.672699457035;3650.671439570425;3657.4513822926506;3663.084228942764;3666.2850744104912;5124.385073791132;5202.141646628302;5205.219217117463;5209.400918894337;5226.216067589854;4695.7886895089805;4726.503717109723;4732.266498692708;4736;4755.262934245197;5391.892162156774;5496.993597336983;5497.773401772289;5498.725063746797;5504.779808807642;3979.144483935968;3984.1234928315725;3984.963909383552;3992.1416895367634;3997.98001009996;5455.809046683386;5609.4390560943575;5743.425657434265;5744.587273345205;5758.48173664368;3917.7061720370516;3952.6245006724316;3956.2878681837547;3956.467860569238;4065.2559522322313;4099.467069280974;4131.132462182975;4132.194222126656;4137.937930931039;4141.7722025288895;4548.545145485491;4693.530646935279;4705;4716.3632909557455;4725.220338644154;5305.62860599762;5466.289382380344;5466.535344495763;5467.2663668165915;5562.638428502134;1366.7425968109164;1393.171063217384;1415.8177921435718;1419.90667186266;1431.799548063272;938.643315540104;970.6069042037985;973.6056896956744;975.9853602195973;985.4530735441898;5300.655457395257;5322.175062865262;5350.705711185922;5351.876106017702;5369.060414427459;5615.326160860641;5627.5779316551425;5631.943680563142;5634.32388113429;5656.575756818255;5182.455842136596;5324.227986941872;5336.46635336471;5337.172738225581;5348.090824559834;2664.2292016303213;2672.0647773279584;2672.719364466742;2693.878775455109;2721.1972468121558;5189.42916279209;5199.246109314128;5205.817796377184;5213.843584692465;5277.788888444419;4834.709917404896;5096.923546146811;5110;5152.278680984665;5173.741312934339;5131.435542090367;5139.665921715076;5160.7419629018395;5183.714895680774;5256.448072952285;4995.575376092927;5014.34813474246;5031.6226283029655;5056.786371270795;5060.9119039406705;4683.625309975262;4901.456041346964;4910.453207239708;5000.899622158775;5041.697688014357;5127.154019586876;5146.459621739664;5153.7165455898785;5216.634835561475;5235.764390602356;3664;3686.0006892521915;3691.5016472776906;3695.796731179811;3703.1300741925224;5097.986295413365;5332.920006199833;5578.246936663661;5587.916181257366;5831.504322132666;5544.417836127149;5580.414056524007;5594.6502468963945;5627.352854421631;5632.239647647515;5523.972380138073;5558.805441809517;5575.8884822304135;5582.413846546055;5631.7184140793615;5283.788648454019;5525.254090697865;5572.219889215432;5586.497215250647;5589.580781441489;5638.182463542846;5642.576806739593;5658.151277308437;5671.432856714296;5673.659580425187;5418.891622167455;5428.0620378325875;5540.833774986757;5552.305961754781;5560.666360018412 12:46:29 INFO - PROCESS | 3911 | |5;yui.html;776.7630872583862;796.8685166947454;817.6524976884826;849.2950850793837;860;15893.205339733011;17227.483175504723;17252.39616613419;17274.827251727464;17295.30818767251;13950.720985580283;14066.859331406682;14183;14194.858051419482;14676.559703208894;802.1096582793109;809.1180613131685;817.480899628737;818.0265484073963;818.4516374029415;658.6838317607551;776.0377132355894;819.4345901328095;822.3421262989614;822.6092606012156;825.8100636853527;855.687673998989;859.5959898847532;860.3934226370425;861.6811779641541;851.3104385447807;851.9488830670149;853.564682012172;854.0818619983543;854.5599016506504;501.420525345162;596.582392325374;603.1856993059379;616.4236438929615;618.5762752514497;15369.923150384288;15375.384984600603;15401.306941187673;15422.845771542365;15457.227138643022;14021.64945876351;14716.705665886622;14841.406343746237;14963.925180374137;15045.398184072625;13536.796948045787;13658.453661853513;13815.240161791098;13882.375293111834;14312.21282829444;4603.401557797499;4618.607418369443;4630.4443466784205;4716.787744551503;4816.54242846929;77390;77738.6113069431;78161.60919195424;78183.8272425914;81629.59185204036;11205.60780372683;11247.606333778278;11502;11620.53517859293;11889.464974076187;22490.100395983976;22518;22558;22568;22581.09675612957;8776.736697899074;8827.911720882837;8867.334949878785;8987.146221108984;9007.144321289466;4824.204006338915;4825.5174482551465;4972.252169895173;4996.975015124901;5158.845234642967;3587.5336206293014;3724.832382542792;3736.831842567091;3744.8127593620757;3748.3815170496564;639.0478187500684;644.4811926399293;644.8387903024244;649.7076315657878;652.1359199061168;700.4626635490752;713.7715930902166;724.9855002900018;728.1189760389988;749.6926260233278;9422;9445.716628501155;9608.327417080876;9863.260255480867;9883.851742223873;584.8245526342081;674.5530836356087;684.2780866186222;726.0126228329468;729.1177675013294;4674.298855171752;4720.150372932905;4850.805967761321;4955.8017679292425;4956.355673762388;108806;115559.42220288845;116070;118351.40824295823;119497;59865.700671496365;93613;97055.51472242594;97097;98122;80156.59921700355;85781.57109214414;88423;89445.55277223572;90577.30092942173;9154.633814647339;9167.908320916706;9252.583633736363;9305.302102342486;9348.1119293667;51650;53167.734161328946;53776.46223537715;54222;56645.71677141588;68424;68550.42110866301;69582;75610.6219468899;77077.61461192658;12159.939200303941;12419.75160496803;12487.625371238877;13031.02267329973;14512.492062777752;15780.68438631244;16137.743094264833;16154.1115238663;16313.67372652564;16423;15040.398384064514;15147.54557363281;15322;15432.382704691687;15735.741140708944;14819;14941.626459338604;15308.846911530742;15362.385504579692;15833.762493562836;13618.18290902549;14019.50931717385;14112.858871411565;14113.2943352834;14161.221132837793;11507.827382589101;11681.941590291994;11848.170628055954;12154.878451215729;12173.756524869275;11386.658400248005;11957.581484647995;12041.939790301343;12096.818547721967;12420.875791241971 12:46:29 INFO - PROCESS | 3911 | __end_tp_report 12:46:29 INFO - PROCESS | 3911 | __start_cc_report 12:46:29 INFO - PROCESS | 3911 | _x_x_mozilla_cycle_collect,1100 12:46:29 INFO - PROCESS | 3911 | __end_cc_report 12:46:29 INFO - PROCESS | 3911 | __startTimestamp1468611989608__endTimestamp 12:46:29 INFO - PROCESS | 3911 | 12:46:29 INFO - PROCESS | 3911 | ------- Summary: start ------- 12:46:29 INFO - PROCESS | 3911 | Number of tests: 6 12:46:29 INFO - PROCESS | 3911 | 12:46:29 INFO - PROCESS | 3911 | [#0] dojo.html Cycles:165 Average:5375.93 Median:5587.64 stddev:624.43 (11.2%) stddev-sans-first:599.18 12:46:29 INFO - PROCESS | 3911 | Values: 3053.8 3078.6 3104.5 3112.5 3126.3 5347.1 5376.2 5390.8 5448.1 5464.1 5335.0 5359.6 5437.8 5462.9 5465.2 4814.9 4859.2 4861.5 4939.1 5031.9 4904.5 4923.2 5028.6 5041.6 5053.4 4858.1 4902.0 4929.7 4969.1 5021.6 4851.6 4860.1 4863.4 4867.9 4923.0 4843.8 4884.8 4891.1 4897.5 4931.4 5315.7 5320.6 5344.4 5427.7 5430.2 5749.8 5807.9 5815.7 5818.2 5824.8 5789.9 5841.4 5850.4 5855.5 5857.9 5268.7 5304.0 5364.3 5440.7 5442.2 5919.1 5939.1 5940.5 5941.9 5947.7 5623.5 5644.1 5682.4 5692.2 5699.8 5667.2 5676.2 5749.2 5753.5 5784.6 5738.8 5744.7 5746.1 5746.9 5750.5 5698.2 5723.0 5726.4 5735.9 5747.9 4337.8 4376.3 4381.6 4418.6 4423.4 3924.4 3926.2 3927.7 3966.1 3971.8 5427.3 5487.7 5488.0 5490.5 5490.8 5694.7 5779.5 5794.0 5848.0 5858.9 5495.9 5499.9 5502.9 5505.0 5507.9 4780.3 4889.1 4896.7 4902.6 4948.8 5943.4 6039.8 6040.5 6045.4 6061.1 5830.5 5841.1 5841.8 5848.2 5849.1 5874.4 6010.5 6044.1 6058.2 6062.7 5764.6 5776.9 5782.7 5792.4 5847.5 5764.6 5843.2 5845.1 5863.6 5874.1 5506.3 5587.6 5681.4 5700.3 5707.8 5684.4 5696.1 5696.5 5698.1 5742.8 5584.4 5628.3 5642.9 5646.1 5649.3 5569.6 5685.2 5725.6 5775.4 5776.9 5480.3 5534.6 5543.4 5564.7 5627.7 12:46:29 INFO - PROCESS | 3911 | 12:46:29 INFO - PROCESS | 3911 | [#1] ext.html Cycles:180 Average:61248.99 Median:21179.75 stddev:121534.63 (573.8%) stddev-sans-first:121790.22 12:46:29 INFO - PROCESS | 3911 | Values: 587.1 622.2 626.8 634.7 643.7 42884.0 44338.0 44401.0 44471.6 48074.3 45191.1 45525.5 45592.3 45656.1 45690.5 8109.9 9055.9 9203.3 9210.2 10685.1 10578.0 10987.7 11019.2 11021.6 11024.9 11081.6 11115.2 11132.4 11138.6 11140.3 8322.8 8487.4 10917.2 10982.6 11176.7 10596.2 10995.8 11001.4 11011.9 11016.3 42068.6 42539.4 42582.8 42599.0 42616.1 2953.0 3798.6 3826.9 3907.7 4108.5 32312.5 33123.2 33201.0 33490.8 34899.7 4426.8 4457.4 4495.5 4524.4 4589.9 353470.0 354111.0 355387.4 355431.0 356910.0 63033.4 63512.0 63544.7 63574.7 63621.4 36540.8 37326.6 37365.6 38941.2 67646.7 17287.8 17377.7 17426.6 17444.7 17468.6 12053.5 13111.8 13290.9 13333.4 13522.4 20893.9 20934.6 20993.2 21078.3 21195.8 7697.5 7936.0 7969.0 7969.5 7974.6 998.2 1027.5 1094.6 1145.5 1146.5 33002.8 33505.0 33556.2 33721.2 34302.5 1069.0 1144.8 1165.0 1169.7 1239.7 17603.6 17622.5 17654.5 17692.7 17748.1 574611.0 585975.0 587504.0 588320.0 589080.0 59172.4 59707.7 59718.7 59732.0 59758.7 1244.3 1296.5 1339.8 1388.8 1395.2 30098.9 34039.7 34109.1 34236.8 34558.8 50756.2 50909.7 51433.7 51441.0 51473.2 400852.0 401161.0 401435.0 401987.0 402054.0 25309.4 27702.6 28186.3 28824.3 29010.3 48933.0 48985.3 49484.0 49771.8 50353.7 38532.6 41635.0 42367.4 42425.0 42975.4 41416.4 41661.2 42029.8 42131.0 42344.0 41863.5 42381.6 42582.8 42907.8 43203.4 35414.8 37827.8 38604.0 38683.8 38884.8 28966.3 28979.7 29324.6 29364.6 29500.7 12:46:29 INFO - PROCESS | 3911 | 12:46:29 INFO - PROCESS | 3911 | [#2] jquery.html Cycles:180 Average:30568.96 Median:2459.36 stddev:83924.22 (3412.4%) stddev-sans-first:84129.07 12:46:29 INFO - PROCESS | 3911 | Values: 394.5 395.2 395.8 405.8 411.8 14465.8 18943.1 19253.7 20292.8 20316.5 15018.2 18253.9 18622.7 19292.3 19953.5 5978.2 6128.4 6146.0 6156.0 6157.2 4277.9 6114.2 6149.6 6606.6 6944.2 7002.2 7009.5 7052.2 7056.1 7063.4 6710.4 6932.7 6935.1 6935.2 6941.6 6265.1 6449.4 6458.9 6517.9 6527.7 20445.4 20587.3 22101.3 23251.7 23853.9 2447.9 2470.9 2480.9 2564.0 2609.2 14599.6 14796.7 15186.0 15217.2 15597.1 2003.3 2068.3 2081.8 2083.6 2185.1 92483.5 93024.5 95000.5 95205.5 95950.5 14163.5 14186.7 14207.7 14267.6 14289.3 11099.4 21850.6 21883.1 21909.3 21963.8 7489.3 7716.9 7792.1 7882.4 7882.6 7035.1 8312.5 8388.9 8498.3 8499.9 4481.9 4650.8 4748.5 4770.8 4825.2 1885.3 1936.7 1970.5 1971.4 1996.0 911.3 931.4 936.7 990.3 1041.6 18707.8 18780.0 19786.3 20088.8 20235.2 987.9 999.9 1006.5 1006.9 1051.9 10600.5 10688.4 10997.9 11081.9 11082.7 484458.0 505983.0 512622.0 516398.4 518889.0 91306.5 91491.5 93029.5 93335.5 102146.0 1007.6 1020.2 1059.2 1067.5 1067.5 17819.9 17843.6 18321.4 18522.3 18808.9 41876.0 44724.3 44820.6 45111.8 45324.1 61977.7 62681.7 63673.0 64734.4 64834.7 6141.1 6785.2 8350.2 8725.6 8779.0 11286.3 13052.9 13583.5 13756.7 13890.4 11702.9 11877.5 12019.9 12078.1 12150.8 11691.2 11770.4 11841.0 12028.7 12102.9 11458.9 11647.4 12118.9 12225.4 12250.1 8367.7 8414.2 8446.8 8461.4 8478.4 11181.4 11227.3 11582.1 11638.5 11646.2 12:46:29 INFO - PROCESS | 3911 | 12:46:29 INFO - PROCESS | 3911 | [#3] mootools.html Cycles:180 Average:5723.47 Median:4613.25 stddev:3241.43 (70.3%) stddev-sans-first:3233.73 12:46:29 INFO - PROCESS | 3911 | Values: 1333.5 1450.5 1484.1 1563.5 1739.3 8098.5 8497.5 8523.6 8725.7 8747.1 8526.1 8526.9 8549.7 8623.3 8655.6 2004.9 2232.9 2312.1 2341.8 2342.0 2316.1 2329.9 2337.9 2339.3 2345.1 2297.0 2319.5 2322.0 2322.9 2339.7 1966.9 2152.9 2216.1 2225.1 2227.6 2255.1 2268.7 2270.5 2271.9 2274.5 8524.9 8592.4 8601.3 8601.5 8604.5 4943.8 5062.1 5066.4 5070.0 5072.9 3248.5 3310.5 3390.2 3410.4 3412.0 1107.2 1122.0 1123.6 1125.9 1127.5 11898.1 11905.1 11925.5 11940.1 11943.0 4410.6 4433.3 4611.1 4615.4 4625.9 10126.5 10126.9 10140.8 10163.5 10172.3 5121.9 5131.6 5147.8 5162.1 5170.5 4257.3 4431.4 4513.5 4526.4 4728.9 3877.1 3988.0 4003.6 4025.0 4065.3 1190.6 1287.3 1293.9 1305.9 1316.5 879.6 946.9 962.4 998.7 1021.3 5771.5 5803.9 5824.3 5888.6 6020.9 942.3 943.1 949.8 953.1 964.7 4206.7 4255.2 4283.9 4285.7 4319.4 10383.7 10552.9 10799.1 10807.8 10819.1 10682.5 10687.4 10695.9 10696.7 10700.8 7669.1 8034.2 8044.1 8052.3 8178.6 5856.3 5966.7 6016.2 6055.5 6085.6 9968.5 10016.5 10125.6 10132.1 10137.5 9805.3 10043.8 10330.2 10346.2 10505.2 7224.9 7868.8 7915.1 8029.2 8200.3 8314.6 8493.8 8523.0 8576.7 8580.5 7459.4 7686.8 7705.3 7730.0 7777.1 7434.3 7515.8 7567.5 7611.2 7647.9 6955.2 6980.7 7011.9 7021.0 7025.6 4838.2 5074.4 5149.9 5189.7 5237.5 5072.5 5087.2 5102.2 5182.4 5239.8 12:46:29 INFO - PROCESS | 3911 | 12:46:29 INFO - PROCESS | 3911 | [#4] prototype.html Cycles:180 Average:4540.55 Median:5157.23 stddev:1319.28 (25.6%) stddev-sans-first:1284.10 12:46:29 INFO - PROCESS | 3911 | Values: 304.7 317.7 320.2 324.5 326.1 5306.3 5344.4 5395.4 5423.9 5440.6 5332.9 5341.6 5341.9 5346.3 5360.1 4156.0 4159.2 4159.6 4163.3 4174.2 4055.1 4152.5 4163.8 4171.1 4174.0 4108.5 4114.1 4125.6 4132.4 4133.2 4115.7 4116.3 4119.1 4125.1 4128.7 3636.7 3650.7 3657.5 3663.1 3666.3 5124.4 5202.1 5205.2 5209.4 5226.2 4695.8 4726.5 4732.3 4736.0 4755.3 5391.9 5497.0 5497.8 5498.7 5504.8 3979.1 3984.1 3985.0 3992.1 3998.0 5455.8 5609.4 5743.4 5744.6 5758.5 3917.7 3952.6 3956.3 3956.5 4065.3 4099.5 4131.1 4132.2 4137.9 4141.8 4548.5 4693.5 4705.0 4716.4 4725.2 5305.6 5466.3 5466.5 5467.3 5562.6 1366.7 1393.2 1415.8 1419.9 1431.8 938.6 970.6 973.6 976.0 985.5 5300.7 5322.2 5350.7 5351.9 5369.1 5615.3 5627.6 5631.9 5634.3 5656.6 5182.5 5324.2 5336.5 5337.2 5348.1 2664.2 2672.1 2672.7 2693.9 2721.2 5189.4 5199.2 5205.8 5213.8 5277.8 4834.7 5096.9 5110.0 5152.3 5173.7 5131.4 5139.7 5160.7 5183.7 5256.4 4995.6 5014.3 5031.6 5056.8 5060.9 4683.6 4901.5 4910.5 5000.9 5041.7 5127.2 5146.5 5153.7 5216.6 5235.8 3664.0 3686.0 3691.5 3695.8 3703.1 5098.0 5332.9 5578.2 5587.9 5831.5 5544.4 5580.4 5594.7 5627.4 5632.2 5524.0 5558.8 5575.9 5582.4 5631.7 5283.8 5525.3 5572.2 5586.5 5589.6 5638.2 5642.6 5658.2 5671.4 5673.7 5418.9 5428.1 5540.8 5552.3 5560.7 12:46:29 INFO - PROCESS | 3911 | 12:46:29 INFO - PROCESS | 3911 | [#5] yui.html Cycles:180 Average:20985.91 Median:4956.08 stddev:29440.59 (594.0%) stddev-sans-first:29484.07 12:46:29 INFO - PROCESS | 3911 | Values: 776.8 796.9 817.7 849.3 860.0 15893.2 17227.5 17252.4 17274.8 17295.3 13950.7 14066.9 14183.0 14194.9 14676.6 802.1 809.1 817.5 818.0 818.5 658.7 776.0 819.4 822.3 822.6 825.8 855.7 859.6 860.4 861.7 851.3 851.9 853.6 854.1 854.6 501.4 596.6 603.2 616.4 618.6 15369.9 15375.4 15401.3 15422.8 15457.2 14021.6 14716.7 14841.4 14963.9 15045.4 13536.8 13658.5 13815.2 13882.4 14312.2 4603.4 4618.6 4630.4 4716.8 4816.5 77390.0 77738.6 78161.6 78183.8 81629.6 11205.6 11247.6 11502.0 11620.5 11889.5 22490.1 22518.0 22558.0 22568.0 22581.1 8776.7 8827.9 8867.3 8987.1 9007.1 4824.2 4825.5 4972.3 4997.0 5158.8 3587.5 3724.8 3736.8 3744.8 3748.4 639.0 644.5 644.8 649.7 652.1 700.5 713.8 725.0 728.1 749.7 9422.0 9445.7 9608.3 9863.3 9883.9 584.8 674.6 684.3 726.0 729.1 4674.3 4720.2 4850.8 4955.8 4956.4 108806.0 115559.4 116070.0 118351.4 119497.0 59865.7 93613.0 97055.5 97097.0 98122.0 80156.6 85781.6 88423.0 89445.6 90577.3 9154.6 9167.9 9252.6 9305.3 9348.1 51650.0 53167.7 53776.5 54222.0 56645.7 68424.0 68550.4 69582.0 75610.6 77077.6 12159.9 12419.8 12487.6 13031.0 14512.5 15780.7 16137.7 16154.1 16313.7 16423.0 15040.4 15147.5 15322.0 15432.4 15735.7 14819.0 14941.6 15308.8 15362.4 15833.8 13618.2 14019.5 14112.9 14113.3 14161.2 11507.8 11681.9 11848.2 12154.9 12173.8 11386.7 11957.6 12041.9 12096.8 12420.9 12:46:29 INFO - PROCESS | 3911 | -------- Summary: end -------- 12:46:29 INFO - PROCESS | 3911 | 12:46:30 INFO - TEST-INFO | 3911: exit 0 12:46:30 INFO - TEST-OK | dromaeo_css | took 1113831ms 12:46:30 INFO - TEST-START | kraken 12:46:30 INFO - operating with platform_type : linux_ 12:46:30 INFO - Initialising browser for kraken test... 12:46:30 INFO - TEST-INFO | started process 4107 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPM3rQt/profile http://localhost:38119/getInfo.html) 12:46:34 INFO - PROCESS | 4107 | __metrics Screen width/height:1600/1200 12:46:34 INFO - PROCESS | 4107 | colorDepth:24 12:46:34 INFO - PROCESS | 4107 | Browser inner width/height: 1024/697 12:46:34 INFO - PROCESS | 4107 | __metrics 12:46:35 INFO - PROCESS | 4107 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:46:35 INFO - TEST-INFO | 4107: exit 0 12:46:35 INFO - Browser initialized. 12:46:35 INFO - Running cycle 1/1 for kraken test... 12:46:35 INFO - TEST-INFO | started process 4187 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPM3rQt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:46:47 INFO - PROCESS | 4187 | RSS: Main: 157110272 12:46:47 INFO - PROCESS | 4187 | 12:46:50 INFO - PROCESS | 4187 | Cycle 1(1): loaded http://localhost:38119/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38119/tests/kraken/driver.html?testName=audio-beat-detection) 12:46:51 INFO - PROCESS | 4187 | RSS: Main: 215494656 12:46:51 INFO - PROCESS | 4187 | 12:46:53 INFO - PROCESS | 4187 | Cycle 1(1): loaded http://localhost:38119/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38119/tests/kraken/driver.html?testName=audio-dft) 12:46:54 INFO - PROCESS | 4187 | RSS: Main: 203902976 12:46:54 INFO - PROCESS | 4187 | 12:46:57 INFO - PROCESS | 4187 | Cycle 1(1): loaded http://localhost:38119/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38119/tests/kraken/driver.html?testName=audio-fft) 12:46:58 INFO - PROCESS | 4187 | RSS: Main: 269946880 12:46:58 INFO - PROCESS | 4187 | 12:47:00 INFO - PROCESS | 4187 | Cycle 1(1): loaded http://localhost:38119/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38119/tests/kraken/driver.html?testName=audio-oscillator) 12:47:00 INFO - PROCESS | 4187 | RSS: Main: 180424704 12:47:00 INFO - PROCESS | 4187 | 12:47:02 INFO - PROCESS | 4187 | Cycle 1(1): loaded http://localhost:38119/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38119/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:47:03 INFO - PROCESS | 4187 | RSS: Main: 184381440 12:47:03 INFO - PROCESS | 4187 | 12:47:06 INFO - PROCESS | 4187 | Cycle 1(1): loaded http://localhost:38119/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38119/tests/kraken/driver.html?testName=imaging-darkroom) 12:47:07 INFO - PROCESS | 4187 | RSS: Main: 219021312 12:47:07 INFO - PROCESS | 4187 | 12:47:10 INFO - PROCESS | 4187 | Cycle 1(1): loaded http://localhost:38119/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38119/tests/kraken/driver.html?testName=imaging-desaturate) 12:47:11 INFO - PROCESS | 4187 | RSS: Main: 220536832 12:47:11 INFO - PROCESS | 4187 | 12:47:13 INFO - PROCESS | 4187 | Cycle 1(1): loaded http://localhost:38119/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38119/tests/kraken/driver.html?testName=json-parse-financial) 12:47:14 INFO - PROCESS | 4187 | RSS: Main: 221163520 12:47:14 INFO - PROCESS | 4187 | 12:47:16 INFO - PROCESS | 4187 | Cycle 1(1): loaded http://localhost:38119/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38119/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:47:16 INFO - PROCESS | 4187 | RSS: Main: 208228352 12:47:16 INFO - PROCESS | 4187 | 12:47:18 INFO - PROCESS | 4187 | Cycle 1(1): loaded http://localhost:38119/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38119/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:47:19 INFO - PROCESS | 4187 | RSS: Main: 210972672 12:47:19 INFO - PROCESS | 4187 | 12:47:20 INFO - PROCESS | 4187 | Cycle 1(1): loaded http://localhost:38119/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38119/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:47:21 INFO - PROCESS | 4187 | RSS: Main: 211394560 12:47:21 INFO - PROCESS | 4187 | 12:47:24 INFO - PROCESS | 4187 | Cycle 1(1): loaded http://localhost:38119/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38119/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:47:24 INFO - PROCESS | 4187 | RSS: Main: 225959936 12:47:24 INFO - PROCESS | 4187 | 12:47:27 INFO - PROCESS | 4187 | Cycle 1(1): loaded http://localhost:38119/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38119/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:47:28 INFO - PROCESS | 4187 | RSS: Main: 225738752 12:47:28 INFO - PROCESS | 4187 | 12:47:29 INFO - PROCESS | 4187 | Cycle 1(1): loaded http://localhost:38119/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38119/tests/kraken/driver.html?testName=ai-astar) 12:47:29 INFO - PROCESS | 4187 | RSS: Main: 268152832 12:47:29 INFO - PROCESS | 4187 | 12:47:29 INFO - PROCESS | 4187 | __start_tp_report 12:47:29 INFO - PROCESS | 4187 | _x_x_mozilla_page_load 12:47:29 INFO - PROCESS | 4187 | _x_x_mozilla_page_load_details 12:47:29 INFO - PROCESS | 4187 | |i|pagename|runs| 12:47:29 INFO - PROCESS | 4187 | |0;ai-astar;100;110;110;112;110;109;109;110;109;109 12:47:29 INFO - PROCESS | 4187 | |1;audio-beat-detection;146;122;120;170;123;118;147;121;146;118 12:47:29 INFO - PROCESS | 4187 | |2;audio-dft;161;162;161;160;160;161;160;161;161;161 12:47:29 INFO - PROCESS | 4187 | |3;audio-fft;75;75;76;152;76;79;74;75;98;75 12:47:29 INFO - PROCESS | 4187 | |4;audio-oscillator;83;85;120;84;84;85;119;83;85;120 12:47:29 INFO - PROCESS | 4187 | |5;imaging-gaussian-blur;117;116;117;117;117;117;117;117;117;117 12:47:29 INFO - PROCESS | 4187 | |6;imaging-darkroom;145;146;146;145;146;146;146;146;146;146 12:47:29 INFO - PROCESS | 4187 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;95 12:47:29 INFO - PROCESS | 4187 | |8;json-parse-financial;53;53;53;53;53;52;54;53;53;51 12:47:29 INFO - PROCESS | 4187 | |9;json-stringify-tinderbox;61;62;62;62;62;62;62;63;62;63 12:47:29 INFO - PROCESS | 4187 | |10;stanford-crypto-aes;75;80;75;75;84;77;75;75;84;80 12:47:29 INFO - PROCESS | 4187 | |11;stanford-crypto-ccm;128;127;117;119;128;127;122;118;171;120 12:47:29 INFO - PROCESS | 4187 | |12;stanford-crypto-pbkdf2;162;154;158;158;155;153;153;163;154;157 12:47:29 INFO - PROCESS | 4187 | |13;stanford-crypto-sha256-iterative;63;62;62;62;63;62;62;63;61;61 12:47:29 INFO - PROCESS | 4187 | __end_tp_report 12:47:29 INFO - PROCESS | 4187 | __start_cc_report 12:47:29 INFO - PROCESS | 4187 | _x_x_mozilla_cycle_collect,1652 12:47:29 INFO - PROCESS | 4187 | __end_cc_report 12:47:29 INFO - PROCESS | 4187 | __startTimestamp1468612049941__endTimestamp 12:47:29 INFO - PROCESS | 4187 | 12:47:29 INFO - PROCESS | 4187 | ------- Summary: start ------- 12:47:29 INFO - PROCESS | 4187 | Number of tests: 14 12:47:29 INFO - PROCESS | 4187 | 12:47:29 INFO - PROCESS | 4187 | [#0] ai-astar Cycles:10 Average:108.80 Median:110.00 stddev:3.22 (2.9%) stddev-sans-first:0.97 12:47:29 INFO - PROCESS | 4187 | Values: 100.0 110.0 110.0 112.0 110.0 109.0 109.0 110.0 109.0 109.0 12:47:29 INFO - PROCESS | 4187 | 12:47:29 INFO - PROCESS | 4187 | [#1] audio-beat-detection Cycles:10 Average:133.10 Median:134.50 stddev:17.91 (13.3%) stddev-sans-first:18.38 12:47:29 INFO - PROCESS | 4187 | Values: 146.0 122.0 120.0 170.0 123.0 118.0 147.0 121.0 146.0 118.0 12:47:29 INFO - PROCESS | 4187 | 12:47:29 INFO - PROCESS | 4187 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 12:47:29 INFO - PROCESS | 4187 | Values: 161.0 162.0 161.0 160.0 160.0 161.0 160.0 161.0 161.0 161.0 12:47:29 INFO - PROCESS | 4187 | 12:47:29 INFO - PROCESS | 4187 | [#3] audio-fft Cycles:10 Average:85.50 Median:75.50 stddev:24.44 (32.4%) stddev-sans-first:25.62 12:47:29 INFO - PROCESS | 4187 | Values: 75.0 75.0 76.0 152.0 76.0 79.0 74.0 75.0 98.0 75.0 12:47:29 INFO - PROCESS | 4187 | 12:47:29 INFO - PROCESS | 4187 | [#4] audio-oscillator Cycles:10 Average:94.80 Median:84.00 stddev:17.18 (20.4%) stddev-sans-first:17.68 12:47:29 INFO - PROCESS | 4187 | Values: 83.0 85.0 120.0 84.0 84.0 85.0 119.0 83.0 85.0 120.0 12:47:29 INFO - PROCESS | 4187 | 12:47:29 INFO - PROCESS | 4187 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 12:47:29 INFO - PROCESS | 4187 | Values: 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 12:47:29 INFO - PROCESS | 4187 | 12:47:29 INFO - PROCESS | 4187 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.33 12:47:29 INFO - PROCESS | 4187 | Values: 145.0 146.0 146.0 145.0 146.0 146.0 146.0 146.0 146.0 146.0 12:47:29 INFO - PROCESS | 4187 | 12:47:29 INFO - PROCESS | 4187 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 12:47:29 INFO - PROCESS | 4187 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 12:47:29 INFO - PROCESS | 4187 | 12:47:29 INFO - PROCESS | 4187 | [#8] json-parse-financial Cycles:10 Average:52.80 Median:53.00 stddev:0.79 (1.5%) stddev-sans-first:0.83 12:47:29 INFO - PROCESS | 4187 | Values: 53.0 53.0 53.0 53.0 53.0 52.0 54.0 53.0 53.0 51.0 12:47:29 INFO - PROCESS | 4187 | 12:47:29 INFO - PROCESS | 4187 | [#9] json-stringify-tinderbox Cycles:10 Average:62.10 Median:62.00 stddev:0.57 (0.9%) stddev-sans-first:0.44 12:47:29 INFO - PROCESS | 4187 | Values: 61.0 62.0 62.0 62.0 62.0 62.0 62.0 63.0 62.0 63.0 12:47:29 INFO - PROCESS | 4187 | 12:47:29 INFO - PROCESS | 4187 | [#10] stanford-crypto-aes Cycles:10 Average:78.00 Median:78.50 stddev:3.74 (4.8%) stddev-sans-first:3.81 12:47:29 INFO - PROCESS | 4187 | Values: 75.0 80.0 75.0 75.0 84.0 77.0 75.0 75.0 84.0 80.0 12:47:29 INFO - PROCESS | 4187 | 12:47:29 INFO - PROCESS | 4187 | [#11] stanford-crypto-ccm Cycles:10 Average:127.70 Median:127.00 stddev:15.82 (12.5%) stddev-sans-first:16.78 12:47:29 INFO - PROCESS | 4187 | Values: 128.0 127.0 117.0 119.0 128.0 127.0 122.0 118.0 171.0 120.0 12:47:29 INFO - PROCESS | 4187 | 12:47:29 INFO - PROCESS | 4187 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.70 Median:157.50 stddev:3.59 (2.3%) stddev-sans-first:3.26 12:47:29 INFO - PROCESS | 4187 | Values: 162.0 154.0 158.0 158.0 155.0 153.0 153.0 163.0 154.0 157.0 12:47:29 INFO - PROCESS | 4187 | 12:47:29 INFO - PROCESS | 4187 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.10 Median:62.00 stddev:0.74 (1.2%) stddev-sans-first:0.71 12:47:29 INFO - PROCESS | 4187 | Values: 63.0 62.0 62.0 62.0 63.0 62.0 62.0 63.0 61.0 61.0 12:47:29 INFO - PROCESS | 4187 | -------- Summary: end -------- 12:47:29 INFO - PROCESS | 4187 | 12:47:30 INFO - TEST-INFO | 4187: exit 0 12:47:30 INFO - TEST-OK | kraken | took 60667ms 12:47:30 INFO - SUITE-END | took 1174s 12:47:31 INFO - Completed test suite (00:19:34) 12:47:31 INFO - javascript benchmark 12:47:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3053.832039237842, 3078.5843911071997, 3104.5498402731605, 3112.4708799504083, 3126.2809553802626, 5347.1177255752855, 5376.247325374446, 5390.838274851756, 5448.128299472085, 5464.0711079116545, 5335.0, 5359.598030147735, 5437.782488700447, 5462.863428414292, 5465.207544905987, 4814.879628009301, 4859.198232291667, 4861.489543597924, 4939.086269040221, 5031.874203144914, 4904.5340692634145, 4923.236898280755, 5028.647994640377, 5041.621878359119, 5053.36832895888, 4858.052679727454, 4902.044101400228, 4929.728864912428, 4969.080720066781, 5021.573166280852, 4851.611871050308, 4860.125177468054, 4863.392075990501, 4867.8783030424165, 4923.040007198598, 4843.782029808667, 4884.780184891689, 4891.070696567676, 4897.534734200245, 4931.408231012266, 5315.681059136464, 5320.574354051667, 5344.412114667383, 5427.728613569345, 5430.158325459521, 5749.798757043483, 5807.925533776222, 5815.709214539298, 5818.156367326714, 5824.825255242349, 5789.884202315972, 5841.357450680422, 5850.3564607893095, 5855.473007429309, 5857.85355366115, 5268.683878967274, 5304.0, 5364.329458817648, 5440.700761458118, 5442.183672449164, 5919.082542205965, 5939.13882487037, 5940.524758019348, 5941.881162376728, 5947.702614869239, 5623.493885550239, 5644.125160600113, 5682.40334764852, 5692.23154874095, 5699.772009119672, 5667.234923285304, 5676.205331253628, 5749.223854779635, 5753.51095156908, 5784.566157538117, 5738.8278351649515, 5744.655320680772, 5746.138079288056, 5746.942530574641, 5750.482456578844, 5698.202251684767, 5722.971385143048, 5726.3700992890745, 5735.8852822944145, 5747.942520574825, 4337.8481753138485, 4376.256036473807, 4381.605655490957, 4418.580234877746, 4423.358613001161, 3924.372100463912, 3926.2130704578453, 3927.666148377363, 3966.087799806061, 3971.7616942983514, 5427.348718153847, 5487.6981766003255, 5487.972560137254, 5490.478404551562, 5490.752916118784, 5694.715264236772, 5779.450952159538, 5794.0, 5848.035074212792, 5858.853528661817, 5495.917561236584, 5499.890002199933, 5502.9174562381595, 5505.03661859173, 5507.862303442366, 4780.330753694486, 4889.144399730033, 4896.706197628154, 4902.558769710672, 4948.826791062295, 5943.375945525744, 6039.78860739872, 6040.486558642477, 6045.425684559959, 6061.121137435047, 5830.5044071254415, 5841.065429531254, 5841.824745257649, 5848.152017957287, 5849.1226316052935, 5874.412558744091, 6010.4891084258325, 6044.0933859919605, 6058.182145410489, 6062.666553339609, 5764.625299355528, 5776.942230577641, 5782.739776709974, 5792.4497172768515, 5847.473727364558, 5764.625299355528, 5843.211166492639, 5845.09401042839, 5863.560232982458, 5874.089516125007, 5506.2841830563375, 5587.636803607753, 5681.431856814285, 5700.315962084576, 5707.828765137053, 5684.431556844283, 5696.088625819849, 5696.515796157208, 5698.116791897262, 5742.7702891883855, 5584.441555844383, 5628.296462942132, 5642.943570564242, 5646.0683987141665, 5649.322081350264, 5569.610127291213, 5685.175649530877, 5725.599208055396, 5775.393583673822, 5776.884462310814, 5480.287562616834, 5534.557235421076, 5543.445655434424, 5564.721763911707, 5627.7467513961155], "value": 5332.671689213151, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [587.0929414055284, 622.212900680639, 626.8307556959621, 634.7238951056291, 643.6749441532025, 42884.0, 44337.99999999992, 44401.0, 44471.5552844471, 48074.27888581674, 45191.09617807642, 45525.54474455263, 45592.3161152583, 45656.08687826242, 45690.543094569126, 8109.878351824727, 9055.909440905589, 9203.309751768644, 9210.171084602385, 10685.145188384911, 10578.0, 10987.670369888916, 11019.228653994223, 11021.559137634486, 11024.944875275613, 11081.556737730481, 11115.221934464591, 11132.443377831116, 11138.610148644799, 11140.33158010518, 8322.791930201733, 8487.40588158829, 10917.23579349446, 10982.615608453705, 11176.664700059011, 10596.205284603686, 10995.835062474069, 11001.394923279217, 11011.944940275247, 11016.283941543774, 42068.579314207076, 42539.36190957138, 42582.78708606468, 42599.0, 42616.147677046596, 2952.985235073811, 3798.5631652360057, 3826.885193444201, 3907.6924608210625, 4108.4864391951005, 32312.5153122701, 33123.171920701934, 33201.0, 33490.83254583736, 34899.6510034899, 4426.822927082912, 4457.398251236074, 4495.483019452739, 4524.434445694288, 4589.875480507264, 353470.0, 354110.99999999744, 355387.44612553803, 355431.0, 356910.0, 63033.36966630367, 63512.0, 63544.68227658832, 63574.68212658907, 63621.36378636247, 36540.81729591335, 37326.62673373286, 37365.626343736214, 38941.221175576895, 67646.66176669086, 17287.82712172862, 17377.73933391, 17426.564335891704, 17444.651106978043, 17468.5632859177, 12053.457594408274, 13111.803322950163, 13290.933545332211, 13333.399997000159, 13522.391492382867, 20893.89553052225, 20934.58130837375, 20993.16027358919, 21078.262260820797, 21195.78804211938, 7697.538147711155, 7935.960320198362, 7969.0, 7969.521828690297, 7974.641141148662, 998.236349192868, 1027.5222021759917, 1094.6497120921229, 1145.450183911727, 1146.4668928948079, 33002.83498582492, 33505.0, 33556.1610959728, 33721.15697107592, 34302.485462718076, 1069.0111646726746, 1144.8282757586428, 1164.9825252621217, 1169.7309618787726, 1239.6776440155315, 17603.647927041642, 17622.471325860246, 17654.470365889043, 17692.734608980874, 17748.112594370228, 574611.0, 585975.0, 587504.0, 588320.0, 589080.0, 59172.40827591755, 59707.70146149241, 59718.70140649269, 59732.0, 59758.701206493686, 1244.2783185752423, 1296.5397283964057, 1339.7789364754901, 1388.8263967004125, 1395.2465668539078, 30098.920863309704, 34039.65960340365, 34109.14727131841, 34236.82881585576, 34558.82720586381, 50756.238656419446, 50909.74545127251, 51433.74283128561, 51441.0, 51473.22790158076, 400852.0, 401161.0, 401435.0, 401987.0, 402054.0, 25309.367265818502, 27702.584461233502, 28186.2953426166, 28824.279393015342, 29010.27474313159, 48933.0, 48985.265221022426, 49484.0, 49771.75114124551, 50353.74823125861, 38532.614673852906, 41635.0, 42367.3644895333, 42425.0, 42975.355369670106, 41416.37875431931, 41661.166776664904, 42029.78985105055, 42131.0, 42344.0, 41863.50860321088, 42381.576184239, 42582.787086064374, 42907.78546107374, 43203.35194972015, 35414.82292588521, 37827.810860945516, 38604.0, 38683.80658096691, 38884.80557597307, 28966.27584310409, 28979.710202897702, 29324.560131597616, 29364.559531606617, 29500.704992950654], "value": 20958.33220335347, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [394.5462717874446, 395.18788888833456, 395.76254247451516, 405.7606012452652, 411.808509043295, 14465.783013254782, 18943.147558359873, 19253.711194332096, 20292.797072029294, 20316.492087697814, 15018.249087545633, 18253.90873045636, 18622.720659190123, 19292.3247686331, 19953.501162470944, 5978.163057171989, 6128.356522565134, 6146.047362658773, 6156.0, 6157.168782214411, 4277.935830962538, 6114.2357205349335, 6149.600275982069, 6606.570572912769, 6944.201416837078, 7002.229754727002, 7009.544379615334, 7052.224255331909, 7056.1179852518435, 7063.399611033043, 6710.396064354207, 6932.7226910923755, 6935.133108361455, 6935.167779866398, 6941.618210998393, 6265.091561723524, 6449.419552240321, 6458.93541064588, 6517.902231466532, 6527.673616319165, 20445.386638400872, 20587.279445219345, 22101.33695989123, 23251.651225231635, 23853.88073059641, 2447.853128812259, 2470.876456177184, 2480.8759562022005, 2563.9871800640876, 2609.2172348295435, 14599.635009124751, 14796.70406591862, 15186.0, 15217.239138043053, 15597.064176149468, 2003.2688068854764, 2068.2657656531865, 2081.8126368626745, 2083.6041152181037, 2185.071344678521, 92483.53758231233, 93024.53487732586, 95000.52499737527, 95205.5239723797, 95950.52024739832, 14163.459135216195, 14186.71626567463, 14207.71584568303, 14267.64330891736, 14289.285535723173, 11099.44502774858, 21850.562988740137, 21883.12467501314, 21909.342719718436, 21963.780362196172, 7489.28851759082, 7716.92283077162, 7792.142864284924, 7882.448228623941, 7882.645280962371, 7035.085438892911, 8312.5428101455, 8388.8741668875, 8498.320134389234, 8499.872501912476, 4481.887952801141, 4650.767461626905, 4748.525147485224, 4770.7596025033745, 4825.1555977703765, 1885.2741694447461, 1936.6998115292151, 1970.4581240158784, 1971.3790156100783, 1995.9900200499194, 911.3301723233418, 931.38993958957, 936.7423958411355, 990.3265779270022, 1041.57295508841, 18707.812921870605, 18780.0, 19786.33540372671, 20088.799112008986, 20235.19059237614, 987.8863930648067, 999.8550210219478, 1006.4917216805612, 1006.9395836249848, 1051.9000694933968, 10600.469976501145, 10688.412137332522, 10997.945010274898, 11081.889181108085, 11082.722931926766, 484458.0, 505983.0, 512622.0, 516398.4180079076, 518889.0, 91306.54346728224, 91491.54254228686, 93029.5348523253, 93335.53332233295, 102146.0, 1007.6271779441654, 1020.1838529176778, 1059.1579694143174, 1067.503610820972, 1067.503610820972, 17819.910900445415, 17843.553911152325, 18321.3587524436, 18522.259109635463, 18808.905955470134, 41876.0, 44724.32913506235, 44820.55179448164, 45111.774441127585, 45324.09351813011, 61977.69011154916, 62681.68659156675, 63673.0, 64734.35265647283, 64834.675826620565, 6141.07883817431, 6785.1518560179975, 8350.164983501601, 8725.607347669496, 8778.956105219433, 11286.266392684449, 13052.869471305545, 13583.52457663977, 13756.65608359799, 13890.444382225001, 11702.88297117018, 11877.46551405206, 12019.939900300442, 12078.094142939139, 12150.817737733763, 11691.240069395462, 11770.3526306054, 11841.0, 12028.699282518008, 12102.878971210528, 11458.94270528642, 11647.417629118341, 12118.939405302917, 12225.44985475638, 12250.142490025613, 8367.748967530984, 8414.158584141536, 8446.831063378575, 8461.40770146084, 8478.448900821428, 11181.440927953407, 11227.326360418401, 11582.131340149692, 11638.476268567765, 11646.184767066225], "value": 9730.379095139697, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1333.4999375234288, 1450.4633285684295, 1484.1169504145034, 1563.4918651438286, 1739.3216645508253, 8098.514089154647, 8497.532635705034, 8523.616437260323, 8725.694600688978, 8747.12528747125, 8526.104759000309, 8526.87209691855, 8549.658013679446, 8623.267022303111, 8655.610497527627, 2004.8897310647908, 2232.8660280383147, 2312.1098377124845, 2341.8243631727605, 2341.988290058547, 2316.073570571768, 2329.860208387502, 2337.8947947342413, 2339.2982105368405, 2345.0502546468706, 2296.9770302297015, 2319.512902290521, 2321.976780232193, 2322.907083716649, 2339.6958395408574, 1966.8918209498472, 2152.9354119376444, 2216.0581752755015, 2225.143319821864, 2227.610168220563, 2255.0979608156704, 2268.65970104484, 2270.5345404192103, 2271.8864056797092, 2274.465500607356, 8524.914750852475, 8592.441491303045, 8601.31189504838, 8601.526916019617, 8604.52675102869, 4943.802247910079, 5062.063518249136, 5066.392032956032, 5069.999999999963, 5072.873178170538, 3248.512723091555, 3310.5034244863223, 3390.1524618845287, 3410.352033113725, 3411.9764070778665, 1107.213878146517, 1121.9887801122047, 1123.617969890233, 1125.881782412843, 1127.520803658442, 11898.107641926803, 11905.107116966263, 11925.463354149084, 11940.104492163122, 11943.044556435465, 4410.647148228134, 4433.268510695763, 4611.100835337077, 4615.3999980003055, 4625.907481850411, 10126.493675316206, 10126.949365253275, 10140.847887281696, 10163.4918254087, 10172.338797978107, 5121.948780512147, 5131.640785145079, 5147.819826306061, 5162.096633089194, 5170.508801663836, 4257.254980378421, 4431.446069241345, 4513.458384993756, 4526.366308716782, 4728.88177795551, 3877.0501227199516, 3987.980060099739, 4003.559608443069, 4025.0, 4065.308897487434, 1190.6487586162102, 1287.3241548187088, 1293.9223646581236, 1305.8563558008611, 1316.486570237608, 879.5514287713185, 946.8674385585886, 962.3504134709043, 998.7103739915489, 1021.2697920986382, 5771.480566749013, 5803.854903627359, 5824.301083869878, 5888.646681199141, 6020.9162350776405, 942.2556180617372, 943.1464524605243, 949.8290307744672, 953.0802775321848, 964.7346979580672, 4206.684498662551, 4255.1915136124035, 4283.914321713611, 4285.657147428198, 4319.3952846601505, 10383.688489345332, 10552.894471055344, 10799.082078023455, 10807.783844323227, 10819.13446924244, 10682.465876706134, 10687.41219232934, 10695.893041069645, 10696.732581685364, 10700.78598428027, 7669.079710434784, 8034.196580341919, 8044.115147333789, 8052.315553177928, 8178.631961561625, 5856.326522449973, 5966.731497082728, 6016.161936263351, 6055.485283750931, 6085.604435711664, 9968.451735154636, 10016.549255283675, 10125.64560240388, 10132.138768204784, 10137.543810528692, 9805.2646051545, 10043.799124017625, 10330.225233107698, 10346.172306215636, 10505.212109091695, 7224.89162662571, 7868.84262314762, 7915.0897646771355, 8029.197080292158, 8200.302974247255, 8314.584270786558, 8493.787655308419, 8522.957385213282, 8576.699815506427, 8580.485170889766, 7459.37226161084, 7686.769396918102, 7705.267999540035, 7730.0, 7777.144514103557, 7434.33091021789, 7515.8496830061995, 7567.508111972704, 7611.238876112345, 7647.923520764721, 6955.234924158237, 6980.6509674515055, 7011.878099504259, 7020.964895175695, 7025.613591252531, 4838.153323168361, 5074.3657042869645, 5149.948500514947, 5189.714565698923, 5237.502437268454, 5072.492750724898, 5087.23691446286, 5102.209157580581, 5182.352205974254, 5239.790408383775], "value": 4583.530333605759, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [304.6953046953047, 317.6569305150437, 320.1675643327349, 324.5261917600304, 326.0755757427692, 5306.336707911511, 5344.385395679493, 5395.406505284421, 5423.888102938898, 5440.564754819615, 5332.866678333034, 5341.626086173969, 5341.866453338668, 5346.27825243593, 5360.142377219646, 4156.044109854735, 4159.168166366723, 4159.604837540429, 4163.3130533461945, 4174.248635245654, 4055.1484188320487, 4152.460180176573, 4163.7501749894955, 4171.124063946575, 4173.979130104361, 4108.4864391951005, 4114.074333275019, 4125.628693417591, 4132.400801883725, 4133.2353514599745, 4115.670746340301, 4116.320807066861, 4119.073208528087, 4125.133721918401, 4128.710990230685, 3636.672699457035, 3650.671439570425, 3657.4513822926506, 3663.084228942764, 3666.2850744104912, 5124.385073791132, 5202.141646628302, 5205.219217117463, 5209.400918894337, 5226.216067589854, 4695.7886895089805, 4726.503717109723, 4732.266498692708, 4736.0, 4755.262934245197, 5391.892162156774, 5496.993597336983, 5497.773401772289, 5498.725063746797, 5504.779808807642, 3979.144483935968, 3984.1234928315725, 3984.963909383552, 3992.1416895367634, 3997.98001009996, 5455.809046683386, 5609.4390560943575, 5743.425657434265, 5744.587273345205, 5758.48173664368, 3917.7061720370516, 3952.6245006724316, 3956.2878681837547, 3956.467860569238, 4065.2559522322313, 4099.467069280974, 4131.132462182975, 4132.194222126656, 4137.937930931039, 4141.7722025288895, 4548.545145485491, 4693.530646935279, 4705.0, 4716.3632909557455, 4725.220338644154, 5305.62860599762, 5466.289382380344, 5466.535344495763, 5467.2663668165915, 5562.638428502134, 1366.7425968109164, 1393.171063217384, 1415.8177921435718, 1419.90667186266, 1431.799548063272, 938.643315540104, 970.6069042037985, 973.6056896956744, 975.9853602195973, 985.4530735441898, 5300.655457395257, 5322.175062865262, 5350.705711185922, 5351.876106017702, 5369.060414427459, 5615.326160860641, 5627.5779316551425, 5631.943680563142, 5634.32388113429, 5656.575756818255, 5182.455842136596, 5324.227986941872, 5336.46635336471, 5337.172738225581, 5348.090824559834, 2664.2292016303213, 2672.0647773279584, 2672.719364466742, 2693.878775455109, 2721.1972468121558, 5189.42916279209, 5199.246109314128, 5205.817796377184, 5213.843584692465, 5277.788888444419, 4834.709917404896, 5096.923546146811, 5110.0, 5152.278680984665, 5173.741312934339, 5131.435542090367, 5139.665921715076, 5160.7419629018395, 5183.714895680774, 5256.448072952285, 4995.575376092927, 5014.34813474246, 5031.6226283029655, 5056.786371270795, 5060.9119039406705, 4683.625309975262, 4901.456041346964, 4910.453207239708, 5000.899622158775, 5041.697688014357, 5127.154019586876, 5146.459621739664, 5153.7165455898785, 5216.634835561475, 5235.764390602356, 3664.0, 3686.0006892521915, 3691.5016472776906, 3695.796731179811, 3703.1300741925224, 5097.986295413365, 5332.920006199833, 5578.246936663661, 5587.916181257366, 5831.504322132666, 5544.417836127149, 5580.414056524007, 5594.6502468963945, 5627.352854421631, 5632.239647647515, 5523.972380138073, 5558.805441809517, 5575.8884822304135, 5582.413846546055, 5631.7184140793615, 5283.788648454019, 5525.254090697865, 5572.219889215432, 5586.497215250647, 5589.580781441489, 5638.182463542846, 5642.576806739593, 5658.151277308437, 5671.432856714296, 5673.659580425187, 5418.891622167455, 5428.0620378325875, 5540.833774986757, 5552.305961754781, 5560.666360018412], "value": 4121.12549679743, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [776.7630872583862, 796.8685166947454, 817.6524976884826, 849.2950850793837, 860.0, 15893.205339733011, 17227.483175504723, 17252.39616613419, 17274.827251727464, 17295.30818767251, 13950.720985580283, 14066.859331406682, 14183.0, 14194.858051419482, 14676.559703208894, 802.1096582793109, 809.1180613131685, 817.480899628737, 818.0265484073963, 818.4516374029415, 658.6838317607551, 776.0377132355894, 819.4345901328095, 822.3421262989614, 822.6092606012156, 825.8100636853527, 855.687673998989, 859.5959898847532, 860.3934226370425, 861.6811779641541, 851.3104385447807, 851.9488830670149, 853.564682012172, 854.0818619983543, 854.5599016506504, 501.420525345162, 596.582392325374, 603.1856993059379, 616.4236438929615, 618.5762752514497, 15369.923150384288, 15375.384984600603, 15401.306941187673, 15422.845771542365, 15457.227138643022, 14021.64945876351, 14716.705665886622, 14841.406343746237, 14963.925180374137, 15045.398184072625, 13536.796948045787, 13658.453661853513, 13815.240161791098, 13882.375293111834, 14312.21282829444, 4603.401557797499, 4618.607418369443, 4630.4443466784205, 4716.787744551503, 4816.54242846929, 77390.0, 77738.6113069431, 78161.60919195424, 78183.8272425914, 81629.59185204036, 11205.60780372683, 11247.606333778278, 11502.0, 11620.53517859293, 11889.464974076187, 22490.100395983976, 22518.0, 22558.0, 22568.0, 22581.09675612957, 8776.736697899074, 8827.911720882837, 8867.334949878785, 8987.146221108984, 9007.144321289466, 4824.204006338915, 4825.5174482551465, 4972.252169895173, 4996.975015124901, 5158.845234642967, 3587.5336206293014, 3724.832382542792, 3736.831842567091, 3744.8127593620757, 3748.3815170496564, 639.0478187500684, 644.4811926399293, 644.8387903024244, 649.7076315657878, 652.1359199061168, 700.4626635490752, 713.7715930902166, 724.9855002900018, 728.1189760389988, 749.6926260233278, 9422.0, 9445.716628501155, 9608.327417080876, 9863.260255480867, 9883.851742223873, 584.8245526342081, 674.5530836356087, 684.2780866186222, 726.0126228329468, 729.1177675013294, 4674.298855171752, 4720.150372932905, 4850.805967761321, 4955.8017679292425, 4956.355673762388, 108806.0, 115559.42220288845, 116070.0, 118351.40824295823, 119497.0, 59865.700671496365, 93613.0, 97055.51472242594, 97097.0, 98122.0, 80156.59921700355, 85781.57109214414, 88423.0, 89445.55277223572, 90577.30092942173, 9154.633814647339, 9167.908320916706, 9252.583633736363, 9305.302102342486, 9348.1119293667, 51650.0, 53167.734161328946, 53776.46223537715, 54222.0, 56645.71677141588, 68424.0, 68550.42110866301, 69582.0, 75610.6219468899, 77077.61461192658, 12159.939200303941, 12419.75160496803, 12487.625371238877, 13031.02267329973, 14512.492062777752, 15780.68438631244, 16137.743094264833, 16154.1115238663, 16313.67372652564, 16423.0, 15040.398384064514, 15147.54557363281, 15322.0, 15432.382704691687, 15735.741140708944, 14819.0, 14941.626459338604, 15308.846911530742, 15362.385504579692, 15833.762493562836, 13618.18290902549, 14019.50931717385, 14112.858871411565, 14113.2943352834, 14161.221132837793, 11507.827382589101, 11681.941590291994, 11848.170628055954, 12154.878451215729, 12173.756524869275, 11386.658400248005, 11957.581484647995, 12041.939790301343, 12096.818547721967, 12420.875791241971], "value": 7786.030444679775, "unit": "score"}], "name": "dromaeo_css", "value": 7367.758795048323, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 110.0, 110.0, 112.0, 110.0, 109.0, 109.0, 110.0, 109.0, 109.0], "value": 108.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 122.0, 120.0, 170.0, 123.0, 118.0, 147.0, 121.0, 146.0, 118.0], "value": 133.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 161.0, 160.0, 160.0, 161.0, 160.0, 161.0, 161.0, 161.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 152.0, 76.0, 79.0, 74.0, 75.0, 98.0, 75.0], "value": 85.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 85.0, 120.0, 84.0, 84.0, 85.0, 119.0, 83.0, 85.0, 120.0], "value": 94.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 145.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 53.0, 53.0, 53.0, 52.0, 54.0, 53.0, 53.0, 51.0], "value": 52.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 62.0, 62.0, 62.0, 62.0, 62.0, 63.0, 62.0, 63.0], "value": 62.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 80.0, 75.0, 75.0, 84.0, 77.0, 75.0, 75.0, 84.0, 80.0], "value": 78.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 127.0, 117.0, 119.0, 128.0, 127.0, 122.0, 118.0, 171.0, 120.0], "value": 127.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 154.0, 158.0, 158.0, 155.0, 153.0, 153.0, 163.0, 154.0, 157.0], "value": 156.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 62.0, 62.0, 63.0, 62.0, 62.0, 63.0, 61.0, 61.0], "value": 62.1, "unit": "score"}], "name": "kraken", "value": 1480.1, "alertThreshold": 2.0}]} 12:47:31 INFO - Return code: 0 12:47:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:47:31 INFO - # TBPL SUCCESS # 12:47:31 INFO - Running post-action listener: _resource_record_post_action 12:47:31 INFO - ##### 12:47:31 INFO - ##### Finished run-tests step (success) 12:47:31 INFO - ##### 12:47:31 INFO - Running post-run listener: _resource_record_post_run 12:47:31 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 0; Write bytes: 559325184; Read time: 0; Write time: 431496 12:47:31 INFO - TinderboxPrint: CPU usage
13.0% 12:47:31 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 12:47:31 INFO - TinderboxPrint: I/O write bytes / time
559,325,184 / 431,496 12:47:31 INFO - TinderboxPrint: CPU idle
8,273.2 (87.0%) 12:47:31 INFO - TinderboxPrint: CPU user
1,197.3 (12.6%) 12:47:31 INFO - TinderboxPrint: Swap in / out
0 / 0 12:47:31 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 263475200; Read time: 0; Write time: 226320 12:47:31 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 291852288; Read time: 0; Write time: 204568 12:47:31 INFO - Running post-run listener: _upload_blobber_files 12:47:31 INFO - Blob upload gear active. 12:47:31 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:47:31 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 12:47:31 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'] 12:47:31 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 12:47:32 INFO - (blobuploader) - INFO - Open directory for files ... 12:47:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:47:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:47:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:47:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:47:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:47:33 INFO - (blobuploader) - INFO - Done attempting. 12:47:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:47:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:47:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:47:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:47:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:47:33 INFO - (blobuploader) - INFO - Done attempting. 12:47:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:47:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:47:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:47:37 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:47:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:47:37 INFO - (blobuploader) - INFO - Done attempting. 12:47:37 INFO - (blobuploader) - INFO - Iteration through files over. 12:47:37 INFO - Return code: 0 12:47:37 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:47:37 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:47:37 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/239cce380c9efa1069b8cc2b6a3b017b3b680946bba1b2f75512b3cbf4c6f71ccebcad62bc6163eb756b4f18a6e55cb2845c1bae177e7161d846ea5fcd1ceaea", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4c36e1cc3607e697f9444abc4078b235b7354838fd04f92d4a3d0bb1659bfe920de4ce67c8bf261aaf9eddcd5fa6e2a3ff9a4e913504a4f12f15b1bb7cbad7b1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/89171e4851064f8a285c0d0aeb0caffb35ecb254e1a1cfd5bb3ffd770a28ba67e48ef881648aec0034c3bb7aea8f9d4cc928351cd0c1ce1472943659d7fa8bbc"} 12:47:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:47:37 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:47:37 INFO - Contents: 12:47:37 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/239cce380c9efa1069b8cc2b6a3b017b3b680946bba1b2f75512b3cbf4c6f71ccebcad62bc6163eb756b4f18a6e55cb2845c1bae177e7161d846ea5fcd1ceaea", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4c36e1cc3607e697f9444abc4078b235b7354838fd04f92d4a3d0bb1659bfe920de4ce67c8bf261aaf9eddcd5fa6e2a3ff9a4e913504a4f12f15b1bb7cbad7b1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/89171e4851064f8a285c0d0aeb0caffb35ecb254e1a1cfd5bb3ffd770a28ba67e48ef881648aec0034c3bb7aea8f9d4cc928351cd0c1ce1472943659d7fa8bbc"} 12:47:37 INFO - Running post-run listener: copy_logs_to_upload_dir 12:47:37 INFO - Copying logs to upload dir... 12:47:37 INFO - mkdir: /builds/slave/test/build/upload/logs 12:47:37 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1230.692044 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-07-15 12:47:37.709098) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-15 12:47:37.712369) ========= 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=41bf3e9aed84707956354da8000001c5-1468610824.650182-239027312 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/239cce380c9efa1069b8cc2b6a3b017b3b680946bba1b2f75512b3cbf4c6f71ccebcad62bc6163eb756b4f18a6e55cb2845c1bae177e7161d846ea5fcd1ceaea", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4c36e1cc3607e697f9444abc4078b235b7354838fd04f92d4a3d0bb1659bfe920de4ce67c8bf261aaf9eddcd5fa6e2a3ff9a4e913504a4f12f15b1bb7cbad7b1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/89171e4851064f8a285c0d0aeb0caffb35ecb254e1a1cfd5bb3ffd770a28ba67e48ef881648aec0034c3bb7aea8f9d4cc928351cd0c1ce1472943659d7fa8bbc"} build_url:https://queue.taskcluster.net/v1/task/b6ou9dPDQpalcDoAEKkR8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011170 build_url: 'https://queue.taskcluster.net/v1/task/b6ou9dPDQpalcDoAEKkR8A/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/239cce380c9efa1069b8cc2b6a3b017b3b680946bba1b2f75512b3cbf4c6f71ccebcad62bc6163eb756b4f18a6e55cb2845c1bae177e7161d846ea5fcd1ceaea", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4c36e1cc3607e697f9444abc4078b235b7354838fd04f92d4a3d0bb1659bfe920de4ce67c8bf261aaf9eddcd5fa6e2a3ff9a4e913504a4f12f15b1bb7cbad7b1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/89171e4851064f8a285c0d0aeb0caffb35ecb254e1a1cfd5bb3ffd770a28ba67e48ef881648aec0034c3bb7aea8f9d4cc928351cd0c1ce1472943659d7fa8bbc"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-15 12:47:37.740769) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 12:47:37.741508) ========= 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=41bf3e9aed84707956354da8000001c5-1468610824.650182-239027312 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004593 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 12:47:37.822609) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-15 12:47:37.823353) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-15 12:47:37.824028) ========= ========= Total master_lag: 0.31 =========