builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-040 starttime: 1468063380.64 results: success (0) buildid: 20160709013205 builduid: 407d8540e4834fe3abeb9dcfde5a0646 revision: 942dac3830549a98809abca0d62aeb7599c51631 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-09 04:23:00.639603) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-09 04:23:00.639996) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-09 04:23:00.640263) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-09 04:23:00.687851) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-09 04:23:00.688224) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1468060409.406568-104905261 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-09 04:23:00-- 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% 51.2M=0s 2016-07-09 04:23:00 (51.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.088808 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-09 04:23:00.791911) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-09 04:23:00.792215) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1468060409.406568-104905261 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015482 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-09 04:23:00.852001) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-09 04:23:00.852303) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 942dac3830549a98809abca0d62aeb7599c51631 --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 942dac3830549a98809abca0d62aeb7599c51631 --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=9e0dfe3369c33a1556e63f89000001d8-1468060409.406568-104905261 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-09 04:23:01,054 truncating revision to first 12 chars 2016-07-09 04:23:01,055 Setting DEBUG logging. 2016-07-09 04:23:01,055 attempt 1/10 2016-07-09 04:23:01,055 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/942dac383054?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-09 04:23:01,982 unpacking tar archive at: mozilla-inbound-942dac383054/testing/mozharness/ program finished with exit code 0 elapsedTime=1.277206 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-09 04:23:02.144493) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-09 04:23:02.144856) ========= script_repo_revision: 942dac3830549a98809abca0d62aeb7599c51631 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-09 04:23:02.145329) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-09 04:23:02.145656) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-09 04:23:02.156573) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-07-09 04:23:02.156879) ========= /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=9e0dfe3369c33a1556e63f89000001d8-1468060409.406568-104905261 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:23:02 INFO - MultiFileLogger online at 20160709 04:23:02 in /builds/slave/test 04:23:02 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 04:23:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:23:02 INFO - {'append_to_log': False, 04:23:02 INFO - 'base_work_dir': '/builds/slave/test', 04:23:02 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 04:23:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:23:02 INFO - 'branch': 'Mozilla-Inbound', 04:23:02 INFO - 'buildbot_json_path': 'buildprops.json', 04:23:02 INFO - 'config_files': ('talos/linux_config.py',), 04:23:02 INFO - 'default_actions': ('clobber', 04:23:02 INFO - 'read-buildbot-config', 04:23:02 INFO - 'download-and-extract', 04:23:02 INFO - 'populate-webroot', 04:23:02 INFO - 'create-virtualenv', 04:23:02 INFO - 'install', 04:23:02 INFO - 'run-tests'), 04:23:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:23:02 INFO - 'download_minidump_stackwalk': True, 04:23:02 INFO - 'download_symbols': 'ondemand', 04:23:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:23:02 INFO - 'tooltool.py': '/tools/tooltool.py', 04:23:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:23:02 INFO - '/tools/misc-python/virtualenv.py')}, 04:23:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:23:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:23:02 INFO - 'installer_path': 'installer.exe', 04:23:02 INFO - 'log_level': 'info', 04:23:02 INFO - 'log_name': 'talos', 04:23:02 INFO - 'log_to_console': True, 04:23:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:23:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:23:02 INFO - 'opt_config_files': (), 04:23:02 INFO - 'pip_index': False, 04:23:02 INFO - 'sps_profile': False, 04:23:02 INFO - 'sps_profile_interval': 0, 04:23:02 INFO - 'suite': 'dromaeojs', 04:23:02 INFO - 'system_bits': '32', 04:23:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:23:02 INFO - 'title': 'talos-linux64-ix-040', 04:23:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:23:02 INFO - 'use_talos_json': True, 04:23:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:23:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:23:02 INFO - 'work_dir': 'build'} 04:23:02 INFO - ##### 04:23:02 INFO - ##### Running clobber step. 04:23:02 INFO - ##### 04:23:02 INFO - Running pre-action listener: _resource_record_pre_action 04:23:02 INFO - Running main action method: clobber 04:23:02 INFO - rmtree: /builds/slave/test/build 04:23:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:23:02 INFO - Running post-action listener: _resource_record_post_action 04:23:02 INFO - ##### 04:23:02 INFO - ##### Finished clobber step (success) 04:23:02 INFO - ##### 04:23:02 INFO - ##### 04:23:02 INFO - ##### Running read-buildbot-config step. 04:23:02 INFO - ##### 04:23:02 INFO - Running pre-action listener: _resource_record_pre_action 04:23:02 INFO - Running main action method: read_buildbot_config 04:23:02 INFO - Using buildbot properties: 04:23:02 INFO - { 04:23:02 INFO - "project": "", 04:23:02 INFO - "product": "firefox", 04:23:02 INFO - "script_repo_revision": "production", 04:23:02 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 04:23:02 INFO - "repository": "", 04:23:02 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 04:23:02 INFO - "buildid": "20160709013205", 04:23:02 INFO - "pgo_build": "True", 04:23:02 INFO - "basedir": "/builds/slave/test", 04:23:02 INFO - "buildnumber": 1222, 04:23:02 INFO - "slavename": "talos-linux64-ix-040", 04:23:02 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:23:02 INFO - "platform": "ubuntu64_hw", 04:23:02 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 04:23:02 INFO - "branch": "mozilla-inbound", 04:23:02 INFO - "repo_path": "integration/mozilla-inbound", 04:23:02 INFO - "revision": "942dac3830549a98809abca0d62aeb7599c51631", 04:23:02 INFO - "stage_platform": "linux64-pgo", 04:23:02 INFO - "builduid": "407d8540e4834fe3abeb9dcfde5a0646", 04:23:02 INFO - "slavebuilddir": "test" 04:23:02 INFO - } 04:23:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/WbUEBQaJTtGR5NhfPmTf9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 04:23:02 INFO - Running post-action listener: _resource_record_post_action 04:23:02 INFO - ##### 04:23:02 INFO - ##### Finished read-buildbot-config step (success) 04:23:02 INFO - ##### 04:23:02 INFO - ##### 04:23:02 INFO - ##### Running download-and-extract step. 04:23:02 INFO - ##### 04:23:02 INFO - Running pre-action listener: _resource_record_pre_action 04:23:02 INFO - Running main action method: download_and_extract 04:23:02 INFO - mkdir: /builds/slave/test/build/tests 04:23:02 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')]} 04:23:02 INFO - https://queue.taskcluster.net/v1/task/WbUEBQaJTtGR5NhfPmTf9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:23:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WbUEBQaJTtGR5NhfPmTf9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:23:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WbUEBQaJTtGR5NhfPmTf9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:23:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WbUEBQaJTtGR5NhfPmTf9g/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 04:23:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WbUEBQaJTtGR5NhfPmTf9g/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 04:23:09 INFO - Downloaded 1361 bytes. 04:23:09 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:23:09 INFO - Using the following test package requirements: 04:23:09 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 04:23:09 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:23:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:23:09 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:23:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:23:09 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:23:09 INFO - u'jsshell-linux-x86_64.zip'], 04:23:09 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:23:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:23:09 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 04:23:09 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:23:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:23:09 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:23:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:23:09 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:23:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:23:09 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:23:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:23:09 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:23:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:09 INFO - https://queue.taskcluster.net/v1/task/WbUEBQaJTtGR5NhfPmTf9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:23:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WbUEBQaJTtGR5NhfPmTf9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:23:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WbUEBQaJTtGR5NhfPmTf9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:23:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WbUEBQaJTtGR5NhfPmTf9g/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 04:23:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WbUEBQaJTtGR5NhfPmTf9g/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 04:23:16 INFO - Downloaded 24307096 bytes. 04:23:16 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'] 04:23:16 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 04:23:17 INFO - Return code: 0 04:23:17 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 04:23:17 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')]} 04:23:17 INFO - https://queue.taskcluster.net/v1/task/WbUEBQaJTtGR5NhfPmTf9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:23:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WbUEBQaJTtGR5NhfPmTf9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:23:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WbUEBQaJTtGR5NhfPmTf9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:23:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WbUEBQaJTtGR5NhfPmTf9g/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 04:23:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WbUEBQaJTtGR5NhfPmTf9g/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 04:23:18 INFO - Downloaded 24307096 bytes. 04:23:18 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'] 04:23:18 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 04:23:19 INFO - Return code: 0 04:23: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')]} 04:23:19 INFO - https://queue.taskcluster.net/v1/task/WbUEBQaJTtGR5NhfPmTf9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:23:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WbUEBQaJTtGR5NhfPmTf9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:23:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WbUEBQaJTtGR5NhfPmTf9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:23:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WbUEBQaJTtGR5NhfPmTf9g/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 04:23:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WbUEBQaJTtGR5NhfPmTf9g/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 04:23:20 INFO - Downloaded 14403333 bytes. 04:23:20 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'] 04:23:20 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 04:23:21 INFO - Return code: 0 04:23:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:21 INFO - https://queue.taskcluster.net/v1/task/WbUEBQaJTtGR5NhfPmTf9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:23:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WbUEBQaJTtGR5NhfPmTf9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:23:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WbUEBQaJTtGR5NhfPmTf9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:23:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WbUEBQaJTtGR5NhfPmTf9g/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 04:23:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WbUEBQaJTtGR5NhfPmTf9g/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 04:23:22 INFO - Downloaded 60467768 bytes. 04:23:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WbUEBQaJTtGR5NhfPmTf9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:23:22 INFO - mkdir: /builds/slave/test/properties 04:23:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:23:22 INFO - Writing to file /builds/slave/test/properties/build_url 04:23:22 INFO - Contents: 04:23:22 INFO - build_url:https://queue.taskcluster.net/v1/task/WbUEBQaJTtGR5NhfPmTf9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:23:23 INFO - Running post-action listener: _resource_record_post_action 04:23:23 INFO - Running post-action listener: set_extra_try_arguments 04:23:23 INFO - ##### 04:23:23 INFO - ##### Finished download-and-extract step (success) 04:23:23 INFO - ##### 04:23:23 INFO - ##### 04:23:23 INFO - ##### Running populate-webroot step. 04:23:23 INFO - ##### 04:23:23 INFO - Running pre-action listener: _resource_record_pre_action 04:23:23 INFO - Running main action method: populate_webroot 04:23:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:23:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:23:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:23:23 INFO - '--tppagecycles', 04:23:23 INFO - '7'], 04:23:23 INFO - 'tests': ['tsvgm']}}, 04:23:23 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:23:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:23:23 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:23:23 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:23:23 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:23:23 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:23:23 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:23:23 INFO - 'talos_options': ['--disable-e10s'], 04:23:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:23:23 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:23:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:23:23 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:23:23 INFO - 'talos_options': ['--disable-e10s'], 04:23:23 INFO - 'tests': ['damp', 'tps']}, 04:23:23 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:23:23 INFO - 'tests': ['damp', 'tps']}, 04:23:23 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:23:23 INFO - 'tests': ['dromaeo_dom']}, 04:23:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:23:23 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:23:23 INFO - 'tests': ['basic_compositor_video']}, 04:23:23 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:23:23 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:23:23 INFO - 'tests': ['a11yr', 04:23:23 INFO - 'ts_paint', 04:23:23 INFO - 'tpaint', 04:23:23 INFO - 'sessionrestore', 04:23:23 INFO - 'sessionrestore_no_auto_restore', 04:23:23 INFO - 'tabpaint']}, 04:23:23 INFO - 'other-e10s': {'tests': ['a11yr', 04:23:23 INFO - 'ts_paint', 04:23:23 INFO - 'tpaint', 04:23:23 INFO - 'sessionrestore', 04:23:23 INFO - 'sessionrestore_no_auto_restore', 04:23:23 INFO - 'tabpaint']}, 04:23:23 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:23:23 INFO - 'ts_paint', 04:23:23 INFO - 'tpaint', 04:23:23 INFO - 'sessionrestore', 04:23:23 INFO - 'sessionrestore_no_auto_restore', 04:23:23 INFO - 'tabpaint']}, 04:23:23 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:23:23 INFO - 'ts_paint', 04:23:23 INFO - 'tpaint', 04:23:23 INFO - 'sessionrestore', 04:23:23 INFO - 'sessionrestore_no_auto_restore', 04:23:23 INFO - 'tabpaint']}, 04:23:23 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:23:23 INFO - 'tests': ['a11yr', 04:23:23 INFO - 'ts_paint', 04:23:23 INFO - 'tpaint', 04:23:23 INFO - 'sessionrestore', 04:23:23 INFO - 'sessionrestore_no_auto_restore', 04:23:23 INFO - 'tabpaint']}, 04:23:23 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:23:23 INFO - 'tests': ['a11yr', 04:23:23 INFO - 'ts_paint', 04:23:23 INFO - 'tpaint', 04:23:23 INFO - 'sessionrestore', 04:23:23 INFO - 'sessionrestore_no_auto_restore', 04:23:23 INFO - 'tabpaint']}, 04:23:23 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:23:23 INFO - 'tests': ['tsvgx', 04:23:23 INFO - 'tsvgr_opacity', 04:23:23 INFO - 'tart', 04:23:23 INFO - 'tscrollx', 04:23:23 INFO - 'cart']}, 04:23:23 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:23:23 INFO - 'tsvgr_opacity', 04:23:23 INFO - 'tart', 04:23:23 INFO - 'tscrollx', 04:23:23 INFO - 'cart']}, 04:23:23 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:23:23 INFO - 'talos_options': ['--disable-e10s'], 04:23:23 INFO - 'tests': ['tp5o']}, 04:23:23 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:23:23 INFO - 'tests': ['tp5o']}, 04:23:23 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:23:23 INFO - 'talos_options': ['--disable-e10s', 04:23:23 INFO - '--xperf_path', 04:23:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:23:23 INFO - 'tests': ['tp5n']}, 04:23:23 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:23:23 INFO - 'talos_options': ['--xperf_path', 04:23:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:23:23 INFO - 'tests': ['tp5n']}}, 04:23:23 INFO - 'talos.zip': {'path': '', 04:23:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:23:23 INFO - Running post-action listener: _resource_record_post_action 04:23:23 INFO - ##### 04:23:23 INFO - ##### Finished populate-webroot step (success) 04:23:23 INFO - ##### 04:23:23 INFO - ##### 04:23:23 INFO - ##### Running create-virtualenv step. 04:23:23 INFO - ##### 04:23:23 INFO - Running pre-action listener: _resource_record_pre_action 04:23:23 INFO - Running main action method: create_virtualenv 04:23:23 INFO - Creating virtualenv /builds/slave/test/build/venv 04:23:23 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 04:23:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:23:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:23:23 INFO - Using real prefix '/usr' 04:23:23 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:23:23 INFO - Installing distribute.............................................................................................................................................................................................done. 04:23:25 INFO - Installing pip.................done. 04:23:25 INFO - Return code: 0 04:23:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:23:25 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')]} 04:23:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:25 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')]} 04:23:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:25 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 0x2a9c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d5d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d5b3b0>, '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 0x2d5c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d5c740>, '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': '9e0dfe3369c33a1556e63f89000001d8-1468060409.406568-104905261', '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 04:23:25 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 04:23:25 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 04:23:25 INFO - Using env: {'DISPLAY': ':0', 04:23:25 INFO - 'HOME': '/home/cltbld', 04:23:25 INFO - 'LANG': 'en_US.UTF-8', 04:23:25 INFO - 'LANGUAGE': 'en_US:en', 04:23:25 INFO - 'LOGNAME': 'cltbld', 04:23:25 INFO - 'MAIL': '/var/mail/cltbld', 04:23:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:25 INFO - 'MOZ_NO_REMOTE': '1', 04:23:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:25 INFO - 'NO_EM_RESTART': '1', 04:23:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:25 INFO - 'PWD': '/builds/slave/test', 04:23:25 INFO - 'SHELL': '/bin/bash', 04:23:25 INFO - 'SHLVL': '1', 04:23:25 INFO - 'TERM': 'linux', 04:23:25 INFO - 'TMOUT': '86400', 04:23:25 INFO - 'USER': 'cltbld', 04:23:25 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1468060409.406568-104905261', 04:23:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:25 INFO - '_': '/tools/buildbot/bin/python'} 04:23:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:25 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 04:23:25 INFO - Cleaning up... 04:23:26 INFO - Return code: 0 04:23:26 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:23:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x2a9c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d5d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d5b3b0>, '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 0x2d5c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d5c740>, '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': '9e0dfe3369c33a1556e63f89000001d8-1468060409.406568-104905261', '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 04:23:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:23:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:23:26 INFO - Using env: {'DISPLAY': ':0', 04:23:26 INFO - 'HOME': '/home/cltbld', 04:23:26 INFO - 'LANG': 'en_US.UTF-8', 04:23:26 INFO - 'LANGUAGE': 'en_US:en', 04:23:26 INFO - 'LOGNAME': 'cltbld', 04:23:26 INFO - 'MAIL': '/var/mail/cltbld', 04:23:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:26 INFO - 'MOZ_NO_REMOTE': '1', 04:23:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:26 INFO - 'NO_EM_RESTART': '1', 04:23:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:26 INFO - 'PWD': '/builds/slave/test', 04:23:26 INFO - 'SHELL': '/bin/bash', 04:23:26 INFO - 'SHLVL': '1', 04:23:26 INFO - 'TERM': 'linux', 04:23:26 INFO - 'TMOUT': '86400', 04:23:26 INFO - 'USER': 'cltbld', 04:23:26 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1468060409.406568-104905261', 04:23:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:26 INFO - '_': '/tools/buildbot/bin/python'} 04:23:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:26 INFO - Downloading/unpacking psutil>=3.1.1 04:23: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 04:23: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 04:23: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 04:23: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 04:23: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 04:23: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 04:23:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:23:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:23:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:23:28 INFO - Installing collected packages: psutil 04:23:28 INFO - Running setup.py install for psutil 04:23:28 INFO - building 'psutil._psutil_linux' extension 04:23:28 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 04:23:28 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 04:23:28 INFO - building 'psutil._psutil_posix' extension 04:23:28 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 04:23:28 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 04:23:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:23:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:23:28 INFO - Successfully installed psutil 04:23:28 INFO - Cleaning up... 04:23:28 INFO - Return code: 0 04:23:28 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:23:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a9c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d5d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d5b3b0>, '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 0x2d5c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d5c740>, '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': '9e0dfe3369c33a1556e63f89000001d8-1468060409.406568-104905261', '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 04:23:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:23:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:23:28 INFO - Using env: {'DISPLAY': ':0', 04:23:28 INFO - 'HOME': '/home/cltbld', 04:23:28 INFO - 'LANG': 'en_US.UTF-8', 04:23:28 INFO - 'LANGUAGE': 'en_US:en', 04:23:28 INFO - 'LOGNAME': 'cltbld', 04:23:28 INFO - 'MAIL': '/var/mail/cltbld', 04:23:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:28 INFO - 'MOZ_NO_REMOTE': '1', 04:23:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:28 INFO - 'NO_EM_RESTART': '1', 04:23:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:28 INFO - 'PWD': '/builds/slave/test', 04:23:28 INFO - 'SHELL': '/bin/bash', 04:23:28 INFO - 'SHLVL': '1', 04:23:28 INFO - 'TERM': 'linux', 04:23:28 INFO - 'TMOUT': '86400', 04:23:28 INFO - 'USER': 'cltbld', 04:23:28 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1468060409.406568-104905261', 04:23:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:28 INFO - '_': '/tools/buildbot/bin/python'} 04:23:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:28 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:23:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:30 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:23:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:23:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:23:30 INFO - Installing collected packages: mozsystemmonitor 04:23:30 INFO - Running setup.py install for mozsystemmonitor 04:23:31 INFO - Successfully installed mozsystemmonitor 04:23:31 INFO - Cleaning up... 04:23:31 INFO - Return code: 0 04:23:31 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:23: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')]} 04:23:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23: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')]} 04:23:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x2a9c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d5d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d5b3b0>, '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 0x2d5c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d5c740>, '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': '9e0dfe3369c33a1556e63f89000001d8-1468060409.406568-104905261', '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 04:23:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:23:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:23:31 INFO - Using env: {'DISPLAY': ':0', 04:23:31 INFO - 'HOME': '/home/cltbld', 04:23:31 INFO - 'LANG': 'en_US.UTF-8', 04:23:31 INFO - 'LANGUAGE': 'en_US:en', 04:23:31 INFO - 'LOGNAME': 'cltbld', 04:23:31 INFO - 'MAIL': '/var/mail/cltbld', 04:23:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:31 INFO - 'MOZ_NO_REMOTE': '1', 04:23:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:31 INFO - 'NO_EM_RESTART': '1', 04:23:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:31 INFO - 'PWD': '/builds/slave/test', 04:23:31 INFO - 'SHELL': '/bin/bash', 04:23:31 INFO - 'SHLVL': '1', 04:23:31 INFO - 'TERM': 'linux', 04:23:31 INFO - 'TMOUT': '86400', 04:23:31 INFO - 'USER': 'cltbld', 04:23:31 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1468060409.406568-104905261', 04:23:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:31 INFO - '_': '/tools/buildbot/bin/python'} 04:23:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:31 INFO - Downloading/unpacking jsonschema==2.5.1 04:23:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:23:33 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:23:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:33 INFO - Downloading functools32-3.2.3-2.tar.gz 04:23:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:23:33 INFO - warning: no files found matching '*.txt' 04:23:33 INFO - no previously-included directories found matching 'build' 04:23:33 INFO - no previously-included directories found matching 'dist' 04:23:33 INFO - no previously-included directories found matching '.git*' 04:23:33 INFO - Installing collected packages: jsonschema, functools32 04:23:33 INFO - Running setup.py install for functools32 04:23:33 INFO - warning: no files found matching '*.txt' 04:23:33 INFO - no previously-included directories found matching 'build' 04:23:33 INFO - no previously-included directories found matching 'dist' 04:23:33 INFO - no previously-included directories found matching '.git*' 04:23:33 INFO - Successfully installed jsonschema functools32 04:23:33 INFO - Cleaning up... 04:23:33 INFO - Return code: 0 04:23:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:23:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x2a9c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d5d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d5b3b0>, '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 0x2d5c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d5c740>, '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': '9e0dfe3369c33a1556e63f89000001d8-1468060409.406568-104905261', '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 04:23:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:23:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:23:33 INFO - Using env: {'DISPLAY': ':0', 04:23:33 INFO - 'HOME': '/home/cltbld', 04:23:33 INFO - 'LANG': 'en_US.UTF-8', 04:23:33 INFO - 'LANGUAGE': 'en_US:en', 04:23:33 INFO - 'LOGNAME': 'cltbld', 04:23:33 INFO - 'MAIL': '/var/mail/cltbld', 04:23:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:33 INFO - 'MOZ_NO_REMOTE': '1', 04:23:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:33 INFO - 'NO_EM_RESTART': '1', 04:23:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:33 INFO - 'PWD': '/builds/slave/test', 04:23:33 INFO - 'SHELL': '/bin/bash', 04:23:33 INFO - 'SHLVL': '1', 04:23:33 INFO - 'TERM': 'linux', 04:23:33 INFO - 'TMOUT': '86400', 04:23:33 INFO - 'USER': 'cltbld', 04:23:33 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1468060409.406568-104905261', 04:23:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:33 INFO - '_': '/tools/buildbot/bin/python'} 04:23:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:33 INFO - Downloading/unpacking blobuploader==1.2.4 04:23:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:35 INFO - Downloading blobuploader-1.2.4.tar.gz 04:23:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:23:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:23: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 04:23: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 04:23: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 04:23: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 04:23: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 04:23: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 04:23:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:23:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:23:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:36 INFO - Downloading docopt-0.6.1.tar.gz 04:23:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:23:36 INFO - Installing collected packages: blobuploader, requests, docopt 04:23:36 INFO - Running setup.py install for blobuploader 04:23:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:23:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:23:36 INFO - Running setup.py install for requests 04:23:36 INFO - Running setup.py install for docopt 04:23:37 INFO - Successfully installed blobuploader requests docopt 04:23:37 INFO - Cleaning up... 04:23:37 INFO - Return code: 0 04:23:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:23:37 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')]} 04:23:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:37 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')]} 04:23:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:37 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 0x2a9c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d5d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d5b3b0>, '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 0x2d5c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d5c740>, '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': '9e0dfe3369c33a1556e63f89000001d8-1468060409.406568-104905261', '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 04:23:37 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 04:23:37 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 04:23:37 INFO - Using env: {'DISPLAY': ':0', 04:23:37 INFO - 'HOME': '/home/cltbld', 04:23:37 INFO - 'LANG': 'en_US.UTF-8', 04:23:37 INFO - 'LANGUAGE': 'en_US:en', 04:23:37 INFO - 'LOGNAME': 'cltbld', 04:23:37 INFO - 'MAIL': '/var/mail/cltbld', 04:23:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:37 INFO - 'MOZ_NO_REMOTE': '1', 04:23:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:37 INFO - 'NO_EM_RESTART': '1', 04:23:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:37 INFO - 'PWD': '/builds/slave/test', 04:23:37 INFO - 'SHELL': '/bin/bash', 04:23:37 INFO - 'SHLVL': '1', 04:23:37 INFO - 'TERM': 'linux', 04:23:37 INFO - 'TMOUT': '86400', 04:23:37 INFO - 'USER': 'cltbld', 04:23:37 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1468060409.406568-104905261', 04:23:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:37 INFO - '_': '/tools/buildbot/bin/python'} 04:23:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:23:37 INFO - Running setup.py (path:/tmp/pip-xLLJmv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:23:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:23:37 INFO - Running setup.py (path:/tmp/pip-IXjC5d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:23:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:23:37 INFO - Running setup.py (path:/tmp/pip-0XHwEP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:23:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:23:37 INFO - Running setup.py (path:/tmp/pip-FR6dY0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:23:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:23:37 INFO - Running setup.py (path:/tmp/pip-jy_nR2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:23:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:23:37 INFO - Running setup.py (path:/tmp/pip-TtQmRr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:23:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:23:37 INFO - Running setup.py (path:/tmp/pip-NqF1cT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:23:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:23:37 INFO - Running setup.py (path:/tmp/pip-pIZ1Vp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:23:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:23:37 INFO - Running setup.py (path:/tmp/pip-pBi639-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:23:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:23:38 INFO - Running setup.py (path:/tmp/pip-MXoyAe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:23:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:23:38 INFO - Running setup.py (path:/tmp/pip-oWJsH6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:23:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:23:38 INFO - Running setup.py (path:/tmp/pip-86TSwZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:23:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:23:38 INFO - Running setup.py (path:/tmp/pip-uVb2rf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:23:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:23:38 INFO - Running setup.py (path:/tmp/pip-lmHIsv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:23:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:23:38 INFO - Running setup.py (path:/tmp/pip-QuoLZs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:23:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:23:38 INFO - Running setup.py (path:/tmp/pip-ZAiaI2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:23:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:23:38 INFO - Running setup.py (path:/tmp/pip-ZpLpA6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:23:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:23:38 INFO - Running setup.py install for manifestparser 04:23:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:23:38 INFO - Running setup.py install for mozcrash 04:23:38 INFO - Running setup.py install for mozdebug 04:23:38 INFO - Running setup.py install for mozdevice 04:23:38 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:23:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:23:39 INFO - Running setup.py install for mozfile 04:23:39 INFO - Running setup.py install for mozhttpd 04:23:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:23:39 INFO - Running setup.py install for mozinfo 04:23:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:23:39 INFO - Running setup.py install for mozInstall 04:23:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:23:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:23:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:23:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:23:39 INFO - Running setup.py install for mozleak 04:23:39 INFO - Running setup.py install for mozlog 04:23:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:23:39 INFO - Running setup.py install for moznetwork 04:23:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:23:39 INFO - Running setup.py install for mozprocess 04:23:39 INFO - Running setup.py install for mozprofile 04:23:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:23:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:23:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:23:39 INFO - Running setup.py install for mozrunner 04:23:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:23:40 INFO - Running setup.py install for mozscreenshot 04:23:40 INFO - Running setup.py install for moztest 04:23:40 INFO - Running setup.py install for mozversion 04:23:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:23:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:23:40 INFO - Cleaning up... 04:23:40 INFO - Return code: 0 04:23:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:23:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:40 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 0x2a9c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d5d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d5b3b0>, '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 0x2d5c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d5c740>, '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': '9e0dfe3369c33a1556e63f89000001d8-1468060409.406568-104905261', '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 04:23:40 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 04:23:40 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 04:23:40 INFO - Using env: {'DISPLAY': ':0', 04:23:40 INFO - 'HOME': '/home/cltbld', 04:23:40 INFO - 'LANG': 'en_US.UTF-8', 04:23:40 INFO - 'LANGUAGE': 'en_US:en', 04:23:40 INFO - 'LOGNAME': 'cltbld', 04:23:40 INFO - 'MAIL': '/var/mail/cltbld', 04:23:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:40 INFO - 'MOZ_NO_REMOTE': '1', 04:23:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:40 INFO - 'NO_EM_RESTART': '1', 04:23:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:40 INFO - 'PWD': '/builds/slave/test', 04:23:40 INFO - 'SHELL': '/bin/bash', 04:23:40 INFO - 'SHLVL': '1', 04:23:40 INFO - 'TERM': 'linux', 04:23:40 INFO - 'TMOUT': '86400', 04:23:40 INFO - 'USER': 'cltbld', 04:23:40 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1468060409.406568-104905261', 04:23:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:40 INFO - '_': '/tools/buildbot/bin/python'} 04:23:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:23:40 INFO - Running setup.py (path:/tmp/pip-OFyBI_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:23:40 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)) 04:23:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:23:40 INFO - Running setup.py (path:/tmp/pip-Tc8X2y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:23:40 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)) 04:23:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:23:40 INFO - Running setup.py (path:/tmp/pip-V8SbfD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:23:40 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)) 04:23:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:23:40 INFO - Running setup.py (path:/tmp/pip-9xoqV_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:23:40 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)) 04:23:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:23:40 INFO - Running setup.py (path:/tmp/pip-v98mmX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:23:40 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)) 04:23:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:23:40 INFO - Running setup.py (path:/tmp/pip-f641O9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:23:41 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)) 04:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:23:41 INFO - Running setup.py (path:/tmp/pip-VUJmSr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:23:41 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)) 04:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:23:41 INFO - Running setup.py (path:/tmp/pip-91DyEv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:23:41 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)) 04:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:23:41 INFO - Running setup.py (path:/tmp/pip-SaJcRP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:23:41 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)) 04:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:23:41 INFO - Running setup.py (path:/tmp/pip-B_u1QG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:23:41 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)) 04:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:23:41 INFO - Running setup.py (path:/tmp/pip-h_DRPW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:23:41 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)) 04:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:23:41 INFO - Running setup.py (path:/tmp/pip-95KUH7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:23:41 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)) 04:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:23:41 INFO - Running setup.py (path:/tmp/pip-N0IW2n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:23:41 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)) 04:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:23:41 INFO - Running setup.py (path:/tmp/pip-2iVP6d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:23:41 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)) 04:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:23:41 INFO - Running setup.py (path:/tmp/pip-zEFFk8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:23:41 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)) 04:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:23:41 INFO - Running setup.py (path:/tmp/pip-EJwEU_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:23:41 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)) 04:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:23:41 INFO - Running setup.py (path:/tmp/pip-t3crPU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:23:41 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)) 04:23:41 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)) 04:23:41 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)) 04:23:41 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)) 04:23:41 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)) 04:23:41 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)) 04:23:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:23:41 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 04:23:41 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 04:23:41 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 04:23:41 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 04:23:41 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 04:23:41 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 04:23:43 INFO - Downloading blessings-1.6.tar.gz 04:23:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:23:43 INFO - Installing collected packages: blessings 04:23:43 INFO - Running setup.py install for blessings 04:23:43 INFO - Successfully installed blessings 04:23:43 INFO - Cleaning up... 04:23:44 INFO - Return code: 0 04:23:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:23:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:23:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:23:44 INFO - Reading from file tmpfile_stdout 04:23:44 INFO - Current package versions: 04:23:44 INFO - argparse == 1.2.1 04:23:44 INFO - blessings == 1.6 04:23:44 INFO - blobuploader == 1.2.4 04:23:44 INFO - docopt == 0.6.1 04:23:44 INFO - functools32 == 3.2.3-2 04:23:44 INFO - jsonschema == 2.5.1 04:23:44 INFO - manifestparser == 1.1 04:23:44 INFO - mozInstall == 1.12 04:23:44 INFO - mozcrash == 0.17 04:23:44 INFO - mozdebug == 0.1 04:23:44 INFO - mozdevice == 0.48 04:23:44 INFO - mozfile == 1.2 04:23:44 INFO - mozhttpd == 0.7 04:23:44 INFO - mozinfo == 0.9 04:23:44 INFO - mozleak == 0.1 04:23:44 INFO - mozlog == 3.2 04:23:44 INFO - moznetwork == 0.27 04:23:44 INFO - mozprocess == 0.23 04:23:44 INFO - mozprofile == 0.28 04:23:44 INFO - mozrunner == 6.12 04:23:44 INFO - mozscreenshot == 0.1 04:23:44 INFO - mozsystemmonitor == 0.3 04:23:44 INFO - moztest == 0.7 04:23:44 INFO - mozversion == 1.4 04:23:44 INFO - psutil == 3.1.1 04:23:44 INFO - requests == 1.2.3 04:23:44 INFO - wsgiref == 0.1.2 04:23:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:23:44 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')]} 04:23:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:44 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')]} 04:23:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:44 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 0x2a9c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d5d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d5b3b0>, '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 0x2d5c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d5c740>, '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': '9e0dfe3369c33a1556e63f89000001d8-1468060409.406568-104905261', '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 04:23:44 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 04:23:44 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 04:23:44 INFO - Using env: {'DISPLAY': ':0', 04:23:44 INFO - 'HOME': '/home/cltbld', 04:23:44 INFO - 'LANG': 'en_US.UTF-8', 04:23:44 INFO - 'LANGUAGE': 'en_US:en', 04:23:44 INFO - 'LOGNAME': 'cltbld', 04:23:44 INFO - 'MAIL': '/var/mail/cltbld', 04:23:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:44 INFO - 'MOZ_NO_REMOTE': '1', 04:23:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:44 INFO - 'NO_EM_RESTART': '1', 04:23:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:44 INFO - 'PWD': '/builds/slave/test', 04:23:44 INFO - 'SHELL': '/bin/bash', 04:23:44 INFO - 'SHLVL': '1', 04:23:44 INFO - 'TERM': 'linux', 04:23:44 INFO - 'TMOUT': '86400', 04:23:44 INFO - 'USER': 'cltbld', 04:23:44 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1468060409.406568-104905261', 04:23:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:44 INFO - '_': '/tools/buildbot/bin/python'} 04:23:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:44 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)) 04:23:44 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)) 04:23:44 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)) 04:23:44 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)) 04:23:44 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)) 04:23:44 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)) 04:23:44 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)) 04:23:44 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)) 04:23:44 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)) 04:23:44 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)) 04:23:44 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)) 04:23:44 INFO - Cleaning up... 04:23:44 INFO - Return code: 0 04:23:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:23:44 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')]} 04:23:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:44 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')]} 04:23:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:44 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 0x2a9c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d5d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d5b3b0>, '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 0x2d5c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d5c740>, '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': '9e0dfe3369c33a1556e63f89000001d8-1468060409.406568-104905261', '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 04:23:44 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 04:23:44 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 04:23:44 INFO - Using env: {'DISPLAY': ':0', 04:23:44 INFO - 'HOME': '/home/cltbld', 04:23:44 INFO - 'LANG': 'en_US.UTF-8', 04:23:44 INFO - 'LANGUAGE': 'en_US:en', 04:23:44 INFO - 'LOGNAME': 'cltbld', 04:23:44 INFO - 'MAIL': '/var/mail/cltbld', 04:23:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:44 INFO - 'MOZ_NO_REMOTE': '1', 04:23:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:44 INFO - 'NO_EM_RESTART': '1', 04:23:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:44 INFO - 'PWD': '/builds/slave/test', 04:23:44 INFO - 'SHELL': '/bin/bash', 04:23:44 INFO - 'SHLVL': '1', 04:23:44 INFO - 'TERM': 'linux', 04:23:44 INFO - 'TMOUT': '86400', 04:23:44 INFO - 'USER': 'cltbld', 04:23:44 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1468060409.406568-104905261', 04:23:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:44 INFO - '_': '/tools/buildbot/bin/python'} 04:23:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:44 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:23:44 INFO - Cleaning up... 04:23:44 INFO - Return code: 0 04:23:44 INFO - Running post-action listener: _resource_record_post_action 04:23:44 INFO - Running post-action listener: _start_resource_monitoring 04:23:44 INFO - Starting resource monitoring. 04:23:44 INFO - ##### 04:23:44 INFO - ##### Finished create-virtualenv step (success) 04:23:44 INFO - ##### 04:23:44 INFO - ##### 04:23:44 INFO - ##### Running install step. 04:23:44 INFO - ##### 04:23:44 INFO - Running pre-action listener: _resource_record_pre_action 04:23:44 INFO - Running main action method: install 04:23:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:23:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:23:44 INFO - Reading from file tmpfile_stdout 04:23:44 INFO - Detecting whether we're running mozinstall >=1.0... 04:23:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:23:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:23:44 INFO - Reading from file tmpfile_stdout 04:23:44 INFO - Output received: 04:23:44 INFO - Usage: mozinstall [options] installer 04:23:44 INFO - Options: 04:23:44 INFO - -h, --help show this help message and exit 04:23:44 INFO - -d DEST, --destination=DEST 04:23:44 INFO - Directory to install application into. [default: 04:23:44 INFO - "/builds/slave/test"] 04:23:44 INFO - --app=APP Application being installed. [default: firefox] 04:23:44 INFO - mkdir: /builds/slave/test/build/application 04:23:44 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'] 04:23:44 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 04:24:02 INFO - Reading from file tmpfile_stdout 04:24:02 INFO - Output received: 04:24:02 INFO - /builds/slave/test/build/application/firefox/firefox 04:24:02 INFO - Running post-action listener: _resource_record_post_action 04:24:02 INFO - ##### 04:24:02 INFO - ##### Finished install step (success) 04:24:02 INFO - ##### 04:24:02 INFO - ##### 04:24:02 INFO - ##### Running run-tests step. 04:24:02 INFO - ##### 04:24:02 INFO - Running pre-action listener: _resource_record_pre_action 04:24:02 INFO - Running main action method: run_tests 04:24:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:24:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:24:02 INFO - Python 2.7.3 04:24:02 INFO - Return code: 0 04:24:02 INFO - grabbing minidump binary from tooltool 04:24:02 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')]} 04:24:02 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 0x2d5b3b0>, '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 0x2d5c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d5c740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:24:02 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 04:24:02 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 04:24:02 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 04:24:02 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:24:02 INFO - Return code: 0 04:24:02 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:24:02 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:24:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:24:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:24:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:24:02 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/WbUEBQaJTtGR5NhfPmTf9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--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 04:24:02 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/WbUEBQaJTtGR5NhfPmTf9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-040 --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 04:24:02 INFO - Using env: {'DISPLAY': ':0', 04:24:02 INFO - 'HOME': '/home/cltbld', 04:24:02 INFO - 'LANG': 'en_US.UTF-8', 04:24:02 INFO - 'LANGUAGE': 'en_US:en', 04:24:02 INFO - 'LOGNAME': 'cltbld', 04:24:02 INFO - 'MAIL': '/var/mail/cltbld', 04:24:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:24:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:24:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:24:02 INFO - 'MOZ_NO_REMOTE': '1', 04:24:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:24:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:24:02 INFO - 'NO_EM_RESTART': '1', 04:24:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:24:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:24:02 INFO - 'PWD': '/builds/slave/test', 04:24:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:24:02 INFO - 'SHELL': '/bin/bash', 04:24:02 INFO - 'SHLVL': '1', 04:24:02 INFO - 'TERM': 'linux', 04:24:02 INFO - 'TMOUT': '86400', 04:24:02 INFO - 'USER': 'cltbld', 04:24:02 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1468060409.406568-104905261', 04:24:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:24:02 INFO - '_': '/tools/buildbot/bin/python'} 04:24:02 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/WbUEBQaJTtGR5NhfPmTf9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--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 04:24:02 INFO - mozversion application_buildid: 20160709013205 04:24:02 INFO - mozversion application_changeset: 942dac3830549a98809abca0d62aeb7599c51631 04:24:02 INFO - mozversion application_display_name: Nightly 04:24:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:24:02 INFO - mozversion application_name: Firefox 04:24:02 INFO - mozversion application_remotingname: firefox 04:24:02 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 04:24:02 INFO - mozversion application_vendor: Mozilla 04:24:02 INFO - mozversion application_version: 50.0a1 04:24:02 INFO - mozversion platform_buildid: 20160709013205 04:24:02 INFO - mozversion platform_changeset: 942dac3830549a98809abca0d62aeb7599c51631 04:24:02 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 04:24:02 INFO - mozversion platform_version: 50.0a1 04:24:02 INFO - using testdate: 1468063442 04:24:02 INFO - actual date: 1468063442 04:24:02 INFO - starting webserver on 'localhost:53321' 04:24:02 INFO - SUITE-START | Running 2 tests 04:24:02 INFO - TEST-START | dromaeo_css 04:24:02 INFO - operating with platform_type : linux_ 04:24:02 INFO - Initialising browser for dromaeo_css test... 04:24:02 INFO - TEST-INFO | started process 16644 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBWScmG/profile http://localhost:53321/getInfo.html) 04:24:06 INFO - PROCESS | 16644 | __metrics Screen width/height:1600/1200 04:24:06 INFO - PROCESS | 16644 | colorDepth:24 04:24:06 INFO - PROCESS | 16644 | Browser inner width/height: 1024/697 04:24:06 INFO - PROCESS | 16644 | __metrics 04:24:07 INFO - PROCESS | 16644 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:24:07 INFO - PROCESS | 16644 | console.error: PushService: 04:24:07 INFO - PROCESS | 16644 | stateChangeProcessEnqueue: Error transitioning state 04:24:07 INFO - PROCESS | 16644 | UnknownError 04:24:08 INFO - TEST-INFO | 16644: exit 0 04:24:08 INFO - Browser initialized. 04:24:08 INFO - Running cycle 1/1 for dromaeo_css test... 04:24:08 INFO - TEST-INFO | started process 16728 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBWScmG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:24:19 INFO - PROCESS | 16728 | RSS: Main: 157646848 04:24:19 INFO - PROCESS | 16728 | 04:25:11 INFO - PROCESS | 16728 | 1468063511465 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] 04:27:19 INFO - PROCESS | 16728 | Cycle 1(1): loaded http://localhost:53321/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53321/tests/dromaeo/cssquery-ext.html) 04:27:20 INFO - PROCESS | 16728 | RSS: Main: 253210624 04:27:20 INFO - PROCESS | 16728 | 04:30:22 INFO - PROCESS | 16728 | Cycle 1(1): loaded http://localhost:53321/tests/dromaeo/cssquery-ext.html (next: http://localhost:53321/tests/dromaeo/cssquery-jquery.html) 04:30:23 INFO - PROCESS | 16728 | RSS: Main: 241364992 04:30:23 INFO - PROCESS | 16728 | 04:33:25 INFO - PROCESS | 16728 | Cycle 1(1): loaded http://localhost:53321/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53321/tests/dromaeo/cssquery-mootools.html) 04:33:25 INFO - PROCESS | 16728 | RSS: Main: 243621888 04:33:25 INFO - PROCESS | 16728 | 04:36:27 INFO - PROCESS | 16728 | Cycle 1(1): loaded http://localhost:53321/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53321/tests/dromaeo/cssquery-prototype.html) 04:36:28 INFO - PROCESS | 16728 | RSS: Main: 233787392 04:36:28 INFO - PROCESS | 16728 | 04:39:30 INFO - PROCESS | 16728 | Cycle 1(1): loaded http://localhost:53321/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53321/tests/dromaeo/cssquery-yui.html) 04:39:31 INFO - PROCESS | 16728 | RSS: Main: 229199872 04:39:31 INFO - PROCESS | 16728 | 04:42:34 INFO - PROCESS | 16728 | Cycle 1(1): loaded http://localhost:53321/tests/dromaeo/cssquery-yui.html (next: http://localhost:53321/tests/dromaeo/cssquery-dojo.html) 04:42:34 INFO - PROCESS | 16728 | RSS: Main: 319160320 04:42:34 INFO - PROCESS | 16728 | 04:42:34 INFO - PROCESS | 16728 | __start_tp_report 04:42:34 INFO - PROCESS | 16728 | _x_x_mozilla_page_load 04:42:34 INFO - PROCESS | 16728 | _x_x_mozilla_page_load_details 04:42:34 INFO - PROCESS | 16728 | |i|pagename|runs| 04:42:34 INFO - PROCESS | 16728 | |0;dojo.html;3033.9393212135756;3081.9691803081964;3099.240686031921;3105.0684794561635;3128.9843550782243;5081.161608334621;5127.564157046646;5296.09966305728;5388.838334849956;5427.945720542798;5221.660592061513;5242.030224408487;5287.444818294081;5298.417174110854;5299.099153143965;4756.262779269219;4834.613230941516;4834.734089625069;4838.830640927568;4971.577415919651;4897.485763994765;4904.4114706235305;4922.433920099181;4961.702297862122;4980.477049909761;4702.106599746055;4707.976460117695;4771.212749896263;4781.593564546983;4790.736509491977;4760.214564596872;4780.378550788375;4848.975755121237;4857.902841943177;4904.926426103611;4669.34629151919;4818.060478206751;4823.469418363977;4834.879128021792;4892.461829198785;5206.140986737184;5257.579393648537;5275.604329675251;5339.652922560022;5356.839294821161;5624.775008999635;5647.717614119278;5654.575906806965;5676.602637815355;5677.318721753375;5485.725713714338;5545.500904918536;5778.913316300259;5813.563982701272;5819.127130930352;5266.499682530153;5345.625806193568;5360.490753378423;5365.678059316415;5366.221897824872;5841.532677385884;5856.882862342729;5858.8242352729485;5860.736266868002;5861.648301101863;5319.148936170272;5450.182472629137;5471.753771080311;5595.132754423071;5596.972015139898;5592.664440133605;5645.1532270159805;5648.63283886546;5652.265205523256;5659.773609055674;5598.412166722435;5599.300087489064;5605.243292155588;5606.21512988182;5613.887722245532;5473.698946557898;5526.778928842801;5576.33084029919;5584.525315348241;5606.1030235163;4326.567343265649;4326.6538676905775;4327.675424343187;4331.371951067078;4360.215161271001;3862.536495620487;3881.825317860703;3902.453656488094;3913;3918.0792513759243;5220.738963051832;5272.736363181825;5328.094223981932;5399.433059528771;5403.270558474555;5655.491005809415;5673.546116310686;5675.318961724537;5676.631018983753;5716.942830571724;5382.515573598395;5400.540954018874;5406.135018397038;5411.242426060355;5415.241866138744;4678.274867395559;4733.786979585927;4778.880527986828;4786.7845946932475;4881.096997055556;5881.7647294107755;5890.087036509348;5895.322037965689;5903.498202652737;5904.202932604129;5687.289088863892;5702.8289151325525;5703.486686198262;5705.800296989585;5710.172025056427;5590.832275031756;5741.540676745767;5764.337101233412;5786.768529258782;5830.2129212555765;5504.559635229252;5541.528970037431;5542.224088627676;5543.1408131739645;5545.694986775766;5437.4562543745305;5645.491905728504;5650.378458369658;5654.547636189012;5658.5473162147755;5466.863328416822;5548.944510555004;5554.305711786027;5575.1915972183;5579.246801681721;5525.613207075467;5536.501714845684;5537.861553461034;5539.41836107219;5544.334679838284;5339.279197308314;5430.104032834538;5466.945330546644;5549.250851135045;5594.9720251398485;5512.5589952802875;5559.277293951922;5562.332520097614;5605.271314729059;5612.579056570855;5434.755436005468;5439.292891924025;5441.782328706808;5442.183672449164;5449.945500545103 04:42:34 INFO - PROCESS | 16728 | |1;ext.html;586.384296488687;613.129356314034;631.510579301042;632.4244937107231;645.183842439314;32943.341133177324;35305.47041794372;35449.82275088624;43890.341644875356;45251.32123018149;45320.69453401922;45560.54439455605;45701.542984570144;45763.31355029677;45768;8885.200331970138;9027.052159523255;9032.819343613124;9034.051424600388;9039.553671412576;9034.638614455414;9037.502937338444;9106.089391060874;9122.22461090808;9122.726318210463;9108.134727200906;9168.954155229248;9175.44947303164;9180.632774689004;9187.03536128707;9080.182783549446;9097.090290970884;9133.634654613808;9155.313351498631;9162.725118246462;8992.370534062618;9046.823912891348;9064.229540489066;9065.59204835784;9073.54632268384;43494.34758478625;43694.12611747779;43726.344104838456;43729.56270437287;43847;3479.704225140866;3558.811072078148;3575.94636080459;3601;3998.0999129126913;33180;33331.500027499605;33660.158496037795;33719.494207586904;33745.66254337474;4386.863392674221;4501.887452813706;4527.366168736379;4598.563136502061;4694.906101877978;339003;339483;339624;339957;340006;58304.12543811846;58860;58959.70520147372;59032;59160.11259831106;62164.37835621586;62512;62513.68743156346;62574;62649;16473.34106635721;16537.66924661524;16620.83379166217;16691.66616667684;16693.33226670944;12255.57105501321;12257.203281786833;12259.203151795105;12269.141160118885;12269.263844169378;16463.588410289838;17522.561935951704;17525.824741752673;17529.561760955825;17562.473125806246;6306.653134077578;6346.661355375138;6374;6518.706658200393;6562.573432726857;994.5673631970116;1033.565902321027;1045.843123531461;1047.6542740895638;1087.8096333141668;33214.16964575905;33218.66781332204;33276.83361583177;33478;33772.66227337744;956.799072194833;1087.8150714378576;1099.648112603975;1105.7567335186245;1175.7295821960997;17097.572560686083;17110.14449277531;17282.913585431994;17294;17366.47900562985;509329;511224;514920;517632;518873;58636.706816466496;58743.706281469174;58876.41123588795;58951;59048.39040291165;1259.0997436832708;1374.8487666356693;1395.051365071761;1410.9223992680502;1417.865302796212;31038.22404439907;34742.65257347394;34787.478187826695;34982.65017349794;35167.824160879034;53549;54633;54801.17798233109;54809.72595136999;54827.72586137044;494120;505894;507232;507976;745967;44563.77718111518;44826.77586612046;45834.77082614566;49257.75371123121;50074.749626251636;49959.50040499549;50264;51071.74464127656;51174;51666.741666291426;40397.798011009756;42797.572024280606;43252.78373608112;43264.1593384889;43846.34230486481;42355.576444236394;42760.358594620484;42815.78592107019;42830.571694283906;43553.78223108864;42937.78531107325;43591.782041089595;43801;44250.55749442593;44265.77867110644;35022.82488587541;37672.43491347687;37780.43329350007;38333;38570.6142938567;28704.569431458964;28772.856135720023;28789.424211515234;28980.27549311284;29243.70756292495 04:42:34 INFO - PROCESS | 16728 | |2;jquery.html;397.57062372637574;399.77612536979274;401.7609522334211;404.89270343359016;411.96984815403914;18743;19401.611967760637;20208.59582808343;20271.08780104897;20279;18886.62226755464;18990.145443455043;19291.517712057204;19810.30663926763;19816.10827512762;5076.79692812288;5239.240310155025;5887.4406931341455;5887.528997680175;5889;5796.275465566804;5814.302283725959;5842.47417732404;5847.356790753014;5871.119332100197;5355.062863998784;5365.973170134144;5371.3822910365225;5371.892562148755;5416.91874621881;5265.736713164327;5312.840614781543;5355.464453554652;5361.490658387427;5363.249145119687;5217;5242.6330156889035;5253.185756207794;5272.499112584298;5280;14502.927485362507;14761.483348082766;14826.406943722239;19239.422817315502;23401.88299058511;2296.7588403217756;2344.4607740219676;2369.7630236976165;2370.6799582056374;2827.123591686584;9526.85709714355;9832;10308.896911030868;10720.463976801208;10790.51442685081;1864.151810926039;1965.84273258139;2006.8795872247713;2011.1653663729535;2020.1515363547346;78838.21161788366;80846;81576;82245.17754822495;82912.58543707304;10788.190885683605;11059.22585419029;11368.94315528417;11377.54489820398;11420.714482137846;15702.842971570366;15746.68506629861;15798.052116873025;15863.682726345409;15865;7770.611469426506;8119.512829230265;8183.304419124441;8290.253877151084;8352.331813454908;7892.171322011106;7905.407094467938;7954.522728636301;8059.838803223903;8084.1107478177355;4925.088858561106;4940.431850337185;4981.601471882241;5011.955810923489;5019.924701129486;1934.3713293179492;1952.7754308254448;1963.4894927318715;1998.9000549972734;2025.7974202579624;925.7361651929168;988.6687959533493;991.2565575818137;1065.6110519660267;1069.005824583145;19824.548249231575;20688.172473101207;20701.275455359293;20786.37640870776;21058;973.3381300715581;978.0561757903657;998.5756053677159;1005.2309982863115;1039.449091981251;10852.294600850919;11472.483738231633;11535.76928461426;11541.134414918915;11564.710882228012;354545;357065;359186.22441326804;471943;484449;76026;85962.57018714867;88479;89670;109311.45344273228;1007.7178390050798;1029.3720830293514;1046.2885238038054;1054.8048611006989;1067.4022547373495;18580.628387432447;18775.248990040247;18887.15007824679;18961.837402843856;19160.34566966041;40401.39397908975;42343.36484952667;44424.555754442044;45113.548864510936;45759.77120114378;54010.45989540211;59382.406175937685;61303.386966131555;61321.38678613335;61644.07533887085;8757.47455152693;9147.58835852375;9180.44917304964;9229.123233292827;9526.380785248937;11116.888831111908;14245.64385890361;14599.416023358946;14744.55766327012;14957.476488322856;12694.492220311084;12706.555270565856;12912.096153269182;12967.675808104872;13001.479940802263;12168.634940951786;12243.20419172751;12565.685857853627;12623.810642840548;12785.105042646925;11862.457880475484;12816.359182040675;13101.73796524045;13135.474581016651;13321.267330296927;9012.63949442015;9135;9449.952750236205;9553.522323883639;9584.04159584064;12623.93688031554;13026.2835544046;13041.869581304445;13043.152195107288;13193.80209296842 04:42:34 INFO - PROCESS | 16728 | |3;mootools.html;1461.8099647045883;1484.7475929092054;1614.7820044294024;1767.8674099442544;1795;8277.420580559363;8767.816344793451;8893;8902.33232507562;8903.910960890396;7546;8288.751337459871;8480.279176270025;8499.830003399928;8736.170063843925;2266.795988361047;2308.6421604651305;2314.2016004478514;2315.3632750993443;2316.3861576682193;2263.321003698892;2282.4408020035116;2283.680284760135;2285.0745448093467;2294.4149241943364;1937.273522429089;2172.3374370816973;2233.6984507091497;2237.5748607764554;2252.842301038928;2233.7877901599486;2260.3557985974003;2268;2281.2129815213725;2282.7374851891996;2236.2620335289316;2241.674957131207;2242.192810588187;2245.6631505274177;2245.8989345479495;8698.304135669132;8729;8753.212210900985;8755.649774009033;8763.78090547735;5047.369078865142;5061.089003979282;5140.665856719302;5185.662931909414;5190.740462976836;3223.3553289342226;3333.4666453367586;3396.626371099177;3411.812350320731;3414.402479566066;1085.2821037776218;1105.618561596248;1119.3284029582267;1134.4384529657873;1137.039201874423;12068.698282542919;12075.335856527887;12092.33492157931;12092.758144837142;12097.274163550303;4306.397104405386;4414.249577571821;4536.682432229778;4615.607673347736;4618.861434156981;10218.489075546193;10224.693259202237;10227.232957528215;10228.59085636581;10231.181505479544;5224.346956630421;5224.50367215114;5226.398964119175;5227;5232.712200828991;4643.698159619614;4758.857234282977;4791.520847915181;4793.161196790547;4798.1123492154065;3788.905277368088;3865.9226815463535;3918.941215881764;3922.9607703922597;3942.1130245695063;1135.3017893995134;1237.3936770982154;1250.6748245456247;1253.9686507837196;1273.9044571657162;889.4174315823146;926.5598840550684;933.869258303838;959.5490119643756;987.0376383026492;6076.240469941257;6088.1476593276975;6170.136180934583;6214.223222097238;6231.875362492816;980.2403137568299;980.2892902645525;980.9509524523888;984.7636567223815;1011.438651548383;4160.126373461607;4217.915641687149;4258.488981322261;4297.183535128315;4327.394164816928;10488.842667359995;10665.040146386862;10692.518836652369;10731.9072780807;10740.248182627141;10195.388276703421;10544.367337959748;10644.201684873666;10668.786624267626;10710.892891071146;7944.086430060617;8041.437099403102;8057.83884322322;8090.0696419912465;8140.389470789714;5990.7903223386975;6274.6548939808745;6290.748370065146;6326.905096423649;6338.619682818861;9438;9632.855507167258;9635.662751803653;9852.605895764089;9857.802843942938;9547.42715437076;9986.201103911815;10109.545070471993;10110.241731869992;10118.696439106838;7518.097828260644;7698.846023079395;7762.456628035983;7768.53388796674;7768.84462310762;8093.433459658003;8116;8136.593170341577;8137.552434615916;8139.226773456512;7242.203357630551;7499.400047996256;7555.357794587521;7566.621668916642;7639.770806875803;7554.131274903457;7583.165851756192;7627.427942904415;7745.341645959931;7761;6862.970554416877;6895.6207408591;6936.34104760047;6937.687804048931;6941.167059952838;5021.347224860745;5107.438181799925;5183.688978661293;5231.110711179184;5259.973700131475;4954.108260513142;4986.80052797884;5051.368578927634;5065.442801291929;5087.058894104603 04:42:34 INFO - PROCESS | 16728 | |4;prototype.html;321.8262138445238;322.19451371571074;329.3446042375673;329.38733954843985;331.9983400083002;5254.57963362931;5263.947360526394;5295.173165257989;5302.693328402148;5325.934813037388;5190.8702282442955;5210.6613070150415;5253;5257.605679574028;5257.921131183035;3952.3281042222893;3988.820503077354;4122;4135.338345864662;4151.149014452045;4060.3706425503947;4084.836606535735;4095.5699651536606;4102.958970410303;4105.096878686699;3941.5664276929515;4088.897777555555;4100.610442008005;4102.610252026053;4119.217348703752;3995.380715989026;4098.979505102485;4101.671866250693;4116.5060192776755;4118.855840045599;3624.7100231981376;3640.508531348287;3647.1399586211223;3655.342038433081;3662.597114317423;5190.4031036430915;5193.1171700810955;5203.323567936182;5209.244659524347;5213.661112027744;4392.912141757147;4647.697899636512;4679.415073115861;4698.449511661143;4702.294655801623;5460.972695136538;5482.150266708666;5482.656749096497;5493;5499.367572729107;3911.100446897201;3925.4308125321954;3932;3933.6066393360434;3941.192055628589;5586.35756887959;5667.376588575254;5671.6388066864065;5694.629849059839;5712.542996560265;3995.840166393312;4004.819783109767;4014.759114453142;4023.939640905389;4039.7778122203563;4027.3153563894207;4049.91900162001;4058.2695114879607;4084.0810817566403;4100.856470023535;4524.705894116872;4639.907201855944;4654.25531914892;4658.813647454132;4682.555157260055;5491.791805802717;5504;5504.669719816824;5538.667679939216;5563.7774489019985;1392.1994852959588;1402.4390243902317;1404.3048690898072;1405.192014591614;1411.905773025913;854.256796586961;886.2732559301439;892.3396686451979;902.1294450854956;952.5046975572664;5249.737513124329;5294.46460526443;5301.231321458367;5317.032697901724;5325.3609566851455;5487.5884308677005;5525.336959564878;5528.226048353154;5551.444855514497;5567.884204002453;5127.461616530285;5242.397124330674;5246.396664383568;5271.6309858310315;5310.946890531122;2918.387138700854;2919.474494590994;2941.9411611767646;2947.572601972702;2947.955780663292;5749.88500229993;5753.338366087954;5767.509761670221;5772.709555553294;5791.046566251242;5454.4545545445135;5651.943480565142;5677.687727175045;5696.3449203341315;5701.458361455655;5673.716314184274;5727.39862314451;5756.265773757432;5795.304563452329;5804.47759701612;5247.58019358458;5520.282363292747;5608.831735047955;5614;5614.382417934105;5474.452554744494;5480.561555075664;5494.587905907153;5495.560355171657;5499.340079190522;5659.6321239119325;5706.600537962303;5744.4829965303325;5748.39641837601;5783.652980821164;3893.8247778849454;3967.107400834789;3994.141259629194;4004.979975100106;4014.177093695727;5327.547158491571;5537.529310008695;5542.224088627515;5575.1915972184615;5591.748371323219;5292.682439053669;5389.8922021558565;5451.754671039734;5475.890482190254;5510.724463776715;5462.8361149165585;5475.753591088331;5510.972445137749;5518.392976772471;5528.502434780889;5277.973610131925;5453;5495.807646732345;5495.835124946098;5498.395176530498;5504.724763761876;5507.256520369699;5530.446955304598;5538.307711536058;5557.666540007613;5186.714730689849;5428.185772134211;5434.619576629598;5441.238226648352;5457.754401051883 04:42:34 INFO - PROCESS | 16728 | |5;yui.html;733.5452019747761;736.9484136110474;764.7782143178479;830.6303694855787;854.987175192372;14052.578422647324;14500.709985800278;14849.925750371247;14860.108393496397;14873.553793386189;14660.56018319452;14665.926670366633;14684.265786710648;14703.33834977426;14768.113913165218;664.9800505984829;796.8326651403198;798.7883210949103;807.2250639386197;810.9107998120202;805.1827395193883;806.5120602035772;807.2976510435929;807.4549678966704;808.8058865872177;870.2037635563452;872.2803686958254;872.6073267029861;872.9781755456132;872.9912700873006;690.17868736204;844.1727107434748;862.4782006885838;864.0322838420977;867.757028032152;628.3371043549099;628.3433811666819;628.9842753931142;629.222909706512;630.1398590923357;15081.773773393408;15103.32035058425;15117.697646047018;15121.773173402407;15126;13967.161970281815;14376.784348234785;14580.781288280577;14612.342444590018;14727.852721472755;12949.611511654666;13090.934545327307;13116;13177.736445271137;13744.381502832297;4121.690873184523;4232.534421213664;4234.513031001444;4238.639715624176;4344.109457561224;80227;80228;81171.59414202892;81334.9999999994;81458.59270703609;10739.83890241647;11413.48639311233;11589;11671.941640291914;11783.823242651368;21016.474588135112;21253.46866328323;21288.78711212899;21289.36131916045;21361.14555417766;7907.960460197777;7936;8020.318272946748;8071.838563228703;8272.586370681442;4531.093781243764;4564.863054108316;4613.169629466728;4662.090892275974;4818.927716084261;3500.7724497907557;3603.6036036036016;3614.0603443104983;3619.3304238715923;3619.5656521217097;471.16142708092076;646.2342124582385;652.6425035925264;653.7711800869657;654.1038776875711;650.7982525417136;658.5719282466339;725.1733024352137;740.5630677900065;758.1054355860138;9617.71146865595;9692.563834627459;9789.755256118511;10125.949370253102;10128.696139115838;677.8271540757075;714.4712912444753;734.0860628517423;737.1706829816457;741.9768169492505;4324.3513472978675;4519.81920723174;4570.291604801261;4674;4705.270683044134;124505.37747311205;131001;132975;133449.29622520893;138601.3069934664;108653.45673271583;111473.44263278632;112156;114611.42694286475;115813;98502;101141;101243;104340.47829760803;104871;8883.911160888309;8991.55042247898;8997.190252877272;9081.273498120003;9195.862062069207;56486.717566411906;56796.716016419654;57106.14340784975;58177.4182258172;59259.703701481216;75657.62171189109;77136.02391629298;78848;83483;85576;11054.613088542184;11462.312261264351;11481.138914581607;11551.075913927034;11894.881051189723;11786.646400607995;11867.109966752356;11880.405979700807;11980.161388702707;12235.877641223475;11241.71895702614;11270.380129092979;11290.830637540279;11369.772604547697;11543;11477.48351324209;12184.147109702235;12398.442070107047;12703.491860325854;12781.552645657357;11995.820062698893;12064.095192860395;12194.451249693608;12336.938315308365;12383.62849114528;9483.715488535356;10049.447280399649;10057.497125143567;10358.223133265186;10364.274500784873;8891;8941.195292423454;9196.632134714537;9403.576839042396;10039.69880903574 04:42:34 INFO - PROCESS | 16728 | __end_tp_report 04:42:34 INFO - PROCESS | 16728 | __start_cc_report 04:42:34 INFO - PROCESS | 16728 | _x_x_mozilla_cycle_collect,844 04:42:34 INFO - PROCESS | 16728 | __end_cc_report 04:42:34 INFO - PROCESS | 16728 | __startTimestamp1468064554357__endTimestamp 04:42:34 INFO - PROCESS | 16728 | 04:42:34 INFO - PROCESS | 16728 | ------- Summary: start ------- 04:42:34 INFO - PROCESS | 16728 | Number of tests: 6 04:42:34 INFO - PROCESS | 16728 | 04:42:34 INFO - PROCESS | 16728 | [#0] dojo.html Cycles:165 Average:5253.64 Median:5442.18 stddev:588.76 (10.8%) stddev-sans-first:564.23 04:42:34 INFO - PROCESS | 16728 | Values: 3033.9 3082.0 3099.2 3105.1 3129.0 5081.2 5127.6 5296.1 5388.8 5427.9 5221.7 5242.0 5287.4 5298.4 5299.1 4756.3 4834.6 4834.7 4838.8 4971.6 4897.5 4904.4 4922.4 4961.7 4980.5 4702.1 4708.0 4771.2 4781.6 4790.7 4760.2 4780.4 4849.0 4857.9 4904.9 4669.3 4818.1 4823.5 4834.9 4892.5 5206.1 5257.6 5275.6 5339.7 5356.8 5624.8 5647.7 5654.6 5676.6 5677.3 5485.7 5545.5 5778.9 5813.6 5819.1 5266.5 5345.6 5360.5 5365.7 5366.2 5841.5 5856.9 5858.8 5860.7 5861.6 5319.1 5450.2 5471.8 5595.1 5597.0 5592.7 5645.2 5648.6 5652.3 5659.8 5598.4 5599.3 5605.2 5606.2 5613.9 5473.7 5526.8 5576.3 5584.5 5606.1 4326.6 4326.7 4327.7 4331.4 4360.2 3862.5 3881.8 3902.5 3913.0 3918.1 5220.7 5272.7 5328.1 5399.4 5403.3 5655.5 5673.5 5675.3 5676.6 5716.9 5382.5 5400.5 5406.1 5411.2 5415.2 4678.3 4733.8 4778.9 4786.8 4881.1 5881.8 5890.1 5895.3 5903.5 5904.2 5687.3 5702.8 5703.5 5705.8 5710.2 5590.8 5741.5 5764.3 5786.8 5830.2 5504.6 5541.5 5542.2 5543.1 5545.7 5437.5 5645.5 5650.4 5654.5 5658.5 5466.9 5548.9 5554.3 5575.2 5579.2 5525.6 5536.5 5537.9 5539.4 5544.3 5339.3 5430.1 5466.9 5549.3 5595.0 5512.6 5559.3 5562.3 5605.3 5612.6 5434.8 5439.3 5441.8 5442.2 5449.9 04:42:34 INFO - PROCESS | 16728 | 04:42:34 INFO - PROCESS | 16728 | [#1] ext.html Cycles:180 Average:63637.46 Median:44070.45 stddev:127872.73 (290.2%) stddev-sans-first:128143.82 04:42:34 INFO - PROCESS | 16728 | Values: 586.4 613.1 631.5 632.4 645.2 32943.3 35305.5 35449.8 43890.3 45251.3 45320.7 45560.5 45701.5 45763.3 45768.0 8885.2 9027.1 9032.8 9034.1 9039.6 9034.6 9037.5 9106.1 9122.2 9122.7 9108.1 9169.0 9175.4 9180.6 9187.0 9080.2 9097.1 9133.6 9155.3 9162.7 8992.4 9046.8 9064.2 9065.6 9073.5 43494.3 43694.1 43726.3 43729.6 43847.0 3479.7 3558.8 3575.9 3601.0 3998.1 33180.0 33331.5 33660.2 33719.5 33745.7 4386.9 4501.9 4527.4 4598.6 4694.9 339003.0 339483.0 339624.0 339957.0 340006.0 58304.1 58860.0 58959.7 59032.0 59160.1 62164.4 62512.0 62513.7 62574.0 62649.0 16473.3 16537.7 16620.8 16691.7 16693.3 12255.6 12257.2 12259.2 12269.1 12269.3 16463.6 17522.6 17525.8 17529.6 17562.5 6306.7 6346.7 6374.0 6518.7 6562.6 994.6 1033.6 1045.8 1047.7 1087.8 33214.2 33218.7 33276.8 33478.0 33772.7 956.8 1087.8 1099.6 1105.8 1175.7 17097.6 17110.1 17282.9 17294.0 17366.5 509329.0 511224.0 514920.0 517632.0 518873.0 58636.7 58743.7 58876.4 58951.0 59048.4 1259.1 1374.8 1395.1 1410.9 1417.9 31038.2 34742.7 34787.5 34982.7 35167.8 53549.0 54633.0 54801.2 54809.7 54827.7 494120.0 505894.0 507232.0 507976.0 745967.0 44563.8 44826.8 45834.8 49257.8 50074.7 49959.5 50264.0 51071.7 51174.0 51666.7 40397.8 42797.6 43252.8 43264.2 43846.3 42355.6 42760.4 42815.8 42830.6 43553.8 42937.8 43591.8 43801.0 44250.6 44265.8 35022.8 37672.4 37780.4 38333.0 38570.6 28704.6 28772.9 28789.4 28980.3 29243.7 04:42:34 INFO - PROCESS | 16728 | 04:42:34 INFO - PROCESS | 16728 | [#2] jquery.html Cycles:180 Average:26841.56 Median:2370.22 stddev:68108.98 (2873.5%) stddev-sans-first:68271.10 04:42:34 INFO - PROCESS | 16728 | Values: 397.6 399.8 401.8 404.9 412.0 18743.0 19401.6 20208.6 20271.1 20279.0 18886.6 18990.1 19291.5 19810.3 19816.1 5076.8 5239.2 5887.4 5887.5 5889.0 5796.3 5814.3 5842.5 5847.4 5871.1 5355.1 5366.0 5371.4 5371.9 5416.9 5265.7 5312.8 5355.5 5361.5 5363.2 5217.0 5242.6 5253.2 5272.5 5280.0 14502.9 14761.5 14826.4 19239.4 23401.9 2296.8 2344.5 2369.8 2370.7 2827.1 9526.9 9832.0 10308.9 10720.5 10790.5 1864.2 1965.8 2006.9 2011.2 2020.2 78838.2 80846.0 81576.0 82245.2 82912.6 10788.2 11059.2 11368.9 11377.5 11420.7 15702.8 15746.7 15798.1 15863.7 15865.0 7770.6 8119.5 8183.3 8290.3 8352.3 7892.2 7905.4 7954.5 8059.8 8084.1 4925.1 4940.4 4981.6 5012.0 5019.9 1934.4 1952.8 1963.5 1998.9 2025.8 925.7 988.7 991.3 1065.6 1069.0 19824.5 20688.2 20701.3 20786.4 21058.0 973.3 978.1 998.6 1005.2 1039.4 10852.3 11472.5 11535.8 11541.1 11564.7 354545.0 357065.0 359186.2 471943.0 484449.0 76026.0 85962.6 88479.0 89670.0 109311.5 1007.7 1029.4 1046.3 1054.8 1067.4 18580.6 18775.2 18887.2 18961.8 19160.3 40401.4 42343.4 44424.6 45113.5 45759.8 54010.5 59382.4 61303.4 61321.4 61644.1 8757.5 9147.6 9180.4 9229.1 9526.4 11116.9 14245.6 14599.4 14744.6 14957.5 12694.5 12706.6 12912.1 12967.7 13001.5 12168.6 12243.2 12565.7 12623.8 12785.1 11862.5 12816.4 13101.7 13135.5 13321.3 9012.6 9135.0 9450.0 9553.5 9584.0 12623.9 13026.3 13041.9 13043.2 13193.8 04:42:34 INFO - PROCESS | 16728 | 04:42:34 INFO - PROCESS | 16728 | [#3] mootools.html Cycles:180 Average:5716.37 Median:5004.07 stddev:3216.18 (64.3%) stddev-sans-first:3209.31 04:42:34 INFO - PROCESS | 16728 | Values: 1461.8 1484.7 1614.8 1767.9 1795.0 8277.4 8767.8 8893.0 8902.3 8903.9 7546.0 8288.8 8480.3 8499.8 8736.2 2266.8 2308.6 2314.2 2315.4 2316.4 2263.3 2282.4 2283.7 2285.1 2294.4 1937.3 2172.3 2233.7 2237.6 2252.8 2233.8 2260.4 2268.0 2281.2 2282.7 2236.3 2241.7 2242.2 2245.7 2245.9 8698.3 8729.0 8753.2 8755.6 8763.8 5047.4 5061.1 5140.7 5185.7 5190.7 3223.4 3333.5 3396.6 3411.8 3414.4 1085.3 1105.6 1119.3 1134.4 1137.0 12068.7 12075.3 12092.3 12092.8 12097.3 4306.4 4414.2 4536.7 4615.6 4618.9 10218.5 10224.7 10227.2 10228.6 10231.2 5224.3 5224.5 5226.4 5227.0 5232.7 4643.7 4758.9 4791.5 4793.2 4798.1 3788.9 3865.9 3918.9 3923.0 3942.1 1135.3 1237.4 1250.7 1254.0 1273.9 889.4 926.6 933.9 959.5 987.0 6076.2 6088.1 6170.1 6214.2 6231.9 980.2 980.3 981.0 984.8 1011.4 4160.1 4217.9 4258.5 4297.2 4327.4 10488.8 10665.0 10692.5 10731.9 10740.2 10195.4 10544.4 10644.2 10668.8 10710.9 7944.1 8041.4 8057.8 8090.1 8140.4 5990.8 6274.7 6290.7 6326.9 6338.6 9438.0 9632.9 9635.7 9852.6 9857.8 9547.4 9986.2 10109.5 10110.2 10118.7 7518.1 7698.8 7762.5 7768.5 7768.8 8093.4 8116.0 8136.6 8137.6 8139.2 7242.2 7499.4 7555.4 7566.6 7639.8 7554.1 7583.2 7627.4 7745.3 7761.0 6863.0 6895.6 6936.3 6937.7 6941.2 5021.3 5107.4 5183.7 5231.1 5260.0 4954.1 4986.8 5051.4 5065.4 5087.1 04:42:34 INFO - PROCESS | 16728 | 04:42:34 INFO - PROCESS | 16728 | [#4] prototype.html Cycles:180 Average:4608.96 Median:5293.57 stddev:1352.61 (25.6%) stddev-sans-first:1317.57 04:42:34 INFO - PROCESS | 16728 | Values: 321.8 322.2 329.3 329.4 332.0 5254.6 5263.9 5295.2 5302.7 5325.9 5190.9 5210.7 5253.0 5257.6 5257.9 3952.3 3988.8 4122.0 4135.3 4151.1 4060.4 4084.8 4095.6 4103.0 4105.1 3941.6 4088.9 4100.6 4102.6 4119.2 3995.4 4099.0 4101.7 4116.5 4118.9 3624.7 3640.5 3647.1 3655.3 3662.6 5190.4 5193.1 5203.3 5209.2 5213.7 4392.9 4647.7 4679.4 4698.4 4702.3 5461.0 5482.2 5482.7 5493.0 5499.4 3911.1 3925.4 3932.0 3933.6 3941.2 5586.4 5667.4 5671.6 5694.6 5712.5 3995.8 4004.8 4014.8 4023.9 4039.8 4027.3 4049.9 4058.3 4084.1 4100.9 4524.7 4639.9 4654.3 4658.8 4682.6 5491.8 5504.0 5504.7 5538.7 5563.8 1392.2 1402.4 1404.3 1405.2 1411.9 854.3 886.3 892.3 902.1 952.5 5249.7 5294.5 5301.2 5317.0 5325.4 5487.6 5525.3 5528.2 5551.4 5567.9 5127.5 5242.4 5246.4 5271.6 5310.9 2918.4 2919.5 2941.9 2947.6 2948.0 5749.9 5753.3 5767.5 5772.7 5791.0 5454.5 5651.9 5677.7 5696.3 5701.5 5673.7 5727.4 5756.3 5795.3 5804.5 5247.6 5520.3 5608.8 5614.0 5614.4 5474.5 5480.6 5494.6 5495.6 5499.3 5659.6 5706.6 5744.5 5748.4 5783.7 3893.8 3967.1 3994.1 4005.0 4014.2 5327.5 5537.5 5542.2 5575.2 5591.7 5292.7 5389.9 5451.8 5475.9 5510.7 5462.8 5475.8 5511.0 5518.4 5528.5 5278.0 5453.0 5495.8 5495.8 5498.4 5504.7 5507.3 5530.4 5538.3 5557.7 5186.7 5428.2 5434.6 5441.2 5457.8 04:42:34 INFO - PROCESS | 16728 | 04:42:34 INFO - PROCESS | 16728 | [#5] yui.html Cycles:180 Average:22205.18 Median:4334.23 stddev:34227.28 (789.7%) stddev-sans-first:34285.33 04:42:34 INFO - PROCESS | 16728 | Values: 733.5 736.9 764.8 830.6 855.0 14052.6 14500.7 14849.9 14860.1 14873.6 14660.6 14665.9 14684.3 14703.3 14768.1 665.0 796.8 798.8 807.2 810.9 805.2 806.5 807.3 807.5 808.8 870.2 872.3 872.6 873.0 873.0 690.2 844.2 862.5 864.0 867.8 628.3 628.3 629.0 629.2 630.1 15081.8 15103.3 15117.7 15121.8 15126.0 13967.2 14376.8 14580.8 14612.3 14727.9 12949.6 13090.9 13116.0 13177.7 13744.4 4121.7 4232.5 4234.5 4238.6 4344.1 80227.0 80228.0 81171.6 81335.0 81458.6 10739.8 11413.5 11589.0 11671.9 11783.8 21016.5 21253.5 21288.8 21289.4 21361.1 7908.0 7936.0 8020.3 8071.8 8272.6 4531.1 4564.9 4613.2 4662.1 4818.9 3500.8 3603.6 3614.1 3619.3 3619.6 471.2 646.2 652.6 653.8 654.1 650.8 658.6 725.2 740.6 758.1 9617.7 9692.6 9789.8 10125.9 10128.7 677.8 714.5 734.1 737.2 742.0 4324.4 4519.8 4570.3 4674.0 4705.3 124505.4 131001.0 132975.0 133449.3 138601.3 108653.5 111473.4 112156.0 114611.4 115813.0 98502.0 101141.0 101243.0 104340.5 104871.0 8883.9 8991.6 8997.2 9081.3 9195.9 56486.7 56796.7 57106.1 58177.4 59259.7 75657.6 77136.0 78848.0 83483.0 85576.0 11054.6 11462.3 11481.1 11551.1 11894.9 11786.6 11867.1 11880.4 11980.2 12235.9 11241.7 11270.4 11290.8 11369.8 11543.0 11477.5 12184.1 12398.4 12703.5 12781.6 11995.8 12064.1 12194.5 12336.9 12383.6 9483.7 10049.4 10057.5 10358.2 10364.3 8891.0 8941.2 9196.6 9403.6 10039.7 04:42:34 INFO - PROCESS | 16728 | -------- Summary: end -------- 04:42:34 INFO - PROCESS | 16728 | 04:42:35 INFO - TEST-INFO | 16728: exit 0 04:42:35 INFO - TEST-OK | dromaeo_css | took 1112684ms 04:42:35 INFO - TEST-START | kraken 04:42:35 INFO - operating with platform_type : linux_ 04:42:35 INFO - Initialising browser for kraken test... 04:42:35 INFO - TEST-INFO | started process 16917 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_RSK5v/profile http://localhost:53321/getInfo.html) 04:42:38 INFO - PROCESS | 16917 | __metrics Screen width/height:1600/1200 04:42:38 INFO - PROCESS | 16917 | colorDepth:24 04:42:38 INFO - PROCESS | 16917 | Browser inner width/height: 1024/697 04:42:38 INFO - PROCESS | 16917 | __metrics 04:42:39 INFO - PROCESS | 16917 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:42:40 INFO - TEST-INFO | 16917: exit 0 04:42:40 INFO - Browser initialized. 04:42:40 INFO - Running cycle 1/1 for kraken test... 04:42:40 INFO - TEST-INFO | started process 17001 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_RSK5v/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:42:52 INFO - PROCESS | 17001 | RSS: Main: 157679616 04:42:52 INFO - PROCESS | 17001 | 04:42:55 INFO - PROCESS | 17001 | Cycle 1(1): loaded http://localhost:53321/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53321/tests/kraken/driver.html?testName=audio-beat-detection) 04:42:55 INFO - PROCESS | 17001 | RSS: Main: 215564288 04:42:55 INFO - PROCESS | 17001 | 04:42:58 INFO - PROCESS | 17001 | Cycle 1(1): loaded http://localhost:53321/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53321/tests/kraken/driver.html?testName=audio-dft) 04:42:59 INFO - PROCESS | 17001 | RSS: Main: 203251712 04:42:59 INFO - PROCESS | 17001 | 04:43:02 INFO - PROCESS | 17001 | Cycle 1(1): loaded http://localhost:53321/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53321/tests/kraken/driver.html?testName=audio-fft) 04:43:02 INFO - PROCESS | 17001 | RSS: Main: 269926400 04:43:02 INFO - PROCESS | 17001 | 04:43:05 INFO - PROCESS | 17001 | Cycle 1(1): loaded http://localhost:53321/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53321/tests/kraken/driver.html?testName=audio-oscillator) 04:43:05 INFO - PROCESS | 17001 | RSS: Main: 180658176 04:43:05 INFO - PROCESS | 17001 | 04:43:07 INFO - PROCESS | 17001 | Cycle 1(1): loaded http://localhost:53321/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53321/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:43:08 INFO - PROCESS | 17001 | RSS: Main: 184598528 04:43:08 INFO - PROCESS | 17001 | 04:43:11 INFO - PROCESS | 17001 | Cycle 1(1): loaded http://localhost:53321/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53321/tests/kraken/driver.html?testName=imaging-darkroom) 04:43:12 INFO - PROCESS | 17001 | RSS: Main: 219144192 04:43:12 INFO - PROCESS | 17001 | 04:43:15 INFO - PROCESS | 17001 | Cycle 1(1): loaded http://localhost:53321/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53321/tests/kraken/driver.html?testName=imaging-desaturate) 04:43:16 INFO - PROCESS | 17001 | RSS: Main: 220680192 04:43:16 INFO - PROCESS | 17001 | 04:43:18 INFO - PROCESS | 17001 | Cycle 1(1): loaded http://localhost:53321/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53321/tests/kraken/driver.html?testName=json-parse-financial) 04:43:19 INFO - PROCESS | 17001 | RSS: Main: 221319168 04:43:19 INFO - PROCESS | 17001 | 04:43:20 INFO - PROCESS | 17001 | Cycle 1(1): loaded http://localhost:53321/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53321/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:43:21 INFO - PROCESS | 17001 | RSS: Main: 208216064 04:43:21 INFO - PROCESS | 17001 | 04:43:23 INFO - PROCESS | 17001 | Cycle 1(1): loaded http://localhost:53321/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53321/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:43:23 INFO - PROCESS | 17001 | RSS: Main: 212881408 04:43:23 INFO - PROCESS | 17001 | 04:43:25 INFO - PROCESS | 17001 | Cycle 1(1): loaded http://localhost:53321/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53321/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:43:26 INFO - PROCESS | 17001 | RSS: Main: 212525056 04:43:26 INFO - PROCESS | 17001 | 04:43:29 INFO - PROCESS | 17001 | Cycle 1(1): loaded http://localhost:53321/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53321/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:43:29 INFO - PROCESS | 17001 | RSS: Main: 225206272 04:43:29 INFO - PROCESS | 17001 | 04:43:32 INFO - PROCESS | 17001 | Cycle 1(1): loaded http://localhost:53321/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53321/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:43:33 INFO - PROCESS | 17001 | RSS: Main: 224407552 04:43:33 INFO - PROCESS | 17001 | 04:43:34 INFO - PROCESS | 17001 | Cycle 1(1): loaded http://localhost:53321/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53321/tests/kraken/driver.html?testName=ai-astar) 04:43:35 INFO - PROCESS | 17001 | RSS: Main: 266780672 04:43:35 INFO - PROCESS | 17001 | 04:43:35 INFO - PROCESS | 17001 | __start_tp_report 04:43:35 INFO - PROCESS | 17001 | _x_x_mozilla_page_load 04:43:35 INFO - PROCESS | 17001 | _x_x_mozilla_page_load_details 04:43:35 INFO - PROCESS | 17001 | |i|pagename|runs| 04:43:35 INFO - PROCESS | 17001 | |0;ai-astar;101;113;111;112;112;113;113;111;111;113 04:43:35 INFO - PROCESS | 17001 | |1;audio-beat-detection;148;118;119;174;116;118;147;117;145;114 04:43:35 INFO - PROCESS | 17001 | |2;audio-dft;161;162;161;161;160;161;161;161;161;160 04:43:35 INFO - PROCESS | 17001 | |3;audio-fft;74;74;75;122;75;75;75;75;102;74 04:43:35 INFO - PROCESS | 17001 | |4;audio-oscillator;83;83;126;84;84;84;122;83;84;132 04:43:35 INFO - PROCESS | 17001 | |5;imaging-gaussian-blur;117;117;116;116;116;117;117;117;117;117 04:43:35 INFO - PROCESS | 17001 | |6;imaging-darkroom;147;147;146;146;146;146;145;146;146;146 04:43:35 INFO - PROCESS | 17001 | |7;imaging-desaturate;95;95;95;96;95;95;95;95;95;96 04:43:35 INFO - PROCESS | 17001 | |8;json-parse-financial;52;53;53;52;52;54;53;53;53;53 04:43:35 INFO - PROCESS | 17001 | |9;json-stringify-tinderbox;62;62;63;62;63;62;62;62;62;63 04:43:35 INFO - PROCESS | 17001 | |10;stanford-crypto-aes;78;75;75;75;80;75;84;76;75;79 04:43:35 INFO - PROCESS | 17001 | |11;stanford-crypto-ccm;128;118;119;127;122;119;133;134;197;120 04:43:35 INFO - PROCESS | 17001 | |12;stanford-crypto-pbkdf2;159;155;161;161;162;157;160;157;160;156 04:43:35 INFO - PROCESS | 17001 | |13;stanford-crypto-sha256-iterative;64;69;68;63;63;63;62;63;66;63 04:43:35 INFO - PROCESS | 17001 | __end_tp_report 04:43:35 INFO - PROCESS | 17001 | __start_cc_report 04:43:35 INFO - PROCESS | 17001 | _x_x_mozilla_cycle_collect,1674 04:43:35 INFO - PROCESS | 17001 | __end_cc_report 04:43:35 INFO - PROCESS | 17001 | __startTimestamp1468064615037__endTimestamp 04:43:35 INFO - PROCESS | 17001 | 04:43:35 INFO - PROCESS | 17001 | ------- Summary: start ------- 04:43:35 INFO - PROCESS | 17001 | Number of tests: 14 04:43:35 INFO - PROCESS | 17001 | 04:43:35 INFO - PROCESS | 17001 | [#0] ai-astar Cycles:10 Average:111.00 Median:112.50 stddev:3.62 (3.2%) stddev-sans-first:0.93 04:43:35 INFO - PROCESS | 17001 | Values: 101.0 113.0 111.0 112.0 112.0 113.0 113.0 111.0 111.0 113.0 04:43:35 INFO - PROCESS | 17001 | 04:43:35 INFO - PROCESS | 17001 | [#1] audio-beat-detection Cycles:10 Average:131.60 Median:132.00 stddev:20.49 (15.5%) stddev-sans-first:20.86 04:43:35 INFO - PROCESS | 17001 | Values: 148.0 118.0 119.0 174.0 116.0 118.0 147.0 117.0 145.0 114.0 04:43:35 INFO - PROCESS | 17001 | 04:43:35 INFO - PROCESS | 17001 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 04:43:35 INFO - PROCESS | 17001 | Values: 161.0 162.0 161.0 161.0 160.0 161.0 161.0 161.0 161.0 160.0 04:43:35 INFO - PROCESS | 17001 | 04:43:35 INFO - PROCESS | 17001 | [#3] audio-fft Cycles:10 Average:82.10 Median:75.00 stddev:16.45 (21.9%) stddev-sans-first:17.19 04:43:35 INFO - PROCESS | 17001 | Values: 74.0 74.0 75.0 122.0 75.0 75.0 75.0 75.0 102.0 74.0 04:43:35 INFO - PROCESS | 17001 | 04:43:35 INFO - PROCESS | 17001 | [#4] audio-oscillator Cycles:10 Average:96.50 Median:83.50 stddev:20.96 (25.1%) stddev-sans-first:21.65 04:43:35 INFO - PROCESS | 17001 | Values: 83.0 83.0 126.0 84.0 84.0 84.0 122.0 83.0 84.0 132.0 04:43:35 INFO - PROCESS | 17001 | 04:43:35 INFO - PROCESS | 17001 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 04:43:35 INFO - PROCESS | 17001 | Values: 117.0 117.0 116.0 116.0 116.0 117.0 117.0 117.0 117.0 117.0 04:43:35 INFO - PROCESS | 17001 | 04:43:35 INFO - PROCESS | 17001 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.50 04:43:35 INFO - PROCESS | 17001 | Values: 147.0 147.0 146.0 146.0 146.0 146.0 145.0 146.0 146.0 146.0 04:43:35 INFO - PROCESS | 17001 | 04:43:35 INFO - PROCESS | 17001 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 04:43:35 INFO - PROCESS | 17001 | Values: 95.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 96.0 04:43:35 INFO - PROCESS | 17001 | 04:43:35 INFO - PROCESS | 17001 | [#8] json-parse-financial Cycles:10 Average:52.80 Median:53.00 stddev:0.63 (1.2%) stddev-sans-first:0.60 04:43:35 INFO - PROCESS | 17001 | Values: 52.0 53.0 53.0 52.0 52.0 54.0 53.0 53.0 53.0 53.0 04:43:35 INFO - PROCESS | 17001 | 04:43:35 INFO - PROCESS | 17001 | [#9] json-stringify-tinderbox Cycles:10 Average:62.30 Median:62.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 04:43:35 INFO - PROCESS | 17001 | Values: 62.0 62.0 63.0 62.0 63.0 62.0 62.0 62.0 62.0 63.0 04:43:35 INFO - PROCESS | 17001 | 04:43:35 INFO - PROCESS | 17001 | [#10] stanford-crypto-aes Cycles:10 Average:77.20 Median:77.00 stddev:3.05 (4.0%) stddev-sans-first:3.22 04:43:35 INFO - PROCESS | 17001 | Values: 78.0 75.0 75.0 75.0 80.0 75.0 84.0 76.0 75.0 79.0 04:43:35 INFO - PROCESS | 17001 | 04:43:35 INFO - PROCESS | 17001 | [#11] stanford-crypto-ccm Cycles:10 Average:131.70 Median:127.50 stddev:23.68 (18.6%) stddev-sans-first:25.08 04:43:35 INFO - PROCESS | 17001 | Values: 128.0 118.0 119.0 127.0 122.0 119.0 133.0 134.0 197.0 120.0 04:43:35 INFO - PROCESS | 17001 | 04:43:35 INFO - PROCESS | 17001 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.80 Median:160.00 stddev:2.39 (1.5%) stddev-sans-first:2.54 04:43:35 INFO - PROCESS | 17001 | Values: 159.0 155.0 161.0 161.0 162.0 157.0 160.0 157.0 160.0 156.0 04:43:35 INFO - PROCESS | 17001 | 04:43:35 INFO - PROCESS | 17001 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.40 Median:63.50 stddev:2.41 (3.8%) stddev-sans-first:2.55 04:43:35 INFO - PROCESS | 17001 | Values: 64.0 69.0 68.0 63.0 63.0 63.0 62.0 63.0 66.0 63.0 04:43:35 INFO - PROCESS | 17001 | -------- Summary: end -------- 04:43:35 INFO - PROCESS | 17001 | 04:43:35 INFO - TEST-INFO | 17001: exit 0 04:43:35 INFO - TEST-OK | kraken | took 60874ms 04:43:35 INFO - SUITE-END | took 1173s 04:43:36 INFO - Completed test suite (00:19:33) 04:43:36 INFO - javascript benchmark 04:43:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3033.9393212135756, 3081.9691803081964, 3099.240686031921, 3105.0684794561635, 3128.9843550782243, 5081.161608334621, 5127.564157046646, 5296.09966305728, 5388.838334849956, 5427.945720542798, 5221.660592061513, 5242.030224408487, 5287.444818294081, 5298.417174110854, 5299.099153143965, 4756.262779269219, 4834.613230941516, 4834.734089625069, 4838.830640927568, 4971.577415919651, 4897.485763994765, 4904.4114706235305, 4922.433920099181, 4961.702297862122, 4980.477049909761, 4702.106599746055, 4707.976460117695, 4771.212749896263, 4781.593564546983, 4790.736509491977, 4760.214564596872, 4780.378550788375, 4848.975755121237, 4857.902841943177, 4904.926426103611, 4669.34629151919, 4818.060478206751, 4823.469418363977, 4834.879128021792, 4892.461829198785, 5206.140986737184, 5257.579393648537, 5275.604329675251, 5339.652922560022, 5356.839294821161, 5624.775008999635, 5647.717614119278, 5654.575906806965, 5676.602637815355, 5677.318721753375, 5485.725713714338, 5545.500904918536, 5778.913316300259, 5813.563982701272, 5819.127130930352, 5266.499682530153, 5345.625806193568, 5360.490753378423, 5365.678059316415, 5366.221897824872, 5841.532677385884, 5856.882862342729, 5858.8242352729485, 5860.736266868002, 5861.648301101863, 5319.148936170272, 5450.182472629137, 5471.753771080311, 5595.132754423071, 5596.972015139898, 5592.664440133605, 5645.1532270159805, 5648.63283886546, 5652.265205523256, 5659.773609055674, 5598.412166722435, 5599.300087489064, 5605.243292155588, 5606.21512988182, 5613.887722245532, 5473.698946557898, 5526.778928842801, 5576.33084029919, 5584.525315348241, 5606.1030235163, 4326.567343265649, 4326.6538676905775, 4327.675424343187, 4331.371951067078, 4360.215161271001, 3862.536495620487, 3881.825317860703, 3902.453656488094, 3913.0, 3918.0792513759243, 5220.738963051832, 5272.736363181825, 5328.094223981932, 5399.433059528771, 5403.270558474555, 5655.491005809415, 5673.546116310686, 5675.318961724537, 5676.631018983753, 5716.942830571724, 5382.515573598395, 5400.540954018874, 5406.135018397038, 5411.242426060355, 5415.241866138744, 4678.274867395559, 4733.786979585927, 4778.880527986828, 4786.7845946932475, 4881.096997055556, 5881.7647294107755, 5890.087036509348, 5895.322037965689, 5903.498202652737, 5904.202932604129, 5687.289088863892, 5702.8289151325525, 5703.486686198262, 5705.800296989585, 5710.172025056427, 5590.832275031756, 5741.540676745767, 5764.337101233412, 5786.768529258782, 5830.2129212555765, 5504.559635229252, 5541.528970037431, 5542.224088627676, 5543.1408131739645, 5545.694986775766, 5437.4562543745305, 5645.491905728504, 5650.378458369658, 5654.547636189012, 5658.5473162147755, 5466.863328416822, 5548.944510555004, 5554.305711786027, 5575.1915972183, 5579.246801681721, 5525.613207075467, 5536.501714845684, 5537.861553461034, 5539.41836107219, 5544.334679838284, 5339.279197308314, 5430.104032834538, 5466.945330546644, 5549.250851135045, 5594.9720251398485, 5512.5589952802875, 5559.277293951922, 5562.332520097614, 5605.271314729059, 5612.579056570855, 5434.755436005468, 5439.292891924025, 5441.782328706808, 5442.183672449164, 5449.945500545103], "value": 5214.64324563243, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [586.384296488687, 613.129356314034, 631.510579301042, 632.4244937107231, 645.183842439314, 32943.341133177324, 35305.47041794372, 35449.82275088624, 43890.341644875356, 45251.32123018149, 45320.69453401922, 45560.54439455605, 45701.542984570144, 45763.31355029677, 45768.0, 8885.200331970138, 9027.052159523255, 9032.819343613124, 9034.051424600388, 9039.553671412576, 9034.638614455414, 9037.502937338444, 9106.089391060874, 9122.22461090808, 9122.726318210463, 9108.134727200906, 9168.954155229248, 9175.44947303164, 9180.632774689004, 9187.03536128707, 9080.182783549446, 9097.090290970884, 9133.634654613808, 9155.313351498631, 9162.725118246462, 8992.370534062618, 9046.823912891348, 9064.229540489066, 9065.59204835784, 9073.54632268384, 43494.34758478625, 43694.12611747779, 43726.344104838456, 43729.56270437287, 43847.0, 3479.704225140866, 3558.811072078148, 3575.94636080459, 3601.0, 3998.0999129126913, 33180.0, 33331.500027499605, 33660.158496037795, 33719.494207586904, 33745.66254337474, 4386.863392674221, 4501.887452813706, 4527.366168736379, 4598.563136502061, 4694.906101877978, 339003.0, 339483.0, 339624.0, 339957.0, 340006.0, 58304.12543811846, 58860.0, 58959.70520147372, 59032.0, 59160.11259831106, 62164.37835621586, 62512.0, 62513.68743156346, 62574.0, 62649.0, 16473.34106635721, 16537.66924661524, 16620.83379166217, 16691.66616667684, 16693.33226670944, 12255.57105501321, 12257.203281786833, 12259.203151795105, 12269.141160118885, 12269.263844169378, 16463.588410289838, 17522.561935951704, 17525.824741752673, 17529.561760955825, 17562.473125806246, 6306.653134077578, 6346.661355375138, 6374.0, 6518.706658200393, 6562.573432726857, 994.5673631970116, 1033.565902321027, 1045.843123531461, 1047.6542740895638, 1087.8096333141668, 33214.16964575905, 33218.66781332204, 33276.83361583177, 33478.0, 33772.66227337744, 956.799072194833, 1087.8150714378576, 1099.648112603975, 1105.7567335186245, 1175.7295821960997, 17097.572560686083, 17110.14449277531, 17282.913585431994, 17294.0, 17366.47900562985, 509329.0, 511224.0, 514920.0, 517632.0, 518873.0, 58636.706816466496, 58743.706281469174, 58876.41123588795, 58951.0, 59048.39040291165, 1259.0997436832708, 1374.8487666356693, 1395.051365071761, 1410.9223992680502, 1417.865302796212, 31038.22404439907, 34742.65257347394, 34787.478187826695, 34982.65017349794, 35167.824160879034, 53549.0, 54633.0, 54801.17798233109, 54809.72595136999, 54827.72586137044, 494120.0, 505894.0, 507232.0, 507976.0, 745967.0, 44563.77718111518, 44826.77586612046, 45834.77082614566, 49257.75371123121, 50074.749626251636, 49959.50040499549, 50264.0, 51071.74464127656, 51174.0, 51666.741666291426, 40397.798011009756, 42797.572024280606, 43252.78373608112, 43264.1593384889, 43846.34230486481, 42355.576444236394, 42760.358594620484, 42815.78592107019, 42830.571694283906, 43553.78223108864, 42937.78531107325, 43591.782041089595, 43801.0, 44250.55749442593, 44265.77867110644, 35022.82488587541, 37672.43491347687, 37780.43329350007, 38333.0, 38570.6142938567, 28704.569431458964, 28772.856135720023, 28789.424211515234, 28980.27549311284, 29243.70756292495], "value": 20770.376920928247, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [397.57062372637574, 399.77612536979274, 401.7609522334211, 404.89270343359016, 411.96984815403914, 18743.0, 19401.611967760637, 20208.59582808343, 20271.08780104897, 20279.0, 18886.62226755464, 18990.145443455043, 19291.517712057204, 19810.30663926763, 19816.10827512762, 5076.79692812288, 5239.240310155025, 5887.4406931341455, 5887.528997680175, 5889.0, 5796.275465566804, 5814.302283725959, 5842.47417732404, 5847.356790753014, 5871.119332100197, 5355.062863998784, 5365.973170134144, 5371.3822910365225, 5371.892562148755, 5416.91874621881, 5265.736713164327, 5312.840614781543, 5355.464453554652, 5361.490658387427, 5363.249145119687, 5217.0, 5242.6330156889035, 5253.185756207794, 5272.499112584298, 5280.0, 14502.927485362507, 14761.483348082766, 14826.406943722239, 19239.422817315502, 23401.88299058511, 2296.7588403217756, 2344.4607740219676, 2369.7630236976165, 2370.6799582056374, 2827.123591686584, 9526.85709714355, 9832.0, 10308.896911030868, 10720.463976801208, 10790.51442685081, 1864.151810926039, 1965.84273258139, 2006.8795872247713, 2011.1653663729535, 2020.1515363547346, 78838.21161788366, 80846.0, 81576.0, 82245.17754822495, 82912.58543707304, 10788.190885683605, 11059.22585419029, 11368.94315528417, 11377.54489820398, 11420.714482137846, 15702.842971570366, 15746.68506629861, 15798.052116873025, 15863.682726345409, 15865.0, 7770.611469426506, 8119.512829230265, 8183.304419124441, 8290.253877151084, 8352.331813454908, 7892.171322011106, 7905.407094467938, 7954.522728636301, 8059.838803223903, 8084.1107478177355, 4925.088858561106, 4940.431850337185, 4981.601471882241, 5011.955810923489, 5019.924701129486, 1934.3713293179492, 1952.7754308254448, 1963.4894927318715, 1998.9000549972734, 2025.7974202579624, 925.7361651929168, 988.6687959533493, 991.2565575818137, 1065.6110519660267, 1069.005824583145, 19824.548249231575, 20688.172473101207, 20701.275455359293, 20786.37640870776, 21058.0, 973.3381300715581, 978.0561757903657, 998.5756053677159, 1005.2309982863115, 1039.449091981251, 10852.294600850919, 11472.483738231633, 11535.76928461426, 11541.134414918915, 11564.710882228012, 354545.0, 357065.0, 359186.22441326804, 471943.0, 484449.0, 76026.0, 85962.57018714867, 88479.0, 89670.0, 109311.45344273228, 1007.7178390050798, 1029.3720830293514, 1046.2885238038054, 1054.8048611006989, 1067.4022547373495, 18580.628387432447, 18775.248990040247, 18887.15007824679, 18961.837402843856, 19160.34566966041, 40401.39397908975, 42343.36484952667, 44424.555754442044, 45113.548864510936, 45759.77120114378, 54010.45989540211, 59382.406175937685, 61303.386966131555, 61321.38678613335, 61644.07533887085, 8757.47455152693, 9147.58835852375, 9180.44917304964, 9229.123233292827, 9526.380785248937, 11116.888831111908, 14245.64385890361, 14599.416023358946, 14744.55766327012, 14957.476488322856, 12694.492220311084, 12706.555270565856, 12912.096153269182, 12967.675808104872, 13001.479940802263, 12168.634940951786, 12243.20419172751, 12565.685857853627, 12623.810642840548, 12785.105042646925, 11862.457880475484, 12816.359182040675, 13101.73796524045, 13135.474581016651, 13321.267330296927, 9012.63949442015, 9135.0, 9449.952750236205, 9553.522323883639, 9584.04159584064, 12623.93688031554, 13026.2835544046, 13041.869581304445, 13043.152195107288, 13193.80209296842], "value": 9335.930755406924, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1461.8099647045883, 1484.7475929092054, 1614.7820044294024, 1767.8674099442544, 1795.0, 8277.420580559363, 8767.816344793451, 8893.0, 8902.33232507562, 8903.910960890396, 7546.0, 8288.751337459871, 8480.279176270025, 8499.830003399928, 8736.170063843925, 2266.795988361047, 2308.6421604651305, 2314.2016004478514, 2315.3632750993443, 2316.3861576682193, 2263.321003698892, 2282.4408020035116, 2283.680284760135, 2285.0745448093467, 2294.4149241943364, 1937.273522429089, 2172.3374370816973, 2233.6984507091497, 2237.5748607764554, 2252.842301038928, 2233.7877901599486, 2260.3557985974003, 2268.0, 2281.2129815213725, 2282.7374851891996, 2236.2620335289316, 2241.674957131207, 2242.192810588187, 2245.6631505274177, 2245.8989345479495, 8698.304135669132, 8729.0, 8753.212210900985, 8755.649774009033, 8763.78090547735, 5047.369078865142, 5061.089003979282, 5140.665856719302, 5185.662931909414, 5190.740462976836, 3223.3553289342226, 3333.4666453367586, 3396.626371099177, 3411.812350320731, 3414.402479566066, 1085.2821037776218, 1105.618561596248, 1119.3284029582267, 1134.4384529657873, 1137.039201874423, 12068.698282542919, 12075.335856527887, 12092.33492157931, 12092.758144837142, 12097.274163550303, 4306.397104405386, 4414.249577571821, 4536.682432229778, 4615.607673347736, 4618.861434156981, 10218.489075546193, 10224.693259202237, 10227.232957528215, 10228.59085636581, 10231.181505479544, 5224.346956630421, 5224.50367215114, 5226.398964119175, 5227.0, 5232.712200828991, 4643.698159619614, 4758.857234282977, 4791.520847915181, 4793.161196790547, 4798.1123492154065, 3788.905277368088, 3865.9226815463535, 3918.941215881764, 3922.9607703922597, 3942.1130245695063, 1135.3017893995134, 1237.3936770982154, 1250.6748245456247, 1253.9686507837196, 1273.9044571657162, 889.4174315823146, 926.5598840550684, 933.869258303838, 959.5490119643756, 987.0376383026492, 6076.240469941257, 6088.1476593276975, 6170.136180934583, 6214.223222097238, 6231.875362492816, 980.2403137568299, 980.2892902645525, 980.9509524523888, 984.7636567223815, 1011.438651548383, 4160.126373461607, 4217.915641687149, 4258.488981322261, 4297.183535128315, 4327.394164816928, 10488.842667359995, 10665.040146386862, 10692.518836652369, 10731.9072780807, 10740.248182627141, 10195.388276703421, 10544.367337959748, 10644.201684873666, 10668.786624267626, 10710.892891071146, 7944.086430060617, 8041.437099403102, 8057.83884322322, 8090.0696419912465, 8140.389470789714, 5990.7903223386975, 6274.6548939808745, 6290.748370065146, 6326.905096423649, 6338.619682818861, 9438.0, 9632.855507167258, 9635.662751803653, 9852.605895764089, 9857.802843942938, 9547.42715437076, 9986.201103911815, 10109.545070471993, 10110.241731869992, 10118.696439106838, 7518.097828260644, 7698.846023079395, 7762.456628035983, 7768.53388796674, 7768.84462310762, 8093.433459658003, 8116.0, 8136.593170341577, 8137.552434615916, 8139.226773456512, 7242.203357630551, 7499.400047996256, 7555.357794587521, 7566.621668916642, 7639.770806875803, 7554.131274903457, 7583.165851756192, 7627.427942904415, 7745.341645959931, 7761.0, 6862.970554416877, 6895.6207408591, 6936.34104760047, 6937.687804048931, 6941.167059952838, 5021.347224860745, 5107.438181799925, 5183.688978661293, 5231.110711179184, 5259.973700131475, 4954.108260513142, 4986.80052797884, 5051.368578927634, 5065.442801291929, 5087.058894104603], "value": 4586.578142603693, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [321.8262138445238, 322.19451371571074, 329.3446042375673, 329.38733954843985, 331.9983400083002, 5254.57963362931, 5263.947360526394, 5295.173165257989, 5302.693328402148, 5325.934813037388, 5190.8702282442955, 5210.6613070150415, 5253.0, 5257.605679574028, 5257.921131183035, 3952.3281042222893, 3988.820503077354, 4122.0, 4135.338345864662, 4151.149014452045, 4060.3706425503947, 4084.836606535735, 4095.5699651536606, 4102.958970410303, 4105.096878686699, 3941.5664276929515, 4088.897777555555, 4100.610442008005, 4102.610252026053, 4119.217348703752, 3995.380715989026, 4098.979505102485, 4101.671866250693, 4116.5060192776755, 4118.855840045599, 3624.7100231981376, 3640.508531348287, 3647.1399586211223, 3655.342038433081, 3662.597114317423, 5190.4031036430915, 5193.1171700810955, 5203.323567936182, 5209.244659524347, 5213.661112027744, 4392.912141757147, 4647.697899636512, 4679.415073115861, 4698.449511661143, 4702.294655801623, 5460.972695136538, 5482.150266708666, 5482.656749096497, 5493.0, 5499.367572729107, 3911.100446897201, 3925.4308125321954, 3932.0, 3933.6066393360434, 3941.192055628589, 5586.35756887959, 5667.376588575254, 5671.6388066864065, 5694.629849059839, 5712.542996560265, 3995.840166393312, 4004.819783109767, 4014.759114453142, 4023.939640905389, 4039.7778122203563, 4027.3153563894207, 4049.91900162001, 4058.2695114879607, 4084.0810817566403, 4100.856470023535, 4524.705894116872, 4639.907201855944, 4654.25531914892, 4658.813647454132, 4682.555157260055, 5491.791805802717, 5504.0, 5504.669719816824, 5538.667679939216, 5563.7774489019985, 1392.1994852959588, 1402.4390243902317, 1404.3048690898072, 1405.192014591614, 1411.905773025913, 854.256796586961, 886.2732559301439, 892.3396686451979, 902.1294450854956, 952.5046975572664, 5249.737513124329, 5294.46460526443, 5301.231321458367, 5317.032697901724, 5325.3609566851455, 5487.5884308677005, 5525.336959564878, 5528.226048353154, 5551.444855514497, 5567.884204002453, 5127.461616530285, 5242.397124330674, 5246.396664383568, 5271.6309858310315, 5310.946890531122, 2918.387138700854, 2919.474494590994, 2941.9411611767646, 2947.572601972702, 2947.955780663292, 5749.88500229993, 5753.338366087954, 5767.509761670221, 5772.709555553294, 5791.046566251242, 5454.4545545445135, 5651.943480565142, 5677.687727175045, 5696.3449203341315, 5701.458361455655, 5673.716314184274, 5727.39862314451, 5756.265773757432, 5795.304563452329, 5804.47759701612, 5247.58019358458, 5520.282363292747, 5608.831735047955, 5614.0, 5614.382417934105, 5474.452554744494, 5480.561555075664, 5494.587905907153, 5495.560355171657, 5499.340079190522, 5659.6321239119325, 5706.600537962303, 5744.4829965303325, 5748.39641837601, 5783.652980821164, 3893.8247778849454, 3967.107400834789, 3994.141259629194, 4004.979975100106, 4014.177093695727, 5327.547158491571, 5537.529310008695, 5542.224088627515, 5575.1915972184615, 5591.748371323219, 5292.682439053669, 5389.8922021558565, 5451.754671039734, 5475.890482190254, 5510.724463776715, 5462.8361149165585, 5475.753591088331, 5510.972445137749, 5518.392976772471, 5528.502434780889, 5277.973610131925, 5453.0, 5495.807646732345, 5495.835124946098, 5498.395176530498, 5504.724763761876, 5507.256520369699, 5530.446955304598, 5538.307711536058, 5557.666540007613, 5186.714730689849, 5428.185772134211, 5434.619576629598, 5441.238226648352, 5457.754401051883], "value": 4174.370166535385, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [733.5452019747761, 736.9484136110474, 764.7782143178479, 830.6303694855787, 854.987175192372, 14052.578422647324, 14500.709985800278, 14849.925750371247, 14860.108393496397, 14873.553793386189, 14660.56018319452, 14665.926670366633, 14684.265786710648, 14703.33834977426, 14768.113913165218, 664.9800505984829, 796.8326651403198, 798.7883210949103, 807.2250639386197, 810.9107998120202, 805.1827395193883, 806.5120602035772, 807.2976510435929, 807.4549678966704, 808.8058865872177, 870.2037635563452, 872.2803686958254, 872.6073267029861, 872.9781755456132, 872.9912700873006, 690.17868736204, 844.1727107434748, 862.4782006885838, 864.0322838420977, 867.757028032152, 628.3371043549099, 628.3433811666819, 628.9842753931142, 629.222909706512, 630.1398590923357, 15081.773773393408, 15103.32035058425, 15117.697646047018, 15121.773173402407, 15126.0, 13967.161970281815, 14376.784348234785, 14580.781288280577, 14612.342444590018, 14727.852721472755, 12949.611511654666, 13090.934545327307, 13116.0, 13177.736445271137, 13744.381502832297, 4121.690873184523, 4232.534421213664, 4234.513031001444, 4238.639715624176, 4344.109457561224, 80227.0, 80228.0, 81171.59414202892, 81334.9999999994, 81458.59270703609, 10739.83890241647, 11413.48639311233, 11589.0, 11671.941640291914, 11783.823242651368, 21016.474588135112, 21253.46866328323, 21288.78711212899, 21289.36131916045, 21361.14555417766, 7907.960460197777, 7936.0, 8020.318272946748, 8071.838563228703, 8272.586370681442, 4531.093781243764, 4564.863054108316, 4613.169629466728, 4662.090892275974, 4818.927716084261, 3500.7724497907557, 3603.6036036036016, 3614.0603443104983, 3619.3304238715923, 3619.5656521217097, 471.16142708092076, 646.2342124582385, 652.6425035925264, 653.7711800869657, 654.1038776875711, 650.7982525417136, 658.5719282466339, 725.1733024352137, 740.5630677900065, 758.1054355860138, 9617.71146865595, 9692.563834627459, 9789.755256118511, 10125.949370253102, 10128.696139115838, 677.8271540757075, 714.4712912444753, 734.0860628517423, 737.1706829816457, 741.9768169492505, 4324.3513472978675, 4519.81920723174, 4570.291604801261, 4674.0, 4705.270683044134, 124505.37747311205, 131001.0, 132975.0, 133449.29622520893, 138601.3069934664, 108653.45673271583, 111473.44263278632, 112156.0, 114611.42694286475, 115813.0, 98502.0, 101141.0, 101243.0, 104340.47829760803, 104871.0, 8883.911160888309, 8991.55042247898, 8997.190252877272, 9081.273498120003, 9195.862062069207, 56486.717566411906, 56796.716016419654, 57106.14340784975, 58177.4182258172, 59259.703701481216, 75657.62171189109, 77136.02391629298, 78848.0, 83483.0, 85576.0, 11054.613088542184, 11462.312261264351, 11481.138914581607, 11551.075913927034, 11894.881051189723, 11786.646400607995, 11867.109966752356, 11880.405979700807, 11980.161388702707, 12235.877641223475, 11241.71895702614, 11270.380129092979, 11290.830637540279, 11369.772604547697, 11543.0, 11477.48351324209, 12184.147109702235, 12398.442070107047, 12703.491860325854, 12781.552645657357, 11995.820062698893, 12064.095192860395, 12194.451249693608, 12336.938315308365, 12383.62849114528, 9483.715488535356, 10049.447280399649, 10057.497125143567, 10358.223133265186, 10364.274500784873, 8891.0, 8941.195292423454, 9196.632134714537, 9403.576839042396, 10039.69880903574], "value": 7489.99530810651, "unit": "score"}], "name": "dromaeo_css", "value": 7248.352441241221, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 113.0, 111.0, 112.0, 112.0, 113.0, 113.0, 111.0, 111.0, 113.0], "value": 111.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 118.0, 119.0, 174.0, 116.0, 118.0, 147.0, 117.0, 145.0, 114.0], "value": 131.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 161.0, 161.0, 160.0, 161.0, 161.0, 161.0, 161.0, 160.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 75.0, 122.0, 75.0, 75.0, 75.0, 75.0, 102.0, 74.0], "value": 82.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 126.0, 84.0, 84.0, 84.0, 122.0, 83.0, 84.0, 132.0], "value": 96.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 146.0, 146.0, 146.0, 145.0, 146.0, 146.0, 146.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 53.0, 53.0, 52.0, 52.0, 54.0, 53.0, 53.0, 53.0, 53.0], "value": 52.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 63.0, 62.0, 63.0, 62.0, 62.0, 62.0, 62.0, 63.0], "value": 62.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 75.0, 75.0, 75.0, 80.0, 75.0, 84.0, 76.0, 75.0, 79.0], "value": 77.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 118.0, 119.0, 127.0, 122.0, 119.0, 133.0, 134.0, 197.0, 120.0], "value": 131.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 155.0, 161.0, 161.0, 162.0, 157.0, 160.0, 157.0, 160.0, 156.0], "value": 158.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 69.0, 68.0, 63.0, 63.0, 63.0, 62.0, 63.0, 66.0, 63.0], "value": 64.4, "unit": "score"}], "name": "kraken", "value": 1487.3000000000002, "alertThreshold": 2.0}]} 04:43:36 INFO - Return code: 0 04:43:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:43:36 INFO - # TBPL SUCCESS # 04:43:36 INFO - Running post-action listener: _resource_record_post_action 04:43:36 INFO - ##### 04:43:36 INFO - ##### Finished run-tests step (success) 04:43:36 INFO - ##### 04:43:36 INFO - Running post-run listener: _resource_record_post_run 04:43:36 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 0; Write bytes: 555188224; Read time: 0; Write time: 468188 04:43:36 INFO - TinderboxPrint: CPU usage
13.0% 04:43:36 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 04:43:36 INFO - TinderboxPrint: I/O write bytes / time
555,188,224 / 468,188 04:43:36 INFO - TinderboxPrint: CPU idle
8,270.2 (87.0%) 04:43:36 INFO - TinderboxPrint: CPU user
1,194.1 (12.6%) 04:43:36 INFO - TinderboxPrint: Swap in / out
0 / 0 04:43:36 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 256225280; Read time: 0; Write time: 243696 04:43:36 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 298348544; Read time: 0; Write time: 224492 04:43:36 INFO - Running post-run listener: _upload_blobber_files 04:43:36 INFO - Blob upload gear active. 04:43:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:43:36 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:43:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:43:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:43:37 INFO - (blobuploader) - INFO - Open directory for files ... 04:43:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:43:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:43:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:43:40 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:43:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:43:40 INFO - (blobuploader) - INFO - Done attempting. 04:43:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:43:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:43:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:43:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:43:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:43:42 INFO - (blobuploader) - INFO - Done attempting. 04:43:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:43:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:43:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:43:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:43:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:43:43 INFO - (blobuploader) - INFO - Done attempting. 04:43:43 INFO - (blobuploader) - INFO - Iteration through files over. 04:43:43 INFO - Return code: 0 04:43:43 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:43:43 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:43:43 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/33ffec2b3619abf6c00c47daa3ce1e8f979965ee132c849b5450f50c1d9cd992c3cd55a13610d448603a4c3088b718e5b0d932eabe9f01f0dce36593cc69c50d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e0a099fda1837b16037d3cbaef888cde988597f6f3787fe8207ac8d4ef3ef04f45620867ebb079b7927136e35e51476b2762e897e37d14c4ede522710a3285f5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1deb69cfb87af62a535e73b20fe62504e65fff77372b18384d43db5894bb4f752832d80b32ec11947657a2b2058138602606eca2bf45e7b1d83c20edc60192b8"} 04:43:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:43:43 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:43:43 INFO - Contents: 04:43:43 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/33ffec2b3619abf6c00c47daa3ce1e8f979965ee132c849b5450f50c1d9cd992c3cd55a13610d448603a4c3088b718e5b0d932eabe9f01f0dce36593cc69c50d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e0a099fda1837b16037d3cbaef888cde988597f6f3787fe8207ac8d4ef3ef04f45620867ebb079b7927136e35e51476b2762e897e37d14c4ede522710a3285f5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1deb69cfb87af62a535e73b20fe62504e65fff77372b18384d43db5894bb4f752832d80b32ec11947657a2b2058138602606eca2bf45e7b1d83c20edc60192b8"} 04:43:43 INFO - Running post-run listener: copy_logs_to_upload_dir 04:43:43 INFO - Copying logs to upload dir... 04:43:43 INFO - mkdir: /builds/slave/test/build/upload/logs 04:43:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.816867 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-07-09 04:43:42.987943) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-09 04:43:42.992040) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1468060409.406568-104905261 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/33ffec2b3619abf6c00c47daa3ce1e8f979965ee132c849b5450f50c1d9cd992c3cd55a13610d448603a4c3088b718e5b0d932eabe9f01f0dce36593cc69c50d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e0a099fda1837b16037d3cbaef888cde988597f6f3787fe8207ac8d4ef3ef04f45620867ebb079b7927136e35e51476b2762e897e37d14c4ede522710a3285f5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1deb69cfb87af62a535e73b20fe62504e65fff77372b18384d43db5894bb4f752832d80b32ec11947657a2b2058138602606eca2bf45e7b1d83c20edc60192b8"} build_url:https://queue.taskcluster.net/v1/task/WbUEBQaJTtGR5NhfPmTf9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011337 build_url: 'https://queue.taskcluster.net/v1/task/WbUEBQaJTtGR5NhfPmTf9g/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/33ffec2b3619abf6c00c47daa3ce1e8f979965ee132c849b5450f50c1d9cd992c3cd55a13610d448603a4c3088b718e5b0d932eabe9f01f0dce36593cc69c50d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e0a099fda1837b16037d3cbaef888cde988597f6f3787fe8207ac8d4ef3ef04f45620867ebb079b7927136e35e51476b2762e897e37d14c4ede522710a3285f5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1deb69cfb87af62a535e73b20fe62504e65fff77372b18384d43db5894bb4f752832d80b32ec11947657a2b2058138602606eca2bf45e7b1d83c20edc60192b8"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-09 04:43:43.017784) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-09 04:43:43.018180) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1468060409.406568-104905261 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004381 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-09 04:43:43.103691) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-09 04:43:43.104024) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-09 04:43:43.104338) ========= ========= Total master_lag: 0.18 =========