builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-050 starttime: 1468330624.51 results: success (0) buildid: 20160712033410 builduid: 8fc38ad2542748fe81dd9582f4f8b5ac revision: 173d493da6f5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-12 06:37:04.509856) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-12 06:37:04.510357) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-12 06:37:04.510646) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-12 06:37:04.525887) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 06:37:04.526199) ========= 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=6dbc10da6d83fee962c624be000001a8-1468330623.740340-2115176594 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-12 06:37:04-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 219M=0s 2016-07-12 06:37:04 (219 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.326289 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 06:37:04.866941) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 06:37:04.867295) ========= 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=6dbc10da6d83fee962c624be000001a8-1468330623.740340-2115176594 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016783 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 06:37:04.918678) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 06:37:04.919161) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 173d493da6f5 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 173d493da6f5 --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=6dbc10da6d83fee962c624be000001a8-1468330623.740340-2115176594 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-12 06:37:04,998 Setting DEBUG logging. 2016-07-12 06:37:04,998 attempt 1/10 2016-07-12 06:37:04,998 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/173d493da6f5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-12 06:37:05,360 unpacking tar archive at: fx-team-173d493da6f5/testing/mozharness/ program finished with exit code 0 elapsedTime=0.710951 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 06:37:05.648509) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-12 06:37:05.649321) ========= script_repo_revision: 173d493da6f5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-12 06:37:05.650346) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-12 06:37:05.651018) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-12 06:37:05.662925) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-07-12 06:37:05.663203) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=6dbc10da6d83fee962c624be000001a8-1468330623.740340-2115176594 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:37:05 INFO - MultiFileLogger online at 20160712 06:37:05 in /builds/slave/test 06:37:05 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 06:37:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:37:05 INFO - {'append_to_log': False, 06:37:05 INFO - 'base_work_dir': '/builds/slave/test', 06:37:05 INFO - 'blob_upload_branch': 'Fx-Team', 06:37:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:37:05 INFO - 'branch': 'Fx-Team', 06:37:05 INFO - 'buildbot_json_path': 'buildprops.json', 06:37:05 INFO - 'config_files': ('talos/linux_config.py',), 06:37:05 INFO - 'default_actions': ('clobber', 06:37:05 INFO - 'read-buildbot-config', 06:37:05 INFO - 'download-and-extract', 06:37:05 INFO - 'populate-webroot', 06:37:05 INFO - 'create-virtualenv', 06:37:05 INFO - 'install', 06:37:05 INFO - 'run-tests'), 06:37:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:37:05 INFO - 'download_minidump_stackwalk': True, 06:37:05 INFO - 'download_symbols': 'ondemand', 06:37:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:37:05 INFO - 'tooltool.py': '/tools/tooltool.py', 06:37:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:37:05 INFO - '/tools/misc-python/virtualenv.py')}, 06:37:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:37:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:37:05 INFO - 'installer_path': 'installer.exe', 06:37:05 INFO - 'log_level': 'info', 06:37:05 INFO - 'log_name': 'talos', 06:37:05 INFO - 'log_to_console': True, 06:37:05 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:37:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:37:05 INFO - 'opt_config_files': (), 06:37:05 INFO - 'pip_index': False, 06:37:05 INFO - 'sps_profile': False, 06:37:05 INFO - 'sps_profile_interval': 0, 06:37:05 INFO - 'suite': 'dromaeojs', 06:37:05 INFO - 'system_bits': '32', 06:37:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:37:05 INFO - 'title': 'talos-linux64-ix-050', 06:37:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:37:05 INFO - 'use_talos_json': True, 06:37:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:37:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:37:05 INFO - 'work_dir': 'build'} 06:37:05 INFO - ##### 06:37:05 INFO - ##### Running clobber step. 06:37:05 INFO - ##### 06:37:05 INFO - Running pre-action listener: _resource_record_pre_action 06:37:05 INFO - Running main action method: clobber 06:37:05 INFO - rmtree: /builds/slave/test/build 06:37:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:37:06 INFO - Running post-action listener: _resource_record_post_action 06:37:06 INFO - ##### 06:37:06 INFO - ##### Finished clobber step (success) 06:37:06 INFO - ##### 06:37:06 INFO - ##### 06:37:06 INFO - ##### Running read-buildbot-config step. 06:37:06 INFO - ##### 06:37:06 INFO - Running pre-action listener: _resource_record_pre_action 06:37:06 INFO - Running main action method: read_buildbot_config 06:37:06 INFO - Using buildbot properties: 06:37:06 INFO - { 06:37:06 INFO - "project": "", 06:37:06 INFO - "product": "firefox", 06:37:06 INFO - "script_repo_revision": "production", 06:37:06 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 06:37:06 INFO - "repository": "", 06:37:06 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 06:37:06 INFO - "buildid": "20160712033410", 06:37:06 INFO - "pgo_build": "True", 06:37:06 INFO - "basedir": "/builds/slave/test", 06:37:06 INFO - "buildnumber": 894, 06:37:06 INFO - "slavename": "talos-linux64-ix-050", 06:37:06 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 06:37:06 INFO - "platform": "ubuntu64_hw", 06:37:06 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 06:37:06 INFO - "branch": "fx-team", 06:37:06 INFO - "repo_path": "integration/fx-team", 06:37:06 INFO - "revision": "173d493da6f5", 06:37:06 INFO - "stage_platform": "linux64-pgo", 06:37:06 INFO - "builduid": "8fc38ad2542748fe81dd9582f4f8b5ac", 06:37:06 INFO - "slavebuilddir": "test" 06:37:06 INFO - } 06:37:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/QjTOXqtgQ26IGcj4GJ4Tqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 06:37:06 INFO - Running post-action listener: _resource_record_post_action 06:37:06 INFO - ##### 06:37:06 INFO - ##### Finished read-buildbot-config step (success) 06:37:06 INFO - ##### 06:37:06 INFO - ##### 06:37:06 INFO - ##### Running download-and-extract step. 06:37:06 INFO - ##### 06:37:06 INFO - Running pre-action listener: _resource_record_pre_action 06:37:06 INFO - Running main action method: download_and_extract 06:37:06 INFO - mkdir: /builds/slave/test/build/tests 06:37:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:37:06 INFO - https://queue.taskcluster.net/v1/task/QjTOXqtgQ26IGcj4GJ4Tqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 06:37:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QjTOXqtgQ26IGcj4GJ4Tqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 06:37:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QjTOXqtgQ26IGcj4GJ4Tqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 06:37:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QjTOXqtgQ26IGcj4GJ4Tqw/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 06:37:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QjTOXqtgQ26IGcj4GJ4Tqw/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 06:37:06 INFO - Downloaded 1361 bytes. 06:37:06 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 06:37:06 INFO - Using the following test package requirements: 06:37:06 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 06:37:06 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:37:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:37:06 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:37:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:37:06 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:37:06 INFO - u'jsshell-linux-x86_64.zip'], 06:37:06 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:37:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:37:06 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 06:37:06 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:37:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:37:06 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:37:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:37:06 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:37:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:37:06 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:37:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:37:06 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:37:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:37:06 INFO - https://queue.taskcluster.net/v1/task/QjTOXqtgQ26IGcj4GJ4Tqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:37:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QjTOXqtgQ26IGcj4GJ4Tqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 06:37:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QjTOXqtgQ26IGcj4GJ4Tqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 06:37:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QjTOXqtgQ26IGcj4GJ4Tqw/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 06:37:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QjTOXqtgQ26IGcj4GJ4Tqw/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 06:37:08 INFO - Downloaded 24271091 bytes. 06:37:08 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'] 06:37:08 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 06:37:09 INFO - Return code: 0 06:37:09 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 06:37: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')]} 06:37:09 INFO - https://queue.taskcluster.net/v1/task/QjTOXqtgQ26IGcj4GJ4Tqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:37:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QjTOXqtgQ26IGcj4GJ4Tqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 06:37:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QjTOXqtgQ26IGcj4GJ4Tqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 06:37:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QjTOXqtgQ26IGcj4GJ4Tqw/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 06:37:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QjTOXqtgQ26IGcj4GJ4Tqw/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 06:37:10 INFO - Downloaded 24271091 bytes. 06:37:10 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'] 06:37:10 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 06:37:11 INFO - Return code: 0 06:37:11 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')]} 06:37:11 INFO - https://queue.taskcluster.net/v1/task/QjTOXqtgQ26IGcj4GJ4Tqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:37:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QjTOXqtgQ26IGcj4GJ4Tqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 06:37:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QjTOXqtgQ26IGcj4GJ4Tqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 06:37:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QjTOXqtgQ26IGcj4GJ4Tqw/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 06:37:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QjTOXqtgQ26IGcj4GJ4Tqw/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 06:37:12 INFO - Downloaded 14403317 bytes. 06:37:12 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'] 06:37:12 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 06:37:13 INFO - Return code: 0 06:37:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:37:13 INFO - https://queue.taskcluster.net/v1/task/QjTOXqtgQ26IGcj4GJ4Tqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:37:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QjTOXqtgQ26IGcj4GJ4Tqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 06:37:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QjTOXqtgQ26IGcj4GJ4Tqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 06:37:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QjTOXqtgQ26IGcj4GJ4Tqw/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 06:37:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QjTOXqtgQ26IGcj4GJ4Tqw/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 06:37:14 INFO - Downloaded 60480314 bytes. 06:37:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QjTOXqtgQ26IGcj4GJ4Tqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 06:37:14 INFO - mkdir: /builds/slave/test/properties 06:37:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:37:14 INFO - Writing to file /builds/slave/test/properties/build_url 06:37:14 INFO - Contents: 06:37:14 INFO - build_url:https://queue.taskcluster.net/v1/task/QjTOXqtgQ26IGcj4GJ4Tqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 06:37:15 INFO - Running post-action listener: _resource_record_post_action 06:37:15 INFO - Running post-action listener: set_extra_try_arguments 06:37:15 INFO - ##### 06:37:15 INFO - ##### Finished download-and-extract step (success) 06:37:15 INFO - ##### 06:37:15 INFO - ##### 06:37:15 INFO - ##### Running populate-webroot step. 06:37:15 INFO - ##### 06:37:15 INFO - Running pre-action listener: _resource_record_pre_action 06:37:15 INFO - Running main action method: populate_webroot 06:37:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:37:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:37:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:37:15 INFO - '--tppagecycles', 06:37:15 INFO - '7'], 06:37:15 INFO - 'tests': ['tsvgm']}}, 06:37:15 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:37:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:37:15 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:37:15 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:37:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:37:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:37:15 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:37:15 INFO - 'talos_options': ['--disable-e10s'], 06:37:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:37:15 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:37:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:37:15 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:37:15 INFO - 'talos_options': ['--disable-e10s'], 06:37:15 INFO - 'tests': ['damp', 'tps']}, 06:37:15 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:37:15 INFO - 'tests': ['damp', 'tps']}, 06:37:15 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:37:15 INFO - 'tests': ['dromaeo_dom']}, 06:37:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:37:15 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:37:15 INFO - 'tests': ['basic_compositor_video']}, 06:37:15 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:37:15 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:37:15 INFO - 'tests': ['a11yr', 06:37:15 INFO - 'ts_paint', 06:37:15 INFO - 'tpaint', 06:37:15 INFO - 'sessionrestore', 06:37:15 INFO - 'sessionrestore_no_auto_restore', 06:37:15 INFO - 'tabpaint']}, 06:37:15 INFO - 'other-e10s': {'tests': ['a11yr', 06:37:15 INFO - 'ts_paint', 06:37:15 INFO - 'tpaint', 06:37:15 INFO - 'sessionrestore', 06:37:15 INFO - 'sessionrestore_no_auto_restore', 06:37:15 INFO - 'tabpaint']}, 06:37:15 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:37:15 INFO - 'ts_paint', 06:37:15 INFO - 'tpaint', 06:37:15 INFO - 'sessionrestore', 06:37:15 INFO - 'sessionrestore_no_auto_restore', 06:37:15 INFO - 'tabpaint']}, 06:37:15 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:37:15 INFO - 'ts_paint', 06:37:15 INFO - 'tpaint', 06:37:15 INFO - 'sessionrestore', 06:37:15 INFO - 'sessionrestore_no_auto_restore', 06:37:15 INFO - 'tabpaint']}, 06:37:15 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:37:15 INFO - 'tests': ['a11yr', 06:37:15 INFO - 'ts_paint', 06:37:15 INFO - 'tpaint', 06:37:15 INFO - 'sessionrestore', 06:37:15 INFO - 'sessionrestore_no_auto_restore', 06:37:15 INFO - 'tabpaint']}, 06:37:15 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:37:15 INFO - 'tests': ['a11yr', 06:37:15 INFO - 'ts_paint', 06:37:15 INFO - 'tpaint', 06:37:15 INFO - 'sessionrestore', 06:37:15 INFO - 'sessionrestore_no_auto_restore', 06:37:15 INFO - 'tabpaint']}, 06:37:15 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:37:15 INFO - 'tests': ['tsvgx', 06:37:15 INFO - 'tsvgr_opacity', 06:37:15 INFO - 'tart', 06:37:15 INFO - 'tscrollx', 06:37:15 INFO - 'cart']}, 06:37:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:37:15 INFO - 'tsvgr_opacity', 06:37:15 INFO - 'tart', 06:37:15 INFO - 'tscrollx', 06:37:15 INFO - 'cart']}, 06:37:15 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:37:15 INFO - 'talos_options': ['--disable-e10s'], 06:37:15 INFO - 'tests': ['tp5o']}, 06:37:15 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:37:15 INFO - 'tests': ['tp5o']}, 06:37:15 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:37:15 INFO - 'talos_options': ['--disable-e10s', 06:37:15 INFO - '--xperf_path', 06:37:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:37:15 INFO - 'tests': ['tp5n']}, 06:37:15 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:37:15 INFO - 'talos_options': ['--xperf_path', 06:37:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:37:15 INFO - 'tests': ['tp5n']}}, 06:37:15 INFO - 'talos.zip': {'path': '', 06:37:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:37:15 INFO - Running post-action listener: _resource_record_post_action 06:37:15 INFO - ##### 06:37:15 INFO - ##### Finished populate-webroot step (success) 06:37:15 INFO - ##### 06:37:15 INFO - ##### 06:37:15 INFO - ##### Running create-virtualenv step. 06:37:15 INFO - ##### 06:37:15 INFO - Running pre-action listener: _resource_record_pre_action 06:37:15 INFO - Running main action method: create_virtualenv 06:37:15 INFO - Creating virtualenv /builds/slave/test/build/venv 06:37:15 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 06:37:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:37:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:37:15 INFO - Using real prefix '/usr' 06:37:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:37:15 INFO - Installing distribute.............................................................................................................................................................................................done. 06:37:17 INFO - Installing pip.................done. 06:37:17 INFO - Return code: 0 06:37:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:37: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')]} 06:37:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:37:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37: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')]} 06:37:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:37:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:17 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 0x23bb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x251e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x267c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x267a3b0>, '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 0x267b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x267b740>, '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': '6dbc10da6d83fee962c624be000001a8-1468330623.740340-2115176594', '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 06:37:17 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 06:37:17 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 06:37:17 INFO - Using env: {'DISPLAY': ':0', 06:37:17 INFO - 'HOME': '/home/cltbld', 06:37:17 INFO - 'LANG': 'en_US.UTF-8', 06:37:17 INFO - 'LANGUAGE': 'en_US:en', 06:37:17 INFO - 'LOGNAME': 'cltbld', 06:37:17 INFO - 'MAIL': '/var/mail/cltbld', 06:37:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:37:17 INFO - 'MOZ_NO_REMOTE': '1', 06:37:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:37:17 INFO - 'NO_EM_RESTART': '1', 06:37:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:37:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:37:17 INFO - 'PWD': '/builds/slave/test', 06:37:17 INFO - 'SHELL': '/bin/bash', 06:37:17 INFO - 'SHLVL': '1', 06:37:17 INFO - 'TERM': 'linux', 06:37:17 INFO - 'TMOUT': '86400', 06:37:17 INFO - 'USER': 'cltbld', 06:37:17 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1468330623.740340-2115176594', 06:37:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:37:17 INFO - '_': '/tools/buildbot/bin/python'} 06:37:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:37:17 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 06:37:17 INFO - Cleaning up... 06:37:18 INFO - Return code: 0 06:37:18 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:37:18 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')]} 06:37:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:37:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:18 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')]} 06:37:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:37:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:18 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 0x23bb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x251e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x267c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x267a3b0>, '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 0x267b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x267b740>, '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': '6dbc10da6d83fee962c624be000001a8-1468330623.740340-2115176594', '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 06:37:18 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 06:37:18 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 06:37:18 INFO - Using env: {'DISPLAY': ':0', 06:37:18 INFO - 'HOME': '/home/cltbld', 06:37:18 INFO - 'LANG': 'en_US.UTF-8', 06:37:18 INFO - 'LANGUAGE': 'en_US:en', 06:37:18 INFO - 'LOGNAME': 'cltbld', 06:37:18 INFO - 'MAIL': '/var/mail/cltbld', 06:37:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:37:18 INFO - 'MOZ_NO_REMOTE': '1', 06:37:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:37:18 INFO - 'NO_EM_RESTART': '1', 06:37:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:37:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:37:18 INFO - 'PWD': '/builds/slave/test', 06:37:18 INFO - 'SHELL': '/bin/bash', 06:37:18 INFO - 'SHLVL': '1', 06:37:18 INFO - 'TERM': 'linux', 06:37:18 INFO - 'TMOUT': '86400', 06:37:18 INFO - 'USER': 'cltbld', 06:37:18 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1468330623.740340-2115176594', 06:37:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:37:18 INFO - '_': '/tools/buildbot/bin/python'} 06:37:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:37:18 INFO - Downloading/unpacking psutil>=3.1.1 06:37:18 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 06:37:18 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 06:37:18 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 06:37:18 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 06:37:18 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 06:37:18 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 06:37:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:37:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:37:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:37:20 INFO - Installing collected packages: psutil 06:37:20 INFO - Running setup.py install for psutil 06:37:20 INFO - building 'psutil._psutil_linux' extension 06:37:20 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 06:37:20 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 06:37:20 INFO - building 'psutil._psutil_posix' extension 06:37:20 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 06:37:20 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 06:37:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:37:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:37:20 INFO - Successfully installed psutil 06:37:20 INFO - Cleaning up... 06:37:20 INFO - Return code: 0 06:37:20 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:37:20 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')]} 06:37:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:37:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:20 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')]} 06:37:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:37:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:20 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 0x23bb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x251e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x267c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x267a3b0>, '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 0x267b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x267b740>, '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': '6dbc10da6d83fee962c624be000001a8-1468330623.740340-2115176594', '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 06:37:20 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 06:37:20 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 06:37:20 INFO - Using env: {'DISPLAY': ':0', 06:37:20 INFO - 'HOME': '/home/cltbld', 06:37:20 INFO - 'LANG': 'en_US.UTF-8', 06:37:20 INFO - 'LANGUAGE': 'en_US:en', 06:37:20 INFO - 'LOGNAME': 'cltbld', 06:37:20 INFO - 'MAIL': '/var/mail/cltbld', 06:37:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:37:20 INFO - 'MOZ_NO_REMOTE': '1', 06:37:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:37:20 INFO - 'NO_EM_RESTART': '1', 06:37:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:37:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:37:20 INFO - 'PWD': '/builds/slave/test', 06:37:20 INFO - 'SHELL': '/bin/bash', 06:37:20 INFO - 'SHLVL': '1', 06:37:20 INFO - 'TERM': 'linux', 06:37:20 INFO - 'TMOUT': '86400', 06:37:20 INFO - 'USER': 'cltbld', 06:37:20 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1468330623.740340-2115176594', 06:37:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:37:20 INFO - '_': '/tools/buildbot/bin/python'} 06:37:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:37:20 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:37:20 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 06:37:20 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 06:37:20 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 06:37:20 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 06:37:20 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 06:37:20 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 06:37:22 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:37:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:37:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:37:22 INFO - Installing collected packages: mozsystemmonitor 06:37:22 INFO - Running setup.py install for mozsystemmonitor 06:37:23 INFO - Successfully installed mozsystemmonitor 06:37:23 INFO - Cleaning up... 06:37:23 INFO - Return code: 0 06:37:23 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:37:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:37:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:37:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:37:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:37:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:23 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 0x23bb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x251e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x267c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x267a3b0>, '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 0x267b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x267b740>, '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': '6dbc10da6d83fee962c624be000001a8-1468330623.740340-2115176594', '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 06:37:23 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 06:37:23 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 06:37:23 INFO - Using env: {'DISPLAY': ':0', 06:37:23 INFO - 'HOME': '/home/cltbld', 06:37:23 INFO - 'LANG': 'en_US.UTF-8', 06:37:23 INFO - 'LANGUAGE': 'en_US:en', 06:37:23 INFO - 'LOGNAME': 'cltbld', 06:37:23 INFO - 'MAIL': '/var/mail/cltbld', 06:37:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:37:23 INFO - 'MOZ_NO_REMOTE': '1', 06:37:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:37:23 INFO - 'NO_EM_RESTART': '1', 06:37:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:37:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:37:23 INFO - 'PWD': '/builds/slave/test', 06:37:23 INFO - 'SHELL': '/bin/bash', 06:37:23 INFO - 'SHLVL': '1', 06:37:23 INFO - 'TERM': 'linux', 06:37:23 INFO - 'TMOUT': '86400', 06:37:23 INFO - 'USER': 'cltbld', 06:37:23 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1468330623.740340-2115176594', 06:37:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:37:23 INFO - '_': '/tools/buildbot/bin/python'} 06:37:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:37:23 INFO - Downloading/unpacking jsonschema==2.5.1 06:37:23 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 06:37:23 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 06:37:23 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 06:37:23 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 06:37:23 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 06:37:23 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 06:37:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:37:25 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:37:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:37:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:37:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:37:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:37:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:37:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:37:25 INFO - Downloading functools32-3.2.3-2.tar.gz 06:37:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:37:25 INFO - warning: no files found matching '*.txt' 06:37:25 INFO - no previously-included directories found matching 'build' 06:37:25 INFO - no previously-included directories found matching 'dist' 06:37:25 INFO - no previously-included directories found matching '.git*' 06:37:25 INFO - Installing collected packages: jsonschema, functools32 06:37:25 INFO - Running setup.py install for functools32 06:37:25 INFO - warning: no files found matching '*.txt' 06:37:25 INFO - no previously-included directories found matching 'build' 06:37:25 INFO - no previously-included directories found matching 'dist' 06:37:25 INFO - no previously-included directories found matching '.git*' 06:37:25 INFO - Successfully installed jsonschema functools32 06:37:25 INFO - Cleaning up... 06:37:25 INFO - Return code: 0 06:37:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:37: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')]} 06:37:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:37:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37: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')]} 06:37:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:37:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37: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', '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 0x23bb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x251e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x267c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x267a3b0>, '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 0x267b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x267b740>, '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': '6dbc10da6d83fee962c624be000001a8-1468330623.740340-2115176594', '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 06:37: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:37: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 blobuploader==1.2.4 06:37:25 INFO - Using env: {'DISPLAY': ':0', 06:37:25 INFO - 'HOME': '/home/cltbld', 06:37:25 INFO - 'LANG': 'en_US.UTF-8', 06:37:25 INFO - 'LANGUAGE': 'en_US:en', 06:37:25 INFO - 'LOGNAME': 'cltbld', 06:37:25 INFO - 'MAIL': '/var/mail/cltbld', 06:37:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:37:25 INFO - 'MOZ_NO_REMOTE': '1', 06:37:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:37:25 INFO - 'NO_EM_RESTART': '1', 06:37:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:37:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:37:25 INFO - 'PWD': '/builds/slave/test', 06:37:25 INFO - 'SHELL': '/bin/bash', 06:37:25 INFO - 'SHLVL': '1', 06:37:25 INFO - 'TERM': 'linux', 06:37:25 INFO - 'TMOUT': '86400', 06:37:25 INFO - 'USER': 'cltbld', 06:37:25 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1468330623.740340-2115176594', 06:37:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:37:25 INFO - '_': '/tools/buildbot/bin/python'} 06:37:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:37:26 INFO - Downloading/unpacking blobuploader==1.2.4 06:37: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 06:37: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 06:37: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 06:37: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 06:37: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 06:37: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 06:37:27 INFO - Downloading blobuploader-1.2.4.tar.gz 06:37:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:37:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:37: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 06:37: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 06:37: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 06:37: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 06:37: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 06:37: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 06:37:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:37:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:37: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 06:37: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 06:37: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 06:37: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 06:37: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 06:37: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 06:37:28 INFO - Downloading docopt-0.6.1.tar.gz 06:37:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:37:28 INFO - Installing collected packages: blobuploader, requests, docopt 06:37:28 INFO - Running setup.py install for blobuploader 06:37:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:37:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:37:28 INFO - Running setup.py install for requests 06:37:29 INFO - Running setup.py install for docopt 06:37:29 INFO - Successfully installed blobuploader requests docopt 06:37:29 INFO - Cleaning up... 06:37:29 INFO - Return code: 0 06:37:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:37:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:37:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:37:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:37:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:37:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:29 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 0x23bb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x251e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x267c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x267a3b0>, '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 0x267b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x267b740>, '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': '6dbc10da6d83fee962c624be000001a8-1468330623.740340-2115176594', '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 06:37:29 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 06:37:29 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 06:37:29 INFO - Using env: {'DISPLAY': ':0', 06:37:29 INFO - 'HOME': '/home/cltbld', 06:37:29 INFO - 'LANG': 'en_US.UTF-8', 06:37:29 INFO - 'LANGUAGE': 'en_US:en', 06:37:29 INFO - 'LOGNAME': 'cltbld', 06:37:29 INFO - 'MAIL': '/var/mail/cltbld', 06:37:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:37:29 INFO - 'MOZ_NO_REMOTE': '1', 06:37:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:37:29 INFO - 'NO_EM_RESTART': '1', 06:37:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:37:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:37:29 INFO - 'PWD': '/builds/slave/test', 06:37:29 INFO - 'SHELL': '/bin/bash', 06:37:29 INFO - 'SHLVL': '1', 06:37:29 INFO - 'TERM': 'linux', 06:37:29 INFO - 'TMOUT': '86400', 06:37:29 INFO - 'USER': 'cltbld', 06:37:29 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1468330623.740340-2115176594', 06:37:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:37:29 INFO - '_': '/tools/buildbot/bin/python'} 06:37:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:37:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:37:29 INFO - Running setup.py (path:/tmp/pip-oDRlUx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:37:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:37:29 INFO - Running setup.py (path:/tmp/pip-1rNAbn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:37:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:37:29 INFO - Running setup.py (path:/tmp/pip-a6eCUN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:37:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:37:29 INFO - Running setup.py (path:/tmp/pip-2uBbzB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:37:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:37:29 INFO - Running setup.py (path:/tmp/pip-eVrjPd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:37:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:37:29 INFO - Running setup.py (path:/tmp/pip-dcMzZI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:37:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:37:30 INFO - Running setup.py (path:/tmp/pip-k4VCiG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:37:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:37:30 INFO - Running setup.py (path:/tmp/pip-QaH3Cv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:37:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:37:30 INFO - Running setup.py (path:/tmp/pip-PdPEHa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:37:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:37:30 INFO - Running setup.py (path:/tmp/pip-NsOHZ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:37:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:37:30 INFO - Running setup.py (path:/tmp/pip-Yg0nDg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:37:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:37:30 INFO - Running setup.py (path:/tmp/pip-D7MY4q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:37:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:37:30 INFO - Running setup.py (path:/tmp/pip-eY07D9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:37:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:37:30 INFO - Running setup.py (path:/tmp/pip-wvC9DW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:37:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:37:30 INFO - Running setup.py (path:/tmp/pip-XtrGDD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:37:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:37:30 INFO - Running setup.py (path:/tmp/pip-Rtt0o2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:37:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:37:30 INFO - Running setup.py (path:/tmp/pip-iFAJL1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:37:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:37:30 INFO - Running setup.py install for manifestparser 06:37:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:37:30 INFO - Running setup.py install for mozcrash 06:37:31 INFO - Running setup.py install for mozdebug 06:37:31 INFO - Running setup.py install for mozdevice 06:37:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:37:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:37:31 INFO - Running setup.py install for mozfile 06:37:31 INFO - Running setup.py install for mozhttpd 06:37:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:37:31 INFO - Running setup.py install for mozinfo 06:37:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:37:31 INFO - Running setup.py install for mozInstall 06:37:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:37:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:37:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:37:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:37:31 INFO - Running setup.py install for mozleak 06:37:31 INFO - Running setup.py install for mozlog 06:37:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:37:31 INFO - Running setup.py install for moznetwork 06:37:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:37:31 INFO - Running setup.py install for mozprocess 06:37:32 INFO - Running setup.py install for mozprofile 06:37:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:37:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:37:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:37:32 INFO - Running setup.py install for mozrunner 06:37:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:37:32 INFO - Running setup.py install for mozscreenshot 06:37:32 INFO - Running setup.py install for moztest 06:37:32 INFO - Running setup.py install for mozversion 06:37:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:37:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:37:32 INFO - Cleaning up... 06:37:32 INFO - Return code: 0 06:37:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:37:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:37:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:37:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:37:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:37:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:32 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 0x23bb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x251e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x267c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x267a3b0>, '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 0x267b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x267b740>, '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': '6dbc10da6d83fee962c624be000001a8-1468330623.740340-2115176594', '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 06:37:32 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 06:37:32 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 06:37:32 INFO - Using env: {'DISPLAY': ':0', 06:37:32 INFO - 'HOME': '/home/cltbld', 06:37:32 INFO - 'LANG': 'en_US.UTF-8', 06:37:32 INFO - 'LANGUAGE': 'en_US:en', 06:37:32 INFO - 'LOGNAME': 'cltbld', 06:37:32 INFO - 'MAIL': '/var/mail/cltbld', 06:37:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:37:32 INFO - 'MOZ_NO_REMOTE': '1', 06:37:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:37:32 INFO - 'NO_EM_RESTART': '1', 06:37:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:37:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:37:32 INFO - 'PWD': '/builds/slave/test', 06:37:32 INFO - 'SHELL': '/bin/bash', 06:37:32 INFO - 'SHLVL': '1', 06:37:32 INFO - 'TERM': 'linux', 06:37:32 INFO - 'TMOUT': '86400', 06:37:32 INFO - 'USER': 'cltbld', 06:37:32 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1468330623.740340-2115176594', 06:37:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:37:32 INFO - '_': '/tools/buildbot/bin/python'} 06:37:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:37:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:37:32 INFO - Running setup.py (path:/tmp/pip-Pbjy6r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:37:32 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)) 06:37:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:37:32 INFO - Running setup.py (path:/tmp/pip-VRQc1a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:37:32 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)) 06:37:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:37:32 INFO - Running setup.py (path:/tmp/pip-1mmyql-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:37:33 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)) 06:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:37:33 INFO - Running setup.py (path:/tmp/pip-5b1ChL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:37:33 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)) 06:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:37:33 INFO - Running setup.py (path:/tmp/pip-doiTLa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:37:33 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)) 06:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:37:33 INFO - Running setup.py (path:/tmp/pip-2Z9032-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:37:33 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)) 06:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:37:33 INFO - Running setup.py (path:/tmp/pip-aFspMi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:37:33 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)) 06:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:37:33 INFO - Running setup.py (path:/tmp/pip-s1V32P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:37:33 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)) 06:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:37:33 INFO - Running setup.py (path:/tmp/pip-fAEphZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:37:33 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)) 06:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:37:33 INFO - Running setup.py (path:/tmp/pip-DOKZAW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:37:33 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)) 06:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:37:33 INFO - Running setup.py (path:/tmp/pip-pe_IEO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:37:33 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)) 06:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:37:33 INFO - Running setup.py (path:/tmp/pip-b6U3LL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:37:33 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)) 06:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:37:33 INFO - Running setup.py (path:/tmp/pip-gW5qaR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:37:33 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)) 06:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:37:33 INFO - Running setup.py (path:/tmp/pip-wRwwMB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:37:33 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)) 06:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:37:33 INFO - Running setup.py (path:/tmp/pip-AZKHVp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:37:33 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)) 06:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:37:33 INFO - Running setup.py (path:/tmp/pip-D1rcsL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:37:34 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)) 06:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:37:34 INFO - Running setup.py (path:/tmp/pip-yj2lzy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:37:34 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)) 06:37:34 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)) 06:37:34 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)) 06:37:34 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)) 06:37:34 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)) 06:37:34 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)) 06:37:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:37:34 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 06:37:34 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 06:37:34 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 06:37:34 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 06:37:34 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 06:37:34 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 06:37:35 INFO - Downloading blessings-1.6.tar.gz 06:37:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:37:36 INFO - Installing collected packages: blessings 06:37:36 INFO - Running setup.py install for blessings 06:37:36 INFO - Successfully installed blessings 06:37:36 INFO - Cleaning up... 06:37:36 INFO - Return code: 0 06:37:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:37:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:37:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:37:36 INFO - Reading from file tmpfile_stdout 06:37:36 INFO - Current package versions: 06:37:36 INFO - argparse == 1.2.1 06:37:36 INFO - blessings == 1.6 06:37:36 INFO - blobuploader == 1.2.4 06:37:36 INFO - docopt == 0.6.1 06:37:36 INFO - functools32 == 3.2.3-2 06:37:36 INFO - jsonschema == 2.5.1 06:37:36 INFO - manifestparser == 1.1 06:37:36 INFO - mozInstall == 1.12 06:37:36 INFO - mozcrash == 0.17 06:37:36 INFO - mozdebug == 0.1 06:37:36 INFO - mozdevice == 0.48 06:37:36 INFO - mozfile == 1.2 06:37:36 INFO - mozhttpd == 0.7 06:37:36 INFO - mozinfo == 0.9 06:37:36 INFO - mozleak == 0.1 06:37:36 INFO - mozlog == 3.2 06:37:36 INFO - moznetwork == 0.27 06:37:36 INFO - mozprocess == 0.23 06:37:36 INFO - mozprofile == 0.28 06:37:36 INFO - mozrunner == 6.12 06:37:36 INFO - mozscreenshot == 0.1 06:37:36 INFO - mozsystemmonitor == 0.3 06:37:36 INFO - moztest == 0.7 06:37:36 INFO - mozversion == 1.4 06:37:36 INFO - psutil == 3.1.1 06:37:36 INFO - requests == 1.2.3 06:37:36 INFO - wsgiref == 0.1.2 06:37:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:37:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:37:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:37:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:37:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:37:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:36 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 0x23bb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x251e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x267c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x267a3b0>, '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 0x267b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x267b740>, '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': '6dbc10da6d83fee962c624be000001a8-1468330623.740340-2115176594', '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 06:37:36 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 06:37:36 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 06:37:36 INFO - Using env: {'DISPLAY': ':0', 06:37:36 INFO - 'HOME': '/home/cltbld', 06:37:36 INFO - 'LANG': 'en_US.UTF-8', 06:37:36 INFO - 'LANGUAGE': 'en_US:en', 06:37:36 INFO - 'LOGNAME': 'cltbld', 06:37:36 INFO - 'MAIL': '/var/mail/cltbld', 06:37:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:37:36 INFO - 'MOZ_NO_REMOTE': '1', 06:37:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:37:36 INFO - 'NO_EM_RESTART': '1', 06:37:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:37:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:37:36 INFO - 'PWD': '/builds/slave/test', 06:37:36 INFO - 'SHELL': '/bin/bash', 06:37:36 INFO - 'SHLVL': '1', 06:37:36 INFO - 'TERM': 'linux', 06:37:36 INFO - 'TMOUT': '86400', 06:37:36 INFO - 'USER': 'cltbld', 06:37:36 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1468330623.740340-2115176594', 06:37:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:37:36 INFO - '_': '/tools/buildbot/bin/python'} 06:37:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:37:36 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)) 06:37:36 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)) 06:37:36 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)) 06:37:36 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)) 06:37:36 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)) 06:37:36 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)) 06:37:36 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)) 06:37:36 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)) 06:37:36 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)) 06:37:36 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)) 06:37:36 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)) 06:37:36 INFO - Cleaning up... 06:37:36 INFO - Return code: 0 06:37:36 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:37:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:37:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:37:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:37:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:37:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23bb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x251e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x267c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x267a3b0>, '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 0x267b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x267b740>, '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': '6dbc10da6d83fee962c624be000001a8-1468330623.740340-2115176594', '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 06:37:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 06:37:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:37:36 INFO - Using env: {'DISPLAY': ':0', 06:37:36 INFO - 'HOME': '/home/cltbld', 06:37:36 INFO - 'LANG': 'en_US.UTF-8', 06:37:36 INFO - 'LANGUAGE': 'en_US:en', 06:37:36 INFO - 'LOGNAME': 'cltbld', 06:37:36 INFO - 'MAIL': '/var/mail/cltbld', 06:37:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:37:36 INFO - 'MOZ_NO_REMOTE': '1', 06:37:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:37:36 INFO - 'NO_EM_RESTART': '1', 06:37:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:37:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:37:36 INFO - 'PWD': '/builds/slave/test', 06:37:36 INFO - 'SHELL': '/bin/bash', 06:37:36 INFO - 'SHLVL': '1', 06:37:36 INFO - 'TERM': 'linux', 06:37:36 INFO - 'TMOUT': '86400', 06:37:36 INFO - 'USER': 'cltbld', 06:37:36 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1468330623.740340-2115176594', 06:37:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:37:36 INFO - '_': '/tools/buildbot/bin/python'} 06:37:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:37:36 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:37:36 INFO - Cleaning up... 06:37:36 INFO - Return code: 0 06:37:36 INFO - Running post-action listener: _resource_record_post_action 06:37:36 INFO - Running post-action listener: _start_resource_monitoring 06:37:36 INFO - Starting resource monitoring. 06:37:36 INFO - ##### 06:37:36 INFO - ##### Finished create-virtualenv step (success) 06:37:36 INFO - ##### 06:37:36 INFO - ##### 06:37:36 INFO - ##### Running install step. 06:37:36 INFO - ##### 06:37:36 INFO - Running pre-action listener: _resource_record_pre_action 06:37:36 INFO - Running main action method: install 06:37:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:37:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:37:37 INFO - Reading from file tmpfile_stdout 06:37:37 INFO - Detecting whether we're running mozinstall >=1.0... 06:37:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:37:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:37:37 INFO - Reading from file tmpfile_stdout 06:37:37 INFO - Output received: 06:37:37 INFO - Usage: mozinstall [options] installer 06:37:37 INFO - Options: 06:37:37 INFO - -h, --help show this help message and exit 06:37:37 INFO - -d DEST, --destination=DEST 06:37:37 INFO - Directory to install application into. [default: 06:37:37 INFO - "/builds/slave/test"] 06:37:37 INFO - --app=APP Application being installed. [default: firefox] 06:37:37 INFO - mkdir: /builds/slave/test/build/application 06:37:37 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'] 06:37:37 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 06:37:54 INFO - Reading from file tmpfile_stdout 06:37:54 INFO - Output received: 06:37:54 INFO - /builds/slave/test/build/application/firefox/firefox 06:37:54 INFO - Running post-action listener: _resource_record_post_action 06:37:54 INFO - ##### 06:37:54 INFO - ##### Finished install step (success) 06:37:54 INFO - ##### 06:37:54 INFO - ##### 06:37:54 INFO - ##### Running run-tests step. 06:37:54 INFO - ##### 06:37:54 INFO - Running pre-action listener: _resource_record_pre_action 06:37:54 INFO - Running main action method: run_tests 06:37:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:37:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:37:54 INFO - Python 2.7.3 06:37:54 INFO - Return code: 0 06:37:54 INFO - grabbing minidump binary from tooltool 06:37:54 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')]} 06:37:54 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 0x267a3b0>, '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 0x267b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x267b740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:37:54 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 06:37:54 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 06:37:54 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 06:37:54 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:37:54 INFO - Return code: 0 06:37:54 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:37:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:37:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:37:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:37:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:37:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QjTOXqtgQ26IGcj4GJ4Tqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--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 06:37:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/QjTOXqtgQ26IGcj4GJ4Tqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-050 --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 06:37:54 INFO - Using env: {'DISPLAY': ':0', 06:37:54 INFO - 'HOME': '/home/cltbld', 06:37:54 INFO - 'LANG': 'en_US.UTF-8', 06:37:54 INFO - 'LANGUAGE': 'en_US:en', 06:37:54 INFO - 'LOGNAME': 'cltbld', 06:37:54 INFO - 'MAIL': '/var/mail/cltbld', 06:37:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:37:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:37:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:37:54 INFO - 'MOZ_NO_REMOTE': '1', 06:37:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:37:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:37:54 INFO - 'NO_EM_RESTART': '1', 06:37:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:37:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:37:54 INFO - 'PWD': '/builds/slave/test', 06:37:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:37:54 INFO - 'SHELL': '/bin/bash', 06:37:54 INFO - 'SHLVL': '1', 06:37:54 INFO - 'TERM': 'linux', 06:37:54 INFO - 'TMOUT': '86400', 06:37:54 INFO - 'USER': 'cltbld', 06:37:54 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1468330623.740340-2115176594', 06:37:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:37:54 INFO - '_': '/tools/buildbot/bin/python'} 06:37:54 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QjTOXqtgQ26IGcj4GJ4Tqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--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 06:37:54 INFO - mozversion application_buildid: 20160712033410 06:37:54 INFO - mozversion application_changeset: 173d493da6f57a15facef6dbf18f4be49e1c6bb4 06:37:54 INFO - mozversion application_display_name: Nightly 06:37:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:37:54 INFO - mozversion application_name: Firefox 06:37:54 INFO - mozversion application_remotingname: firefox 06:37:54 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 06:37:54 INFO - mozversion application_vendor: Mozilla 06:37:54 INFO - mozversion application_version: 50.0a1 06:37:54 INFO - mozversion platform_buildid: 20160712033410 06:37:54 INFO - mozversion platform_changeset: 173d493da6f57a15facef6dbf18f4be49e1c6bb4 06:37:54 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 06:37:54 INFO - mozversion platform_version: 50.0a1 06:37:54 INFO - using testdate: 1468330674 06:37:54 INFO - actual date: 1468330674 06:37:54 INFO - starting webserver on 'localhost:35459' 06:37:54 INFO - SUITE-START | Running 2 tests 06:37:54 INFO - TEST-START | dromaeo_css 06:37:54 INFO - operating with platform_type : linux_ 06:37:54 INFO - Initialising browser for dromaeo_css test... 06:37:54 INFO - TEST-INFO | started process 5375 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpILz7EJ/profile http://localhost:35459/getInfo.html) 06:37:59 INFO - PROCESS | 5375 | __metrics Screen width/height:1600/1200 06:37:59 INFO - PROCESS | 5375 | colorDepth:24 06:37:59 INFO - PROCESS | 5375 | Browser inner width/height: 1024/697 06:37:59 INFO - PROCESS | 5375 | __metrics 06:38:00 INFO - PROCESS | 5375 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:38:00 INFO - PROCESS | 5375 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:38:01 INFO - TEST-INFO | 5375: exit 0 06:38:01 INFO - Browser initialized. 06:38:01 INFO - Running cycle 1/1 for dromaeo_css test... 06:38:01 INFO - TEST-INFO | started process 5458 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpILz7EJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:38:13 INFO - PROCESS | 5458 | RSS: Main: 157569024 06:38:13 INFO - PROCESS | 5458 | 06:39:04 INFO - PROCESS | 5458 | 1468330744709 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] 06:41:12 INFO - PROCESS | 5458 | Cycle 1(1): loaded http://localhost:35459/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35459/tests/dromaeo/cssquery-ext.html) 06:41:13 INFO - PROCESS | 5458 | RSS: Main: 289722368 06:41:13 INFO - PROCESS | 5458 | 06:44:16 INFO - PROCESS | 5458 | Cycle 1(1): loaded http://localhost:35459/tests/dromaeo/cssquery-ext.html (next: http://localhost:35459/tests/dromaeo/cssquery-jquery.html) 06:44:16 INFO - PROCESS | 5458 | RSS: Main: 238383104 06:44:16 INFO - PROCESS | 5458 | 06:47:19 INFO - PROCESS | 5458 | Cycle 1(1): loaded http://localhost:35459/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35459/tests/dromaeo/cssquery-mootools.html) 06:47:19 INFO - PROCESS | 5458 | RSS: Main: 247603200 06:47:19 INFO - PROCESS | 5458 | 06:50:21 INFO - PROCESS | 5458 | Cycle 1(1): loaded http://localhost:35459/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35459/tests/dromaeo/cssquery-prototype.html) 06:50:22 INFO - PROCESS | 5458 | RSS: Main: 235319296 06:50:22 INFO - PROCESS | 5458 | 06:53:24 INFO - PROCESS | 5458 | Cycle 1(1): loaded http://localhost:35459/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35459/tests/dromaeo/cssquery-yui.html) 06:53:25 INFO - PROCESS | 5458 | RSS: Main: 208617472 06:53:25 INFO - PROCESS | 5458 | 06:56:28 INFO - PROCESS | 5458 | Cycle 1(1): loaded http://localhost:35459/tests/dromaeo/cssquery-yui.html (next: http://localhost:35459/tests/dromaeo/cssquery-dojo.html) 06:56:28 INFO - PROCESS | 5458 | RSS: Main: 273575936 06:56:28 INFO - PROCESS | 5458 | 06:56:28 INFO - PROCESS | 5458 | __start_tp_report 06:56:28 INFO - PROCESS | 5458 | _x_x_mozilla_page_load 06:56:28 INFO - PROCESS | 5458 | _x_x_mozilla_page_load_details 06:56:28 INFO - PROCESS | 5458 | |i|pagename|runs| 06:56:28 INFO - PROCESS | 5458 | |0;dojo.html;3053.480908245598;3054.1906394805364;3100.5349197620367;3102.7362674172687;3117.298607813242;5254.080535906221;5331.57347412207;5335.759890804913;5407.594430417715;5463.344398672155;5335.306410166673;5367.114426119686;5399.19012148178;5417.26866872972;5435.211894275328;4874.853754387365;4935.383077115361;4965.702057876539;4977.228529577903;5074.923876141843;4963.528464795839;4976.776045077962;5022.221555658879;5034.320366750497;5041.924371134436;4791.952080479203;4812.879678008043;4820.734859582722;4845;4870.269459581055;4862.270659401082;4863;4869.196582563873;4884.389451318585;4984.601231901439;4853.126437241295;4887.3890763654545;4897.534734200245;4903.436104847917;4960.578350840183;5238.607104467142;5340.145576707708;5402.459754024605;5414.458554144554;5415.512603865671;5841.591088623798;5848.5321174305955;5905.320888097881;5911.231539899829;5914.349421563625;5884.499817515516;5899.144624029492;5938.703064846741;5949.583529152961;5956.702164891738;5285.286486324336;5341.759620817073;5388.407275199725;5397.46025397461;5478.534324582375;5953.613015154001;5958.791442299499;5959.672218027963;5961.463468287875;5967.283925928829;5734.971325143348;5743.282089738783;5747.798827041033;5748.252727145445;5756.395578464285;5628.605997580212;5690.146478028246;5744;5749.195112684228;5810.389909059572;5741.971290143522;5751.626144300607;5754.136879468113;5760.53915686744;5806.390329015392;5694.202811606378;5701.828945131652;5708.828735137952;5757.165211044375;5764.7117644117625;4260.55264197261;4293.97853010733;4300.591443812833;4344.500382456058;4349.782510874507;3868.168343806095;3873.6320049595242;3884.708646851441;3906.90232744178;3914.3345631242755;5400.378956419983;5406.486383793534;5409.5672346213;5410.594205434608;5413.404525502192;5571;5607.859803504945;5660.915086273709;5672.290963629546;5674.432556744375;5309.814156504503;5340.279062326614;5344.706041167773;5349.090654588729;5353.866153346197;4860.1008813368935;4944.660054621177;4950.752462376867;4957.529034741694;5003.474635163256;5933.317668468095;5950.285965684146;5982.4914882234625;5993.970030149909;6016.428439298172;5846.386129456346;5852.502537284378;5854.034084376201;5854.180414741854;5859.062549991981;5813.563982701399;5873.324567674772;5987.5808693391045;6018.819435416769;6031.517478601789;5686.118651609007;5704.629199102045;5710.771569137188;5718.0565206742085;5770.567207459373;5757.222774925499;5787.421257874347;5793.36273009977;5795.942040579709;5796.21751063601;5461.481159289861;5562.527185189304;5598.524125449382;5676.4323567642905;5678.261825962599;5555.527780138572;5597.272354593877;5601.579881508822;5609.186667933209;5655.406182350794;5536.086545719912;5541.556675465872;5546.084895992116;5561.555075594024;5573.191887176417;5507.917381239205;5548.861278467909;5568.721563921868;5660.971695141663;5663.773449061991;5412.648177868584;5482.342118945752;5486.670799752028;5488.396276409671;5499.422560631237 06:56:28 INFO - PROCESS | 5458 | |1;ext.html;581.566732784076;609.3358239518925;628.1770880147006;644.5101722690754;646.7639311651249;42359;43933.121337573226;44043.77978110113;47431.762841185744;47522.524774752244;45105.54894451055;45686.771566142124;45712.54287457124;45741;45844.541554584444;8905.154010369004;9049.321300902426;9055.637774489012;9058;9062.818743625123;8973.416727912698;8997;9056.637734490612;9061.909380906172;9065.093490650948;9043.186113249807;9078.818423631556;9080.00119986801;9085.454872707625;9091.954540227289;8966.327525435554;8981.056989016157;9010.684626038123;9022.954885225598;9027.864582031307;8860.955695221483;8963;8963.596638151233;8973.10268973104;9002.909970900339;41378.1724365514;41647;41678.583214167775;41735;41795.791021045006;3519.771214871025;3557.7153827693983;3561.3055454186183;3630.6913912317223;3964.949288438566;32773.18067048319;33038.50442243368;33067.503987439966;33192.83403582966;33951.15122121942;4358.629516491102;4412.713173643735;4462.553744625544;4487;4528.411306530163;352869;353320;354737;355661;355711;49232.261516077284;53890.46109538933;57167;57447.42552574504;57490.712546437;55307.72346138243;58965;60032.39967600268;60051.39948600545;60072;15390.230488475532;15400.768988465183;15411.383544658313;15428.38286468551;15510.767338489932;10898.673039808818;11158.274712143684;11167.609133680282;11174.720631984266;11657.88342116568;15356;15468.149251791034;15547.222638868012;15627.921860390852;15889.284982175599;6249.281332646713;6287.245530536365;6304.495640348761;6371.331010243857;6397.39224773655;973.3624475968111;975.3660120921458;1068.5939343049592;1073.2058276875057;1074.7801245586315;32400.189995250308;32697.673023269937;32794.3441131176;32872.671273286964;33036.834815825765;1133.7562424078699;1144.1533265383557;1148.9138314626437;1162.1458228202264;1168.2523185161504;16831.158442077845;17147.71392145594;17185.828141718423;17202.053887036083;17222.224999875034;546725;558974;560317;561730;562479;56266.43733562612;57780.422195778345;57795.42204577901;57881.710591446776;58145;1240.4851986425533;1321.9471221151045;1328.0637150808657;1328.8139660447546;1340.3901224942822;32725.50911736278;35334.76328328599;35416.29167416689;35525.644743552235;35591.28817423689;53742.73128634332;55480.16779748226;55818;60328.39671603228;60477;511905;520173;522059;522753;523745;24683.753162468147;25205;25224.621630675923;26649.33376665599;45328.32007519824;47830.521694782605;48388;51792.741036294574;52570;53267.46732532625;41559.58440415557;45019.09961800811;45204.321935171654;45266.54733452755;45705.085898282516;43306.91732706707;44118.23527058882;44155.337669934335;45419.318710218715;45647.54352456433;43475.347869782614;44161.33757993697;44588.777056114515;45051.549484506046;45143.0971380564;38556.22887542177;38784.22431551297;39276.80361598288;39539;40269.59730402658;29523.01439305752;29778.676038669364;30036.399272014;30232;30528.236794080327 06:56:28 INFO - PROCESS | 5458 | |2;jquery.html;384.9769013859167;393.3097414038364;396.49050969504185;400.23155541360586;414.8983499042733;14760.483383081595;18860.245590176393;19022.334218302363;20218.89890550547;20226.190952361907;16455.177241137924;18937;19736.309229176983;19793.901030494828;20639.071241794118;5821.476067153966;6015.939840601582;6018.458338749511;6023.247094113236;6026.9095963560585;4287.5498072702385;5947.078202878539;6042.244719410074;6411.262704788963;6749.628770417625;6775.898361524581;6796.524243302971;6808.21705503866;6819.045333653293;6824.215215250235;6458.354164583551;6737.764178253738;6745.224299205605;6746.325367463263;6748.966255168717;5715.2855893013375;5902.940970590282;5921.61509501881;5924.081767326072;5955.34491205967;20592.485187870272;20736.792632073637;21002;23589.410264743346;24099.277021689377;2537.289558923486;2553.4893021395796;2587.9648140743666;2653.2570880153394;2857.8142420742583;14541.854581454156;15400.3839846406;15657.295421705936;15795.921020394939;15881.812538795779;1965.4496740912568;2013.7784843667184;2047.7952204779551;2062.3812856143095;2130.4371565712463;84161.15838841656;84869.57565212135;85894;86880.13119868784;86950.56524717336;10186.185105191567;10567.101796347242;10660.946695266473;10741.248112632196;10850.67447976562;14521.927390363191;14601.415943362359;14620.488282910048;14658.413663453342;14663.34014969329;7715.729949451742;8026.675598526294;8054.395920306;8136.7152149674475;8150.551719655357;6696.1629796275465;7845.490043147177;7956.164602716747;8134.633941472648;8162.632681529345;4549.476810166873;4657.371254880615;4720.95279047212;4815.398075240595;4878.0975519529;1934.2746470073723;1944.348643204514;1944.562473443464;1973.4671638657483;1998.7501562304712;888.760034790603;953.7424895278375;976.584951395654;996.6860438961849;1025.1388833379847;20643.896780516003;20913.686294705592;20914.163433462796;20960.161593536086;21044.894775526023;990.5542505872386;1001.8647482589903;1004.3271008424373;1011.7066050845319;1067.7330667333167;11076.280041797258;11728.683945872113;11793.174477786473;11827.704307392383;11843.763124737628;458363;465984;468666;472305;472359;77667.61166194132;95890.5205473982;96566;96595.75531835141;97503.51248243856;993.9006099390148;996.835522138839;1011.4285428732743;1015.1016350529834;1019.5666841592293;18308.542286442946;18405.263789448807;18796.718049229;18802.623947521246;18855.340063097727;35607.10982225465;43067.7846610765;43943.92392532492;45820.083598328514;45919;61084;61364.69317653383;62206;63315.366846330944;63540.68229659007;8850.778730531789;9014.368994170607;9020.954895225483;9086.545672716205;9255.953720231355;12180.208286461351;13793.24137172465;13880.93059534696;14073.155610663393;14090.36593353281;11945.223560468541;12338.753224935272;12374.381280936097;12574.874251257736;12750.42623081945;11914.76170476603;12013;12030.939845300718;12101.213421127599;12163.331016793807;12674.556390526288;12724.491020359083;12809.935950320189;12854.614361569167;12976.675583110498;8856.512891791013;8865.734027979172;9093.863592045993;12257.816132757838;13094.607161785161;11449.255798373079;12734.554290599785;12947.482100715866;13244;13283.667908301983 06:56:28 INFO - PROCESS | 5458 | |3;mootools.html;1332.5469340424254;1442.9567112986608;1499.9625009374765;1594.7607858821182;1766.7791526059234;8190.8361832763385;8554.315654747621;8561.1866872647;8725.694600688978;8754;8465.78835529112;8624.741257762262;8635.266002389804;8656.17766312201;8662.91337086629;2326.2904814031754;2375.061850569024;2378.5124049569795;2378.8096952243777;2379.048380647746;2289.164454973931;2339.497008143249;2360.598698221298;2366.95266094678;2371.0752806405517;2339.0526836631193;2340.6840076589615;2352.752960939102;2377.869217193054;2380.2264264114146;2276.760940101282;2303.976960230393;2310.202979971907;2311.2026350908995;2318.4435735423376;2282.954340913189;2286.542691461714;2288.1305104060516;2291.8281128915396;2294.472271377576;8579;8608.741737747878;8638;8889.4666320021;9179.403338783024;5319.069162896478;5427.185922111676;5428.104362780136;5429.348478182644;5437.564994800407;3495.860165593373;3497.7026952708798;3562.6793588576893;3567.839447224881;3615.222727113683;1122.966311010671;1124.2299025167786;1128.091886031744;1144.2619510415818;1146.9483873225724;12520.436580353815;12581.559645412366;12586.81119783204;12606.68483287916;12620;4358.128374325148;4476.977615111904;4575.931361029588;4603.562661547147;4610.97694511532;9807.362521436227;9814.067663572092;9820.950895245478;9830.262730295257;9847.212223022141;5282.894342113136;5285.127953887565;5286.762095705702;5287.154055351125;5294.549963253166;4327.545607711208;4750.7862146202815;4955.157623204064;4963.8014479421145;4976.353074100416;3748.737588368788;3773.584905660375;3809.104860357814;3842.558105817811;3861.420786881934;1150.3098141115263;1196.0610920427423;1200.0699457920007;1207.6980754811298;1214.623466725318;701.4248316380518;930.6324002019164;964.7154089543601;982.651158838602;993.7118235711563;6091.725872335755;6222.160008398899;6277.121203031579;6412.198475190601;6419;468.97655117244;469.9342092107108;488.9706617602955;507.53814029233223;519.6128883981459;4076.2458945095254;4322.5677432256525;4343;4343.587359200871;4438.955610443919;10874.72813179661;11340.716482088013;11365.54537818478;11415.714607134889;11440.027597654293;10571.894281057092;10693.465326733787;10717.35695858251;11249.71875703114;11263.549458021587;8245.587720613945;8468.364872634455;8469.153084691481;8491.61787719554;8516.701915433054;6081.179040829431;6513.967430163008;6568;6591.406773390418;6624.138861948109;10192.388456692623;10380.896191038295;10464.424456654957;10590.099841513558;10764.677059688222;10722.624708135178;10831.837522437327;10842.837357439486;10894.128469722562;10954.123670106532;7194.172670143001;7684.231576842271;7853.842923141391;7861.567613781297;7935.444518883854;8831.69089081879;8838.513881736566;8893.822123557622;8905.821883562423;8925.687600933936;7809;7893.881591776243;7961.72133975308;7972.083210430643;8033.5326486422155;7748.418868584766;7809.882851757115;7848.803779905548;7934.087579928382;7947.284744373034;6682.131322927989;7258.12902451688;7296.270372962661;7314.524555903849;7328.3404493595835;5472.507474327171;5507.091329930517;5529.032419326521;5547.833564993057;5589.273394458694;5345.583420393521;5374.677519348852;5483.067878460592;5492.91760623583;5631.549476041989 06:56:28 INFO - PROCESS | 5458 | |4;prototype.html;331.78268234306523;332.715528223369;338.66810525684815;339.24856442978796;339.5772263531902;5379.3813711423145;5398.730063496829;5400.972995135024;5422.457754224575;5426.945730542693;5235.424103348629;5266.236395722618;5293.417724050361;5304;5314.840554783363;3766.9434958475645;4002.3596224604;4016.9397459038137;4107.876763697094;4143.544210136883;4132.5454200037975;4166.312558427856;4167.708260421772;4179.937300940488;4180.268453020724;4154.6676265898805;4154.896127596804;4159.729617574863;4175.206710724968;4204.0540878302445;3992.7803970781597;4101.630853223194;4168.749875007494;4175.812088456027;4194.748315101104;3702.9259414811822;3704.6480584344445;3710.5139556496943;3714.4428335749585;3738.5139931808963;5129.487051294841;5137.409197942247;5138.177891537373;5171.637985341028;5172.2241663750365;4766.547178018082;4784.617230621577;4786.928196077061;4814.446338671028;4828.372311599504;5580.302462192226;5590.524805391547;5594.804181853657;5600.971995139998;5604.551635869121;3882.669973052294;3894.3768996960353;3996.0409501719378;4061.086255592468;4078.143589846136;5636.844446888378;5687.3743888172685;5725.942740572625;5732.484076433099;5738.7991420300505;4152.1695660867945;4153.899216707575;4159.708820382544;4182.874513764592;4205.726627769185;4159.854405095807;4176.2877220339515;4176.7076304658385;4224.556421575752;4228.640565551963;4745.691530050535;4750.168720473903;4756.6908150970075;4762.880927976828;4802.303665968415;5526.696031718214;5534.916976245359;5559.6664200148125;5592.636478628876;5592.909382670422;1341.610932829488;1398.5804258722546;1405.444849284527;1408.6689627937426;1426.3937826423728;900.9549522523847;914.1726737302752;918.1415376622746;919.3794188922451;946.7017889364828;4640.396748422683;4733.928991065137;4766.285057241442;4773.9045219096115;4802.519748025239;4948.529889660476;4961.950380496221;5018.447970723218;5020.067274099425;5052.823151189691;4482.618977386894;4747;4788.640851936118;4809.907690154794;4810.807567697253;2741.575055866344;2742.9576760831155;2743;2749.8350098994124;2759.6274502941847;5293.788248470095;5321.813736519203;5321.946780532146;5329.241350354374;5330.7068111253475;4780.47024952012;5069.847904562869;5098.954714283563;5155.871103222375;5173.948260517422;5126.538611525055;5157.916837464099;5163.277141200235;5177;5191.961607678555;5032.245163225399;5059.822906198266;5460.972695136499;5469.562435005269;5697.4587414195585;5543.61194716366;5593.300837395325;5607.495325420732;5616.550675945833;5643.435656434323;5654.886902261849;5762.279715035621;5766.826995190151;5795.710214489343;5808.07070868659;4055.655269302142;4076.775777332275;4079.5925405734974;4102.502586555826;4105.137921036616;5677.659340439587;5686.4029276926985;5697.658140511582;5742.59801813869;5771.249737534094;5316.3354580677415;5616;5616.297962754656;5621.357961757967;5629.746661400165;5543.417941116286;5561.165825126263;5567.7494512747835;5572.554195664418;5583.302087239095;5519.530839878656;5523.861903452445;5528.502434780728;5555.694436806015;5556.388797232382;5345.33183352081;5587.161925711176;5594.804181853616;5605.495505404533;5606.803761868315;5425.701586412785;5438.401775804738;5444.972775136099;5449.891002180014;5456.290682211287 06:56:28 INFO - PROCESS | 5458 | |5;yui.html;747.0624366420144;796.6494742313382;819.5574389829493;823.950562966222;833.1668331668332;15502.612434689125;16863.57841053973;16868.072256025913;16878.240479178436;16906.323747050134;15235.619109522268;15272.69454610907;15366.231688415563;15423.768643470328;15452.5364239073;660.7951535024134;774.9496282741632;783.5651213576463;785.2618538573751;795.1809636074838;815.955122468267;825.3644693585935;826.0252901576138;826.4834478450969;826.68999125328;870.4559650218613;871.9912800871973;877.3025444771422;878.3412440669498;878.5607196401799;704.7568588836868;832.0556168748453;859.8151397449516;870.7735988642967;871.0766587417327;616.094341318266;616.901295792671;621.2141640824361;621.6208113051035;621.6705146272437;15894.602634934103;15906.443274485453;15916.602084947968;15924.283407246587;15936.203189840462;15649.608759780982;15703.371865125382;15757.32188361788;15971.92014039934;16031;12796.680082997906;12864.22814631125;12907.870921290854;12929.612111636667;12950.611481655566;3860.903477413059;4008.158286759784;4008.6793056555407;4095.5290141633795;4115.814788334532;79186;79587.20412795855;80663;81322.59338703328;82112.58943705303;11989.580364687194;12152.027837772957;12212.938935305267;12252.387380630933;12602.81095783564;23454.882725586263;23463.76536234616;23468.714379986817;23474;23479.882600586887;8755.605997730117;9001.414908030956;9041.095890411038;9292.581833817494;9324.25405967521;4818.4217893852265;4978.327925730053;5025.723585202849;5037.596992240612;5093.4651861554;3585.4263317869018;3707.073231692077;3711.6102809205186;3714.591394946554;3717.665410113103;655.7311502284041;659.8977158540434;665.7337065173872;667.1960287853125;683.8222062263748;633.4457349818908;684.1140722764032;727.4653129949482;729.2051663686607;752.5597525447674;10034.247431442525;10163.542640581192;10338.793224135476;10445.373277603216;10531.631392901212;681.3322943515383;756.6746299091443;789.8420315936836;790.2887401338841;801.8837268596137;4892;5217.2695822584865;5307.7080760557765;5308.283381743415;5391.892162156735;105168;113459;114742.42628786803;118279.40860295644;119396;101846.49076754569;102626;104314;104331.4783426078;105946.47026764817;89096.10903891007;89183;89712.5514372424;91778.54110729403;91805;10377.533011014371;10429.68710938673;10475.528601213116;10494.68515944523;10556;52008.219876702635;52429.95140097253;52621.7368913153;53155.747540197466;54378.45621543734;73419.63290183515;80853.74450660688;81222;81258.59370703109;81739.5913020431;12903.354832258161;12953.546625868426;12985.285724919677;13995.440182392998;14245.21651309188;15552.222388880284;15727.842721573095;15851.841481585498;15891.125988070306;15908.920455397649;9873.901260987586;12537.435815388148;13109.934450327688;13414.993875459184;13837.238951857744;14381.715101296253;14450.205238711971;14450.494232701805;15254.847451525786;15359.539213823604;9510.625173633005;13472.259025753678;14710.338034788674;14763.114213147246;14931.701365972402;12234;12367.196132251374;12438.19151755133;12504.249745015328;12853.550125745554;12793;12875.613731588068;13090.803637945248;13198.868011319764;13227.404766785325 06:56:28 INFO - PROCESS | 5458 | __end_tp_report 06:56:28 INFO - PROCESS | 5458 | __start_cc_report 06:56:28 INFO - PROCESS | 5458 | _x_x_mozilla_cycle_collect,1066 06:56:28 INFO - PROCESS | 5458 | __end_cc_report 06:56:28 INFO - PROCESS | 5458 | __startTimestamp1468331788378__endTimestamp 06:56:28 INFO - PROCESS | 5458 | 06:56:28 INFO - PROCESS | 5458 | ------- Summary: start ------- 06:56:28 INFO - PROCESS | 5458 | Number of tests: 6 06:56:28 INFO - PROCESS | 5458 | 06:56:28 INFO - PROCESS | 5458 | [#0] dojo.html Cycles:165 Average:5349.07 Median:5536.09 stddev:623.82 (11.3%) stddev-sans-first:599.17 06:56:28 INFO - PROCESS | 5458 | Values: 3053.5 3054.2 3100.5 3102.7 3117.3 5254.1 5331.6 5335.8 5407.6 5463.3 5335.3 5367.1 5399.2 5417.3 5435.2 4874.9 4935.4 4965.7 4977.2 5074.9 4963.5 4976.8 5022.2 5034.3 5041.9 4792.0 4812.9 4820.7 4845.0 4870.3 4862.3 4863.0 4869.2 4884.4 4984.6 4853.1 4887.4 4897.5 4903.4 4960.6 5238.6 5340.1 5402.5 5414.5 5415.5 5841.6 5848.5 5905.3 5911.2 5914.3 5884.5 5899.1 5938.7 5949.6 5956.7 5285.3 5341.8 5388.4 5397.5 5478.5 5953.6 5958.8 5959.7 5961.5 5967.3 5735.0 5743.3 5747.8 5748.3 5756.4 5628.6 5690.1 5744.0 5749.2 5810.4 5742.0 5751.6 5754.1 5760.5 5806.4 5694.2 5701.8 5708.8 5757.2 5764.7 4260.6 4294.0 4300.6 4344.5 4349.8 3868.2 3873.6 3884.7 3906.9 3914.3 5400.4 5406.5 5409.6 5410.6 5413.4 5571.0 5607.9 5660.9 5672.3 5674.4 5309.8 5340.3 5344.7 5349.1 5353.9 4860.1 4944.7 4950.8 4957.5 5003.5 5933.3 5950.3 5982.5 5994.0 6016.4 5846.4 5852.5 5854.0 5854.2 5859.1 5813.6 5873.3 5987.6 6018.8 6031.5 5686.1 5704.6 5710.8 5718.1 5770.6 5757.2 5787.4 5793.4 5795.9 5796.2 5461.5 5562.5 5598.5 5676.4 5678.3 5555.5 5597.3 5601.6 5609.2 5655.4 5536.1 5541.6 5546.1 5561.6 5573.2 5507.9 5548.9 5568.7 5661.0 5663.8 5412.6 5482.3 5486.7 5488.4 5499.4 06:56:28 INFO - PROCESS | 5458 | 06:56:28 INFO - PROCESS | 5458 | [#1] ext.html Cycles:180 Average:63903.60 Median:24753.05 stddev:129056.31 (521.4%) stddev-sans-first:129330.77 06:56:28 INFO - PROCESS | 5458 | Values: 581.6 609.3 628.2 644.5 646.8 42359.0 43933.1 44043.8 47431.8 47522.5 45105.5 45686.8 45712.5 45741.0 45844.5 8905.2 9049.3 9055.6 9058.0 9062.8 8973.4 8997.0 9056.6 9061.9 9065.1 9043.2 9078.8 9080.0 9085.5 9092.0 8966.3 8981.1 9010.7 9023.0 9027.9 8861.0 8963.0 8963.6 8973.1 9002.9 41378.2 41647.0 41678.6 41735.0 41795.8 3519.8 3557.7 3561.3 3630.7 3964.9 32773.2 33038.5 33067.5 33192.8 33951.2 4358.6 4412.7 4462.6 4487.0 4528.4 352869.0 353320.0 354737.0 355661.0 355711.0 49232.3 53890.5 57167.0 57447.4 57490.7 55307.7 58965.0 60032.4 60051.4 60072.0 15390.2 15400.8 15411.4 15428.4 15510.8 10898.7 11158.3 11167.6 11174.7 11657.9 15356.0 15468.1 15547.2 15627.9 15889.3 6249.3 6287.2 6304.5 6371.3 6397.4 973.4 975.4 1068.6 1073.2 1074.8 32400.2 32697.7 32794.3 32872.7 33036.8 1133.8 1144.2 1148.9 1162.1 1168.3 16831.2 17147.7 17185.8 17202.1 17222.2 546725.0 558974.0 560317.0 561730.0 562479.0 56266.4 57780.4 57795.4 57881.7 58145.0 1240.5 1321.9 1328.1 1328.8 1340.4 32725.5 35334.8 35416.3 35525.6 35591.3 53742.7 55480.2 55818.0 60328.4 60477.0 511905.0 520173.0 522059.0 522753.0 523745.0 24683.8 25205.0 25224.6 26649.3 45328.3 47830.5 48388.0 51792.7 52570.0 53267.5 41559.6 45019.1 45204.3 45266.5 45705.1 43306.9 44118.2 44155.3 45419.3 45647.5 43475.3 44161.3 44588.8 45051.5 45143.1 38556.2 38784.2 39276.8 39539.0 40269.6 29523.0 29778.7 30036.4 30232.0 30528.2 06:56:28 INFO - PROCESS | 5458 | 06:56:28 INFO - PROCESS | 5458 | [#2] jquery.html Cycles:180 Average:29103.62 Median:2545.39 stddev:77305.77 (3037.1%) stddev-sans-first:77492.56 06:56:28 INFO - PROCESS | 5458 | Values: 385.0 393.3 396.5 400.2 414.9 14760.5 18860.2 19022.3 20218.9 20226.2 16455.2 18937.0 19736.3 19793.9 20639.1 5821.5 6015.9 6018.5 6023.2 6026.9 4287.5 5947.1 6042.2 6411.3 6749.6 6775.9 6796.5 6808.2 6819.0 6824.2 6458.4 6737.8 6745.2 6746.3 6749.0 5715.3 5902.9 5921.6 5924.1 5955.3 20592.5 20736.8 21002.0 23589.4 24099.3 2537.3 2553.5 2588.0 2653.3 2857.8 14541.9 15400.4 15657.3 15795.9 15881.8 1965.4 2013.8 2047.8 2062.4 2130.4 84161.2 84869.6 85894.0 86880.1 86950.6 10186.2 10567.1 10660.9 10741.2 10850.7 14521.9 14601.4 14620.5 14658.4 14663.3 7715.7 8026.7 8054.4 8136.7 8150.6 6696.2 7845.5 7956.2 8134.6 8162.6 4549.5 4657.4 4721.0 4815.4 4878.1 1934.3 1944.3 1944.6 1973.5 1998.8 888.8 953.7 976.6 996.7 1025.1 20643.9 20913.7 20914.2 20960.2 21044.9 990.6 1001.9 1004.3 1011.7 1067.7 11076.3 11728.7 11793.2 11827.7 11843.8 458363.0 465984.0 468666.0 472305.0 472359.0 77667.6 95890.5 96566.0 96595.8 97503.5 993.9 996.8 1011.4 1015.1 1019.6 18308.5 18405.3 18796.7 18802.6 18855.3 35607.1 43067.8 43943.9 45820.1 45919.0 61084.0 61364.7 62206.0 63315.4 63540.7 8850.8 9014.4 9021.0 9086.5 9256.0 12180.2 13793.2 13880.9 14073.2 14090.4 11945.2 12338.8 12374.4 12574.9 12750.4 11914.8 12013.0 12030.9 12101.2 12163.3 12674.6 12724.5 12809.9 12854.6 12976.7 8856.5 8865.7 9093.9 12257.8 13094.6 11449.3 12734.6 12947.5 13244.0 13283.7 06:56:28 INFO - PROCESS | 5458 | 06:56:28 INFO - PROCESS | 5458 | [#3] mootools.html Cycles:180 Average:5894.76 Median:4959.48 stddev:3383.10 (68.2%) stddev-sans-first:3375.21 06:56:28 INFO - PROCESS | 5458 | Values: 1332.5 1443.0 1500.0 1594.8 1766.8 8190.8 8554.3 8561.2 8725.7 8754.0 8465.8 8624.7 8635.3 8656.2 8662.9 2326.3 2375.1 2378.5 2378.8 2379.0 2289.2 2339.5 2360.6 2367.0 2371.1 2339.1 2340.7 2352.8 2377.9 2380.2 2276.8 2304.0 2310.2 2311.2 2318.4 2283.0 2286.5 2288.1 2291.8 2294.5 8579.0 8608.7 8638.0 8889.5 9179.4 5319.1 5427.2 5428.1 5429.3 5437.6 3495.9 3497.7 3562.7 3567.8 3615.2 1123.0 1124.2 1128.1 1144.3 1146.9 12520.4 12581.6 12586.8 12606.7 12620.0 4358.1 4477.0 4575.9 4603.6 4611.0 9807.4 9814.1 9821.0 9830.3 9847.2 5282.9 5285.1 5286.8 5287.2 5294.5 4327.5 4750.8 4955.2 4963.8 4976.4 3748.7 3773.6 3809.1 3842.6 3861.4 1150.3 1196.1 1200.1 1207.7 1214.6 701.4 930.6 964.7 982.7 993.7 6091.7 6222.2 6277.1 6412.2 6419.0 469.0 469.9 489.0 507.5 519.6 4076.2 4322.6 4343.0 4343.6 4439.0 10874.7 11340.7 11365.5 11415.7 11440.0 10571.9 10693.5 10717.4 11249.7 11263.5 8245.6 8468.4 8469.2 8491.6 8516.7 6081.2 6514.0 6568.0 6591.4 6624.1 10192.4 10380.9 10464.4 10590.1 10764.7 10722.6 10831.8 10842.8 10894.1 10954.1 7194.2 7684.2 7853.8 7861.6 7935.4 8831.7 8838.5 8893.8 8905.8 8925.7 7809.0 7893.9 7961.7 7972.1 8033.5 7748.4 7809.9 7848.8 7934.1 7947.3 6682.1 7258.1 7296.3 7314.5 7328.3 5472.5 5507.1 5529.0 5547.8 5589.3 5345.6 5374.7 5483.1 5492.9 5631.5 06:56:28 INFO - PROCESS | 5458 | 06:56:28 INFO - PROCESS | 5458 | [#4] prototype.html Cycles:180 Average:4565.36 Median:5128.01 stddev:1322.53 (25.8%) stddev-sans-first:1287.50 06:56:28 INFO - PROCESS | 5458 | Values: 331.8 332.7 338.7 339.2 339.6 5379.4 5398.7 5401.0 5422.5 5426.9 5235.4 5266.2 5293.4 5304.0 5314.8 3766.9 4002.4 4016.9 4107.9 4143.5 4132.5 4166.3 4167.7 4179.9 4180.3 4154.7 4154.9 4159.7 4175.2 4204.1 3992.8 4101.6 4168.7 4175.8 4194.7 3702.9 3704.6 3710.5 3714.4 3738.5 5129.5 5137.4 5138.2 5171.6 5172.2 4766.5 4784.6 4786.9 4814.4 4828.4 5580.3 5590.5 5594.8 5601.0 5604.6 3882.7 3894.4 3996.0 4061.1 4078.1 5636.8 5687.4 5725.9 5732.5 5738.8 4152.2 4153.9 4159.7 4182.9 4205.7 4159.9 4176.3 4176.7 4224.6 4228.6 4745.7 4750.2 4756.7 4762.9 4802.3 5526.7 5534.9 5559.7 5592.6 5592.9 1341.6 1398.6 1405.4 1408.7 1426.4 901.0 914.2 918.1 919.4 946.7 4640.4 4733.9 4766.3 4773.9 4802.5 4948.5 4962.0 5018.4 5020.1 5052.8 4482.6 4747.0 4788.6 4809.9 4810.8 2741.6 2743.0 2743.0 2749.8 2759.6 5293.8 5321.8 5321.9 5329.2 5330.7 4780.5 5069.8 5099.0 5155.9 5173.9 5126.5 5157.9 5163.3 5177.0 5192.0 5032.2 5059.8 5461.0 5469.6 5697.5 5543.6 5593.3 5607.5 5616.6 5643.4 5654.9 5762.3 5766.8 5795.7 5808.1 4055.7 4076.8 4079.6 4102.5 4105.1 5677.7 5686.4 5697.7 5742.6 5771.2 5316.3 5616.0 5616.3 5621.4 5629.7 5543.4 5561.2 5567.7 5572.6 5583.3 5519.5 5523.9 5528.5 5555.7 5556.4 5345.3 5587.2 5594.8 5605.5 5606.8 5425.7 5438.4 5445.0 5449.9 5456.3 06:56:28 INFO - PROCESS | 5458 | 06:56:28 INFO - PROCESS | 5458 | [#5] yui.html Cycles:180 Average:21776.95 Median:3713.10 stddev:30897.76 (832.1%) stddev-sans-first:30944.09 06:56:28 INFO - PROCESS | 5458 | Values: 747.1 796.6 819.6 824.0 833.2 15502.6 16863.6 16868.1 16878.2 16906.3 15235.6 15272.7 15366.2 15423.8 15452.5 660.8 774.9 783.6 785.3 795.2 816.0 825.4 826.0 826.5 826.7 870.5 872.0 877.3 878.3 878.6 704.8 832.1 859.8 870.8 871.1 616.1 616.9 621.2 621.6 621.7 15894.6 15906.4 15916.6 15924.3 15936.2 15649.6 15703.4 15757.3 15971.9 16031.0 12796.7 12864.2 12907.9 12929.6 12950.6 3860.9 4008.2 4008.7 4095.5 4115.8 79186.0 79587.2 80663.0 81322.6 82112.6 11989.6 12152.0 12212.9 12252.4 12602.8 23454.9 23463.8 23468.7 23474.0 23479.9 8755.6 9001.4 9041.1 9292.6 9324.3 4818.4 4978.3 5025.7 5037.6 5093.5 3585.4 3707.1 3711.6 3714.6 3717.7 655.7 659.9 665.7 667.2 683.8 633.4 684.1 727.5 729.2 752.6 10034.2 10163.5 10338.8 10445.4 10531.6 681.3 756.7 789.8 790.3 801.9 4892.0 5217.3 5307.7 5308.3 5391.9 105168.0 113459.0 114742.4 118279.4 119396.0 101846.5 102626.0 104314.0 104331.5 105946.5 89096.1 89183.0 89712.6 91778.5 91805.0 10377.5 10429.7 10475.5 10494.7 10556.0 52008.2 52430.0 52621.7 53155.7 54378.5 73419.6 80853.7 81222.0 81258.6 81739.6 12903.4 12953.5 12985.3 13995.4 14245.2 15552.2 15727.8 15851.8 15891.1 15908.9 9873.9 12537.4 13109.9 13415.0 13837.2 14381.7 14450.2 14450.5 15254.8 15359.5 9510.6 13472.3 14710.3 14763.1 14931.7 12234.0 12367.2 12438.2 12504.2 12853.6 12793.0 12875.6 13090.8 13198.9 13227.4 06:56:28 INFO - PROCESS | 5458 | -------- Summary: end -------- 06:56:28 INFO - PROCESS | 5458 | 06:56:29 INFO - TEST-INFO | 5458: exit 0 06:56:29 INFO - TEST-OK | dromaeo_css | took 1114531ms 06:56:29 INFO - TEST-START | kraken 06:56:29 INFO - operating with platform_type : linux_ 06:56:29 INFO - Initialising browser for kraken test... 06:56:29 INFO - TEST-INFO | started process 5650 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpl9yenJ/profile http://localhost:35459/getInfo.html) 06:56:32 INFO - PROCESS | 5650 | __metrics Screen width/height:1600/1200 06:56:32 INFO - PROCESS | 5650 | colorDepth:24 06:56:32 INFO - PROCESS | 5650 | Browser inner width/height: 1024/697 06:56:32 INFO - PROCESS | 5650 | __metrics 06:56:33 INFO - PROCESS | 5650 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:56:33 INFO - PROCESS | 5650 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:56:34 INFO - TEST-INFO | 5650: exit 0 06:56:34 INFO - Browser initialized. 06:56:34 INFO - Running cycle 1/1 for kraken test... 06:56:34 INFO - TEST-INFO | started process 5733 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpl9yenJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:56:46 INFO - PROCESS | 5733 | RSS: Main: 157814784 06:56:46 INFO - PROCESS | 5733 | 06:56:48 INFO - PROCESS | 5733 | Cycle 1(1): loaded http://localhost:35459/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35459/tests/kraken/driver.html?testName=audio-beat-detection) 06:56:49 INFO - PROCESS | 5733 | RSS: Main: 215805952 06:56:49 INFO - PROCESS | 5733 | 06:56:52 INFO - PROCESS | 5733 | Cycle 1(1): loaded http://localhost:35459/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35459/tests/kraken/driver.html?testName=audio-dft) 06:56:52 INFO - PROCESS | 5733 | RSS: Main: 203722752 06:56:52 INFO - PROCESS | 5733 | 06:56:56 INFO - PROCESS | 5733 | Cycle 1(1): loaded http://localhost:35459/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35459/tests/kraken/driver.html?testName=audio-fft) 06:56:56 INFO - PROCESS | 5733 | RSS: Main: 269975552 06:56:56 INFO - PROCESS | 5733 | 06:56:58 INFO - PROCESS | 5733 | Cycle 1(1): loaded http://localhost:35459/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35459/tests/kraken/driver.html?testName=audio-oscillator) 06:56:59 INFO - PROCESS | 5733 | RSS: Main: 180809728 06:56:59 INFO - PROCESS | 5733 | 06:57:01 INFO - PROCESS | 5733 | Cycle 1(1): loaded http://localhost:35459/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35459/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:57:02 INFO - PROCESS | 5733 | RSS: Main: 184811520 06:57:02 INFO - PROCESS | 5733 | 06:57:05 INFO - PROCESS | 5733 | Cycle 1(1): loaded http://localhost:35459/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35459/tests/kraken/driver.html?testName=imaging-darkroom) 06:57:05 INFO - PROCESS | 5733 | RSS: Main: 219820032 06:57:05 INFO - PROCESS | 5733 | 06:57:09 INFO - PROCESS | 5733 | Cycle 1(1): loaded http://localhost:35459/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35459/tests/kraken/driver.html?testName=imaging-desaturate) 06:57:09 INFO - PROCESS | 5733 | RSS: Main: 222216192 06:57:09 INFO - PROCESS | 5733 | 06:57:12 INFO - PROCESS | 5733 | Cycle 1(1): loaded http://localhost:35459/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35459/tests/kraken/driver.html?testName=json-parse-financial) 06:57:13 INFO - PROCESS | 5733 | RSS: Main: 222162944 06:57:13 INFO - PROCESS | 5733 | 06:57:14 INFO - PROCESS | 5733 | Cycle 1(1): loaded http://localhost:35459/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35459/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:57:15 INFO - PROCESS | 5733 | RSS: Main: 209809408 06:57:15 INFO - PROCESS | 5733 | 06:57:16 INFO - PROCESS | 5733 | Cycle 1(1): loaded http://localhost:35459/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35459/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:57:17 INFO - PROCESS | 5733 | RSS: Main: 213528576 06:57:17 INFO - PROCESS | 5733 | 06:57:19 INFO - PROCESS | 5733 | Cycle 1(1): loaded http://localhost:35459/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35459/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:57:20 INFO - PROCESS | 5733 | RSS: Main: 209711104 06:57:20 INFO - PROCESS | 5733 | 06:57:22 INFO - PROCESS | 5733 | Cycle 1(1): loaded http://localhost:35459/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35459/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:57:23 INFO - PROCESS | 5733 | RSS: Main: 223580160 06:57:23 INFO - PROCESS | 5733 | 06:57:26 INFO - PROCESS | 5733 | Cycle 1(1): loaded http://localhost:35459/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35459/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:57:26 INFO - PROCESS | 5733 | RSS: Main: 225386496 06:57:26 INFO - PROCESS | 5733 | 06:57:28 INFO - PROCESS | 5733 | Cycle 1(1): loaded http://localhost:35459/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35459/tests/kraken/driver.html?testName=ai-astar) 06:57:28 INFO - PROCESS | 5733 | RSS: Main: 267784192 06:57:28 INFO - PROCESS | 5733 | 06:57:28 INFO - PROCESS | 5733 | __start_tp_report 06:57:28 INFO - PROCESS | 5733 | _x_x_mozilla_page_load 06:57:28 INFO - PROCESS | 5733 | _x_x_mozilla_page_load_details 06:57:28 INFO - PROCESS | 5733 | |i|pagename|runs| 06:57:28 INFO - PROCESS | 5733 | |0;ai-astar;100;111;111;110;111;112;111;110;111;111 06:57:28 INFO - PROCESS | 5733 | |1;audio-beat-detection;147;120;118;176;119;117;143;116;146;122 06:57:28 INFO - PROCESS | 5733 | |2;audio-dft;160;160;160;161;161;160;159;163;160;161 06:57:28 INFO - PROCESS | 5733 | |3;audio-fft;73;75;76;133;75;76;73;75;104;75 06:57:28 INFO - PROCESS | 5733 | |4;audio-oscillator;83;84;115;84;84;84;122;84;83;121 06:57:28 INFO - PROCESS | 5733 | |5;imaging-gaussian-blur;117;117;117;116;117;117;118;117;117;117 06:57:28 INFO - PROCESS | 5733 | |6;imaging-darkroom;145;146;146;146;146;146;146;146;147;147 06:57:28 INFO - PROCESS | 5733 | |7;imaging-desaturate;95;96;95;96;95;96;95;96;95;95 06:57:28 INFO - PROCESS | 5733 | |8;json-parse-financial;54;53;55;53;52;55;54;54;54;53 06:57:28 INFO - PROCESS | 5733 | |9;json-stringify-tinderbox;62;63;63;63;63;62;63;63;65;63 06:57:28 INFO - PROCESS | 5733 | |10;stanford-crypto-aes;75;75;75;76;75;75;74;75;80;78 06:57:28 INFO - PROCESS | 5733 | |11;stanford-crypto-ccm;127;124;128;119;127;127;128;120;157;131 06:57:28 INFO - PROCESS | 5733 | |12;stanford-crypto-pbkdf2;156;157;156;155;156;157;156;164;159;153 06:57:28 INFO - PROCESS | 5733 | |13;stanford-crypto-sha256-iterative;64;63;66;62;63;63;70;61;65;60 06:57:28 INFO - PROCESS | 5733 | __end_tp_report 06:57:28 INFO - PROCESS | 5733 | __start_cc_report 06:57:28 INFO - PROCESS | 5733 | _x_x_mozilla_cycle_collect,1608 06:57:28 INFO - PROCESS | 5733 | __end_cc_report 06:57:28 INFO - PROCESS | 5733 | __startTimestamp1468331848563__endTimestamp 06:57:28 INFO - PROCESS | 5733 | 06:57:28 INFO - PROCESS | 5733 | ------- Summary: start ------- 06:57:28 INFO - PROCESS | 5733 | Number of tests: 14 06:57:28 INFO - PROCESS | 5733 | 06:57:28 INFO - PROCESS | 5733 | [#0] ai-astar Cycles:10 Average:109.80 Median:111.00 stddev:3.49 (3.1%) stddev-sans-first:0.60 06:57:28 INFO - PROCESS | 5733 | Values: 100.0 111.0 111.0 110.0 111.0 112.0 111.0 110.0 111.0 111.0 06:57:28 INFO - PROCESS | 5733 | 06:57:28 INFO - PROCESS | 5733 | [#1] audio-beat-detection Cycles:10 Average:132.40 Median:132.50 stddev:19.91 (15.0%) stddev-sans-first:20.40 06:57:28 INFO - PROCESS | 5733 | Values: 147.0 120.0 118.0 176.0 119.0 117.0 143.0 116.0 146.0 122.0 06:57:28 INFO - PROCESS | 5733 | 06:57:28 INFO - PROCESS | 5733 | [#2] audio-dft Cycles:10 Average:160.50 Median:160.50 stddev:1.08 (0.7%) stddev-sans-first:1.13 06:57:28 INFO - PROCESS | 5733 | Values: 160.0 160.0 160.0 161.0 161.0 160.0 159.0 163.0 160.0 161.0 06:57:28 INFO - PROCESS | 5733 | 06:57:28 INFO - PROCESS | 5733 | [#3] audio-fft Cycles:10 Average:83.50 Median:75.00 stddev:19.70 (26.3%) stddev-sans-first:20.52 06:57:28 INFO - PROCESS | 5733 | Values: 73.0 75.0 76.0 133.0 75.0 76.0 73.0 75.0 104.0 75.0 06:57:28 INFO - PROCESS | 5733 | 06:57:28 INFO - PROCESS | 5733 | [#4] audio-oscillator Cycles:10 Average:94.40 Median:84.00 stddev:17.30 (20.6%) stddev-sans-first:17.85 06:57:28 INFO - PROCESS | 5733 | Values: 83.0 84.0 115.0 84.0 84.0 84.0 122.0 84.0 83.0 121.0 06:57:28 INFO - PROCESS | 5733 | 06:57:28 INFO - PROCESS | 5733 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 06:57:28 INFO - PROCESS | 5733 | Values: 117.0 117.0 117.0 116.0 117.0 117.0 118.0 117.0 117.0 117.0 06:57:28 INFO - PROCESS | 5733 | 06:57:28 INFO - PROCESS | 5733 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.44 06:57:28 INFO - PROCESS | 5733 | Values: 145.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 147.0 147.0 06:57:28 INFO - PROCESS | 5733 | 06:57:28 INFO - PROCESS | 5733 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 06:57:28 INFO - PROCESS | 5733 | Values: 95.0 96.0 95.0 96.0 95.0 96.0 95.0 96.0 95.0 95.0 06:57:28 INFO - PROCESS | 5733 | 06:57:28 INFO - PROCESS | 5733 | [#8] json-parse-financial Cycles:10 Average:53.70 Median:54.00 stddev:0.95 (1.8%) stddev-sans-first:1.00 06:57:28 INFO - PROCESS | 5733 | Values: 54.0 53.0 55.0 53.0 52.0 55.0 54.0 54.0 54.0 53.0 06:57:28 INFO - PROCESS | 5733 | 06:57:28 INFO - PROCESS | 5733 | [#9] json-stringify-tinderbox Cycles:10 Average:63.00 Median:63.00 stddev:0.82 (1.3%) stddev-sans-first:0.78 06:57:28 INFO - PROCESS | 5733 | Values: 62.0 63.0 63.0 63.0 63.0 62.0 63.0 63.0 65.0 63.0 06:57:28 INFO - PROCESS | 5733 | 06:57:28 INFO - PROCESS | 5733 | [#10] stanford-crypto-aes Cycles:10 Average:75.80 Median:75.00 stddev:1.81 (2.4%) stddev-sans-first:1.90 06:57:28 INFO - PROCESS | 5733 | Values: 75.0 75.0 75.0 76.0 75.0 75.0 74.0 75.0 80.0 78.0 06:57:28 INFO - PROCESS | 5733 | 06:57:28 INFO - PROCESS | 5733 | [#11] stanford-crypto-ccm Cycles:10 Average:128.80 Median:127.50 stddev:10.58 (8.3%) stddev-sans-first:11.20 06:57:28 INFO - PROCESS | 5733 | Values: 127.0 124.0 128.0 119.0 127.0 127.0 128.0 120.0 157.0 131.0 06:57:28 INFO - PROCESS | 5733 | 06:57:28 INFO - PROCESS | 5733 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.90 Median:156.50 stddev:2.92 (1.9%) stddev-sans-first:3.08 06:57:28 INFO - PROCESS | 5733 | Values: 156.0 157.0 156.0 155.0 156.0 157.0 156.0 164.0 159.0 153.0 06:57:28 INFO - PROCESS | 5733 | 06:57:28 INFO - PROCESS | 5733 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.70 Median:63.50 stddev:2.83 (4.5%) stddev-sans-first:3.00 06:57:28 INFO - PROCESS | 5733 | Values: 64.0 63.0 66.0 62.0 63.0 63.0 70.0 61.0 65.0 60.0 06:57:28 INFO - PROCESS | 5733 | -------- Summary: end -------- 06:57:28 INFO - PROCESS | 5733 | 06:57:29 INFO - TEST-INFO | 5733: exit 0 06:57:29 INFO - TEST-OK | kraken | took 60466ms 06:57:29 INFO - SUITE-END | took 1174s 06:57:29 INFO - Completed test suite (00:19:35) 06:57:29 INFO - javascript benchmark 06:57:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3053.480908245598, 3054.1906394805364, 3100.5349197620367, 3102.7362674172687, 3117.298607813242, 5254.080535906221, 5331.57347412207, 5335.759890804913, 5407.594430417715, 5463.344398672155, 5335.306410166673, 5367.114426119686, 5399.19012148178, 5417.26866872972, 5435.211894275328, 4874.853754387365, 4935.383077115361, 4965.702057876539, 4977.228529577903, 5074.923876141843, 4963.528464795839, 4976.776045077962, 5022.221555658879, 5034.320366750497, 5041.924371134436, 4791.952080479203, 4812.879678008043, 4820.734859582722, 4845.0, 4870.269459581055, 4862.270659401082, 4863.0, 4869.196582563873, 4884.389451318585, 4984.601231901439, 4853.126437241295, 4887.3890763654545, 4897.534734200245, 4903.436104847917, 4960.578350840183, 5238.607104467142, 5340.145576707708, 5402.459754024605, 5414.458554144554, 5415.512603865671, 5841.591088623798, 5848.5321174305955, 5905.320888097881, 5911.231539899829, 5914.349421563625, 5884.499817515516, 5899.144624029492, 5938.703064846741, 5949.583529152961, 5956.702164891738, 5285.286486324336, 5341.759620817073, 5388.407275199725, 5397.46025397461, 5478.534324582375, 5953.613015154001, 5958.791442299499, 5959.672218027963, 5961.463468287875, 5967.283925928829, 5734.971325143348, 5743.282089738783, 5747.798827041033, 5748.252727145445, 5756.395578464285, 5628.605997580212, 5690.146478028246, 5744.0, 5749.195112684228, 5810.389909059572, 5741.971290143522, 5751.626144300607, 5754.136879468113, 5760.53915686744, 5806.390329015392, 5694.202811606378, 5701.828945131652, 5708.828735137952, 5757.165211044375, 5764.7117644117625, 4260.55264197261, 4293.97853010733, 4300.591443812833, 4344.500382456058, 4349.782510874507, 3868.168343806095, 3873.6320049595242, 3884.708646851441, 3906.90232744178, 3914.3345631242755, 5400.378956419983, 5406.486383793534, 5409.5672346213, 5410.594205434608, 5413.404525502192, 5571.0, 5607.859803504945, 5660.915086273709, 5672.290963629546, 5674.432556744375, 5309.814156504503, 5340.279062326614, 5344.706041167773, 5349.090654588729, 5353.866153346197, 4860.1008813368935, 4944.660054621177, 4950.752462376867, 4957.529034741694, 5003.474635163256, 5933.317668468095, 5950.285965684146, 5982.4914882234625, 5993.970030149909, 6016.428439298172, 5846.386129456346, 5852.502537284378, 5854.034084376201, 5854.180414741854, 5859.062549991981, 5813.563982701399, 5873.324567674772, 5987.5808693391045, 6018.819435416769, 6031.517478601789, 5686.118651609007, 5704.629199102045, 5710.771569137188, 5718.0565206742085, 5770.567207459373, 5757.222774925499, 5787.421257874347, 5793.36273009977, 5795.942040579709, 5796.21751063601, 5461.481159289861, 5562.527185189304, 5598.524125449382, 5676.4323567642905, 5678.261825962599, 5555.527780138572, 5597.272354593877, 5601.579881508822, 5609.186667933209, 5655.406182350794, 5536.086545719912, 5541.556675465872, 5546.084895992116, 5561.555075594024, 5573.191887176417, 5507.917381239205, 5548.861278467909, 5568.721563921868, 5660.971695141663, 5663.773449061991, 5412.648177868584, 5482.342118945752, 5486.670799752028, 5488.396276409671, 5499.422560631237], "value": 5305.685881351432, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [581.566732784076, 609.3358239518925, 628.1770880147006, 644.5101722690754, 646.7639311651249, 42359.0, 43933.121337573226, 44043.77978110113, 47431.762841185744, 47522.524774752244, 45105.54894451055, 45686.771566142124, 45712.54287457124, 45741.0, 45844.541554584444, 8905.154010369004, 9049.321300902426, 9055.637774489012, 9058.0, 9062.818743625123, 8973.416727912698, 8997.0, 9056.637734490612, 9061.909380906172, 9065.093490650948, 9043.186113249807, 9078.818423631556, 9080.00119986801, 9085.454872707625, 9091.954540227289, 8966.327525435554, 8981.056989016157, 9010.684626038123, 9022.954885225598, 9027.864582031307, 8860.955695221483, 8963.0, 8963.596638151233, 8973.10268973104, 9002.909970900339, 41378.1724365514, 41647.0, 41678.583214167775, 41735.0, 41795.791021045006, 3519.771214871025, 3557.7153827693983, 3561.3055454186183, 3630.6913912317223, 3964.949288438566, 32773.18067048319, 33038.50442243368, 33067.503987439966, 33192.83403582966, 33951.15122121942, 4358.629516491102, 4412.713173643735, 4462.553744625544, 4487.0, 4528.411306530163, 352869.0, 353320.0, 354737.0, 355661.0, 355711.0, 49232.261516077284, 53890.46109538933, 57167.0, 57447.42552574504, 57490.712546437, 55307.72346138243, 58965.0, 60032.39967600268, 60051.39948600545, 60072.0, 15390.230488475532, 15400.768988465183, 15411.383544658313, 15428.38286468551, 15510.767338489932, 10898.673039808818, 11158.274712143684, 11167.609133680282, 11174.720631984266, 11657.88342116568, 15356.0, 15468.149251791034, 15547.222638868012, 15627.921860390852, 15889.284982175599, 6249.281332646713, 6287.245530536365, 6304.495640348761, 6371.331010243857, 6397.39224773655, 973.3624475968111, 975.3660120921458, 1068.5939343049592, 1073.2058276875057, 1074.7801245586315, 32400.189995250308, 32697.673023269937, 32794.3441131176, 32872.671273286964, 33036.834815825765, 1133.7562424078699, 1144.1533265383557, 1148.9138314626437, 1162.1458228202264, 1168.2523185161504, 16831.158442077845, 17147.71392145594, 17185.828141718423, 17202.053887036083, 17222.224999875034, 546725.0, 558974.0, 560317.0, 561730.0, 562479.0, 56266.43733562612, 57780.422195778345, 57795.42204577901, 57881.710591446776, 58145.0, 1240.4851986425533, 1321.9471221151045, 1328.0637150808657, 1328.8139660447546, 1340.3901224942822, 32725.50911736278, 35334.76328328599, 35416.29167416689, 35525.644743552235, 35591.28817423689, 53742.73128634332, 55480.16779748226, 55818.0, 60328.39671603228, 60477.0, 511905.0, 520173.0, 522059.0, 522753.0, 523745.0, 24683.753162468147, 25205.0, 25224.621630675923, 26649.33376665599, 45328.32007519824, 47830.521694782605, 48388.0, 51792.741036294574, 52570.0, 53267.46732532625, 41559.58440415557, 45019.09961800811, 45204.321935171654, 45266.54733452755, 45705.085898282516, 43306.91732706707, 44118.23527058882, 44155.337669934335, 45419.318710218715, 45647.54352456433, 43475.347869782614, 44161.33757993697, 44588.777056114515, 45051.549484506046, 45143.0971380564, 38556.22887542177, 38784.22431551297, 39276.80361598288, 39539.0, 40269.59730402658, 29523.01439305752, 29778.676038669364, 30036.399272014, 30232.0, 30528.236794080327], "value": 20448.209133454093, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [384.9769013859167, 393.3097414038364, 396.49050969504185, 400.23155541360586, 414.8983499042733, 14760.483383081595, 18860.245590176393, 19022.334218302363, 20218.89890550547, 20226.190952361907, 16455.177241137924, 18937.0, 19736.309229176983, 19793.901030494828, 20639.071241794118, 5821.476067153966, 6015.939840601582, 6018.458338749511, 6023.247094113236, 6026.9095963560585, 4287.5498072702385, 5947.078202878539, 6042.244719410074, 6411.262704788963, 6749.628770417625, 6775.898361524581, 6796.524243302971, 6808.21705503866, 6819.045333653293, 6824.215215250235, 6458.354164583551, 6737.764178253738, 6745.224299205605, 6746.325367463263, 6748.966255168717, 5715.2855893013375, 5902.940970590282, 5921.61509501881, 5924.081767326072, 5955.34491205967, 20592.485187870272, 20736.792632073637, 21002.0, 23589.410264743346, 24099.277021689377, 2537.289558923486, 2553.4893021395796, 2587.9648140743666, 2653.2570880153394, 2857.8142420742583, 14541.854581454156, 15400.3839846406, 15657.295421705936, 15795.921020394939, 15881.812538795779, 1965.4496740912568, 2013.7784843667184, 2047.7952204779551, 2062.3812856143095, 2130.4371565712463, 84161.15838841656, 84869.57565212135, 85894.0, 86880.13119868784, 86950.56524717336, 10186.185105191567, 10567.101796347242, 10660.946695266473, 10741.248112632196, 10850.67447976562, 14521.927390363191, 14601.415943362359, 14620.488282910048, 14658.413663453342, 14663.34014969329, 7715.729949451742, 8026.675598526294, 8054.395920306, 8136.7152149674475, 8150.551719655357, 6696.1629796275465, 7845.490043147177, 7956.164602716747, 8134.633941472648, 8162.632681529345, 4549.476810166873, 4657.371254880615, 4720.95279047212, 4815.398075240595, 4878.0975519529, 1934.2746470073723, 1944.348643204514, 1944.562473443464, 1973.4671638657483, 1998.7501562304712, 888.760034790603, 953.7424895278375, 976.584951395654, 996.6860438961849, 1025.1388833379847, 20643.896780516003, 20913.686294705592, 20914.163433462796, 20960.161593536086, 21044.894775526023, 990.5542505872386, 1001.8647482589903, 1004.3271008424373, 1011.7066050845319, 1067.7330667333167, 11076.280041797258, 11728.683945872113, 11793.174477786473, 11827.704307392383, 11843.763124737628, 458363.0, 465984.0, 468666.0, 472305.0, 472359.0, 77667.61166194132, 95890.5205473982, 96566.0, 96595.75531835141, 97503.51248243856, 993.9006099390148, 996.835522138839, 1011.4285428732743, 1015.1016350529834, 1019.5666841592293, 18308.542286442946, 18405.263789448807, 18796.718049229, 18802.623947521246, 18855.340063097727, 35607.10982225465, 43067.7846610765, 43943.92392532492, 45820.083598328514, 45919.0, 61084.0, 61364.69317653383, 62206.0, 63315.366846330944, 63540.68229659007, 8850.778730531789, 9014.368994170607, 9020.954895225483, 9086.545672716205, 9255.953720231355, 12180.208286461351, 13793.24137172465, 13880.93059534696, 14073.155610663393, 14090.36593353281, 11945.223560468541, 12338.753224935272, 12374.381280936097, 12574.874251257736, 12750.42623081945, 11914.76170476603, 12013.0, 12030.939845300718, 12101.213421127599, 12163.331016793807, 12674.556390526288, 12724.491020359083, 12809.935950320189, 12854.614361569167, 12976.675583110498, 8856.512891791013, 8865.734027979172, 9093.863592045993, 12257.816132757838, 13094.607161785161, 11449.255798373079, 12734.554290599785, 12947.482100715866, 13244.0, 13283.667908301983], "value": 9676.997713089719, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1332.5469340424254, 1442.9567112986608, 1499.9625009374765, 1594.7607858821182, 1766.7791526059234, 8190.8361832763385, 8554.315654747621, 8561.1866872647, 8725.694600688978, 8754.0, 8465.78835529112, 8624.741257762262, 8635.266002389804, 8656.17766312201, 8662.91337086629, 2326.2904814031754, 2375.061850569024, 2378.5124049569795, 2378.8096952243777, 2379.048380647746, 2289.164454973931, 2339.497008143249, 2360.598698221298, 2366.95266094678, 2371.0752806405517, 2339.0526836631193, 2340.6840076589615, 2352.752960939102, 2377.869217193054, 2380.2264264114146, 2276.760940101282, 2303.976960230393, 2310.202979971907, 2311.2026350908995, 2318.4435735423376, 2282.954340913189, 2286.542691461714, 2288.1305104060516, 2291.8281128915396, 2294.472271377576, 8579.0, 8608.741737747878, 8638.0, 8889.4666320021, 9179.403338783024, 5319.069162896478, 5427.185922111676, 5428.104362780136, 5429.348478182644, 5437.564994800407, 3495.860165593373, 3497.7026952708798, 3562.6793588576893, 3567.839447224881, 3615.222727113683, 1122.966311010671, 1124.2299025167786, 1128.091886031744, 1144.2619510415818, 1146.9483873225724, 12520.436580353815, 12581.559645412366, 12586.81119783204, 12606.68483287916, 12620.0, 4358.128374325148, 4476.977615111904, 4575.931361029588, 4603.562661547147, 4610.97694511532, 9807.362521436227, 9814.067663572092, 9820.950895245478, 9830.262730295257, 9847.212223022141, 5282.894342113136, 5285.127953887565, 5286.762095705702, 5287.154055351125, 5294.549963253166, 4327.545607711208, 4750.7862146202815, 4955.157623204064, 4963.8014479421145, 4976.353074100416, 3748.737588368788, 3773.584905660375, 3809.104860357814, 3842.558105817811, 3861.420786881934, 1150.3098141115263, 1196.0610920427423, 1200.0699457920007, 1207.6980754811298, 1214.623466725318, 701.4248316380518, 930.6324002019164, 964.7154089543601, 982.651158838602, 993.7118235711563, 6091.725872335755, 6222.160008398899, 6277.121203031579, 6412.198475190601, 6419.0, 468.97655117244, 469.9342092107108, 488.9706617602955, 507.53814029233223, 519.6128883981459, 4076.2458945095254, 4322.5677432256525, 4343.0, 4343.587359200871, 4438.955610443919, 10874.72813179661, 11340.716482088013, 11365.54537818478, 11415.714607134889, 11440.027597654293, 10571.894281057092, 10693.465326733787, 10717.35695858251, 11249.71875703114, 11263.549458021587, 8245.587720613945, 8468.364872634455, 8469.153084691481, 8491.61787719554, 8516.701915433054, 6081.179040829431, 6513.967430163008, 6568.0, 6591.406773390418, 6624.138861948109, 10192.388456692623, 10380.896191038295, 10464.424456654957, 10590.099841513558, 10764.677059688222, 10722.624708135178, 10831.837522437327, 10842.837357439486, 10894.128469722562, 10954.123670106532, 7194.172670143001, 7684.231576842271, 7853.842923141391, 7861.567613781297, 7935.444518883854, 8831.69089081879, 8838.513881736566, 8893.822123557622, 8905.821883562423, 8925.687600933936, 7809.0, 7893.881591776243, 7961.72133975308, 7972.083210430643, 8033.5326486422155, 7748.418868584766, 7809.882851757115, 7848.803779905548, 7934.087579928382, 7947.284744373034, 6682.131322927989, 7258.12902451688, 7296.270372962661, 7314.524555903849, 7328.3404493595835, 5472.507474327171, 5507.091329930517, 5529.032419326521, 5547.833564993057, 5589.273394458694, 5345.583420393521, 5374.677519348852, 5483.067878460592, 5492.91760623583, 5631.549476041989], "value": 4616.722336532512, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [331.78268234306523, 332.715528223369, 338.66810525684815, 339.24856442978796, 339.5772263531902, 5379.3813711423145, 5398.730063496829, 5400.972995135024, 5422.457754224575, 5426.945730542693, 5235.424103348629, 5266.236395722618, 5293.417724050361, 5304.0, 5314.840554783363, 3766.9434958475645, 4002.3596224604, 4016.9397459038137, 4107.876763697094, 4143.544210136883, 4132.5454200037975, 4166.312558427856, 4167.708260421772, 4179.937300940488, 4180.268453020724, 4154.6676265898805, 4154.896127596804, 4159.729617574863, 4175.206710724968, 4204.0540878302445, 3992.7803970781597, 4101.630853223194, 4168.749875007494, 4175.812088456027, 4194.748315101104, 3702.9259414811822, 3704.6480584344445, 3710.5139556496943, 3714.4428335749585, 3738.5139931808963, 5129.487051294841, 5137.409197942247, 5138.177891537373, 5171.637985341028, 5172.2241663750365, 4766.547178018082, 4784.617230621577, 4786.928196077061, 4814.446338671028, 4828.372311599504, 5580.302462192226, 5590.524805391547, 5594.804181853657, 5600.971995139998, 5604.551635869121, 3882.669973052294, 3894.3768996960353, 3996.0409501719378, 4061.086255592468, 4078.143589846136, 5636.844446888378, 5687.3743888172685, 5725.942740572625, 5732.484076433099, 5738.7991420300505, 4152.1695660867945, 4153.899216707575, 4159.708820382544, 4182.874513764592, 4205.726627769185, 4159.854405095807, 4176.2877220339515, 4176.7076304658385, 4224.556421575752, 4228.640565551963, 4745.691530050535, 4750.168720473903, 4756.6908150970075, 4762.880927976828, 4802.303665968415, 5526.696031718214, 5534.916976245359, 5559.6664200148125, 5592.636478628876, 5592.909382670422, 1341.610932829488, 1398.5804258722546, 1405.444849284527, 1408.6689627937426, 1426.3937826423728, 900.9549522523847, 914.1726737302752, 918.1415376622746, 919.3794188922451, 946.7017889364828, 4640.396748422683, 4733.928991065137, 4766.285057241442, 4773.9045219096115, 4802.519748025239, 4948.529889660476, 4961.950380496221, 5018.447970723218, 5020.067274099425, 5052.823151189691, 4482.618977386894, 4747.0, 4788.640851936118, 4809.907690154794, 4810.807567697253, 2741.575055866344, 2742.9576760831155, 2743.0, 2749.8350098994124, 2759.6274502941847, 5293.788248470095, 5321.813736519203, 5321.946780532146, 5329.241350354374, 5330.7068111253475, 4780.47024952012, 5069.847904562869, 5098.954714283563, 5155.871103222375, 5173.948260517422, 5126.538611525055, 5157.916837464099, 5163.277141200235, 5177.0, 5191.961607678555, 5032.245163225399, 5059.822906198266, 5460.972695136499, 5469.562435005269, 5697.4587414195585, 5543.61194716366, 5593.300837395325, 5607.495325420732, 5616.550675945833, 5643.435656434323, 5654.886902261849, 5762.279715035621, 5766.826995190151, 5795.710214489343, 5808.07070868659, 4055.655269302142, 4076.775777332275, 4079.5925405734974, 4102.502586555826, 4105.137921036616, 5677.659340439587, 5686.4029276926985, 5697.658140511582, 5742.59801813869, 5771.249737534094, 5316.3354580677415, 5616.0, 5616.297962754656, 5621.357961757967, 5629.746661400165, 5543.417941116286, 5561.165825126263, 5567.7494512747835, 5572.554195664418, 5583.302087239095, 5519.530839878656, 5523.861903452445, 5528.502434780728, 5555.694436806015, 5556.388797232382, 5345.33183352081, 5587.161925711176, 5594.804181853616, 5605.495505404533, 5606.803761868315, 5425.701586412785, 5438.401775804738, 5444.972775136099, 5449.891002180014, 5456.290682211287], "value": 4145.521528575444, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [747.0624366420144, 796.6494742313382, 819.5574389829493, 823.950562966222, 833.1668331668332, 15502.612434689125, 16863.57841053973, 16868.072256025913, 16878.240479178436, 16906.323747050134, 15235.619109522268, 15272.69454610907, 15366.231688415563, 15423.768643470328, 15452.5364239073, 660.7951535024134, 774.9496282741632, 783.5651213576463, 785.2618538573751, 795.1809636074838, 815.955122468267, 825.3644693585935, 826.0252901576138, 826.4834478450969, 826.68999125328, 870.4559650218613, 871.9912800871973, 877.3025444771422, 878.3412440669498, 878.5607196401799, 704.7568588836868, 832.0556168748453, 859.8151397449516, 870.7735988642967, 871.0766587417327, 616.094341318266, 616.901295792671, 621.2141640824361, 621.6208113051035, 621.6705146272437, 15894.602634934103, 15906.443274485453, 15916.602084947968, 15924.283407246587, 15936.203189840462, 15649.608759780982, 15703.371865125382, 15757.32188361788, 15971.92014039934, 16031.0, 12796.680082997906, 12864.22814631125, 12907.870921290854, 12929.612111636667, 12950.611481655566, 3860.903477413059, 4008.158286759784, 4008.6793056555407, 4095.5290141633795, 4115.814788334532, 79186.0, 79587.20412795855, 80663.0, 81322.59338703328, 82112.58943705303, 11989.580364687194, 12152.027837772957, 12212.938935305267, 12252.387380630933, 12602.81095783564, 23454.882725586263, 23463.76536234616, 23468.714379986817, 23474.0, 23479.882600586887, 8755.605997730117, 9001.414908030956, 9041.095890411038, 9292.581833817494, 9324.25405967521, 4818.4217893852265, 4978.327925730053, 5025.723585202849, 5037.596992240612, 5093.4651861554, 3585.4263317869018, 3707.073231692077, 3711.6102809205186, 3714.591394946554, 3717.665410113103, 655.7311502284041, 659.8977158540434, 665.7337065173872, 667.1960287853125, 683.8222062263748, 633.4457349818908, 684.1140722764032, 727.4653129949482, 729.2051663686607, 752.5597525447674, 10034.247431442525, 10163.542640581192, 10338.793224135476, 10445.373277603216, 10531.631392901212, 681.3322943515383, 756.6746299091443, 789.8420315936836, 790.2887401338841, 801.8837268596137, 4892.0, 5217.2695822584865, 5307.7080760557765, 5308.283381743415, 5391.892162156735, 105168.0, 113459.0, 114742.42628786803, 118279.40860295644, 119396.0, 101846.49076754569, 102626.0, 104314.0, 104331.4783426078, 105946.47026764817, 89096.10903891007, 89183.0, 89712.5514372424, 91778.54110729403, 91805.0, 10377.533011014371, 10429.68710938673, 10475.528601213116, 10494.68515944523, 10556.0, 52008.219876702635, 52429.95140097253, 52621.7368913153, 53155.747540197466, 54378.45621543734, 73419.63290183515, 80853.74450660688, 81222.0, 81258.59370703109, 81739.5913020431, 12903.354832258161, 12953.546625868426, 12985.285724919677, 13995.440182392998, 14245.21651309188, 15552.222388880284, 15727.842721573095, 15851.841481585498, 15891.125988070306, 15908.920455397649, 9873.901260987586, 12537.435815388148, 13109.934450327688, 13414.993875459184, 13837.238951857744, 14381.715101296253, 14450.205238711971, 14450.494232701805, 15254.847451525786, 15359.539213823604, 9510.625173633005, 13472.259025753678, 14710.338034788674, 14763.114213147246, 14931.701365972402, 12234.0, 12367.196132251374, 12438.19151755133, 12504.249745015328, 12853.550125745554, 12793.0, 12875.613731588068, 13090.803637945248, 13198.868011319764, 13227.404766785325], "value": 7924.906179189039, "unit": "score"}], "name": "dromaeo_css", "value": 7362.331391760249, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 111.0, 111.0, 110.0, 111.0, 112.0, 111.0, 110.0, 111.0, 111.0], "value": 109.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 120.0, 118.0, 176.0, 119.0, 117.0, 143.0, 116.0, 146.0, 122.0], "value": 132.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 160.0, 161.0, 161.0, 160.0, 159.0, 163.0, 160.0, 161.0], "value": 160.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 75.0, 76.0, 133.0, 75.0, 76.0, 73.0, 75.0, 104.0, 75.0], "value": 83.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 115.0, 84.0, 84.0, 84.0, 122.0, 84.0, 83.0, 121.0], "value": 94.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 147.0, 147.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 96.0, 95.0, 96.0, 95.0, 96.0, 95.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 55.0, 53.0, 52.0, 55.0, 54.0, 54.0, 54.0, 53.0], "value": 53.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 63.0, 63.0, 63.0, 62.0, 63.0, 63.0, 65.0, 63.0], "value": 63.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 76.0, 75.0, 75.0, 74.0, 75.0, 80.0, 78.0], "value": 75.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 124.0, 128.0, 119.0, 127.0, 127.0, 128.0, 120.0, 157.0, 131.0], "value": 128.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 157.0, 156.0, 155.0, 156.0, 157.0, 156.0, 164.0, 159.0, 153.0], "value": 156.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 66.0, 62.0, 63.0, 63.0, 70.0, 61.0, 65.0, 60.0], "value": 63.7, "unit": "score"}], "name": "kraken", "value": 1481.0000000000002, "alertThreshold": 2.0}]} 06:57:29 INFO - Return code: 0 06:57:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:57:29 INFO - # TBPL SUCCESS # 06:57:29 INFO - Running post-action listener: _resource_record_post_action 06:57:29 INFO - ##### 06:57:29 INFO - ##### Finished run-tests step (success) 06:57:29 INFO - ##### 06:57:29 INFO - Running post-run listener: _resource_record_post_run 06:57:29 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 495616; Write bytes: 298291200; Read time: 40; Write time: 196216 06:57:29 INFO - TinderboxPrint: CPU usage
13.0% 06:57:29 INFO - TinderboxPrint: I/O read bytes / time
495,616 / 40 06:57:29 INFO - TinderboxPrint: I/O write bytes / time
298,291,200 / 196,216 06:57:29 INFO - TinderboxPrint: CPU idle
8,279.3 (87.0%) 06:57:29 INFO - TinderboxPrint: CPU user
1,193.3 (12.5%) 06:57:29 INFO - TinderboxPrint: Swap in / out
0 / 0 06:57:29 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 5255168; Read time: 0; Write time: 312 06:57:29 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 495616; Write bytes: 293036032; Read time: 40; Write time: 195904 06:57:30 INFO - Running post-run listener: _upload_blobber_files 06:57:30 INFO - Blob upload gear active. 06:57:30 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:57:30 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 06:57:30 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:57:30 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:57:30 INFO - (blobuploader) - INFO - Open directory for files ... 06:57:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:57:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:57:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:57:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:57:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:57:32 INFO - (blobuploader) - INFO - Done attempting. 06:57:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:57:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:57:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:57:35 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:57:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:57:35 INFO - (blobuploader) - INFO - Done attempting. 06:57:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:57:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:57:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:57:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:57:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:57:36 INFO - (blobuploader) - INFO - Done attempting. 06:57:36 INFO - (blobuploader) - INFO - Iteration through files over. 06:57:36 INFO - Return code: 0 06:57:36 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:57:36 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:57:36 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/611918e4ba907ab7499f87533658ce14547e4492d7995e7758b4896dfe0ad457184d7b9da6a1a29e5725101d4d6627ccf72f4687abb82e440abce70303510ec3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e9010ce89fb9df4b843e1fbe299d59ebd5e82281c2f92b2b62f310d374ace56b3c7d06e64654da89e36881240558b2204799232e61f68c27064abd00f83cfec9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0ef712e2bcbac659c48e94aab9be6d9724aead0de69043f1353ed8b636b66e59343be3a3207a259288663b8bdef90ba7c173ab271b9e5a04ceb2b3f872d2bbc6"} 06:57:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:57:36 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:57:36 INFO - Contents: 06:57:36 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/611918e4ba907ab7499f87533658ce14547e4492d7995e7758b4896dfe0ad457184d7b9da6a1a29e5725101d4d6627ccf72f4687abb82e440abce70303510ec3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e9010ce89fb9df4b843e1fbe299d59ebd5e82281c2f92b2b62f310d374ace56b3c7d06e64654da89e36881240558b2204799232e61f68c27064abd00f83cfec9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0ef712e2bcbac659c48e94aab9be6d9724aead0de69043f1353ed8b636b66e59343be3a3207a259288663b8bdef90ba7c173ab271b9e5a04ceb2b3f872d2bbc6"} 06:57:36 INFO - Running post-run listener: copy_logs_to_upload_dir 06:57:36 INFO - Copying logs to upload dir... 06:57:36 INFO - mkdir: /builds/slave/test/build/upload/logs 06:57:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1230.919871 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-07-12 06:57:36.593011) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-12 06:57:36.596684) ========= 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=6dbc10da6d83fee962c624be000001a8-1468330623.740340-2115176594 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/611918e4ba907ab7499f87533658ce14547e4492d7995e7758b4896dfe0ad457184d7b9da6a1a29e5725101d4d6627ccf72f4687abb82e440abce70303510ec3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e9010ce89fb9df4b843e1fbe299d59ebd5e82281c2f92b2b62f310d374ace56b3c7d06e64654da89e36881240558b2204799232e61f68c27064abd00f83cfec9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0ef712e2bcbac659c48e94aab9be6d9724aead0de69043f1353ed8b636b66e59343be3a3207a259288663b8bdef90ba7c173ab271b9e5a04ceb2b3f872d2bbc6"} build_url:https://queue.taskcluster.net/v1/task/QjTOXqtgQ26IGcj4GJ4Tqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011400 build_url: 'https://queue.taskcluster.net/v1/task/QjTOXqtgQ26IGcj4GJ4Tqw/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/Fx-Team/sha512/611918e4ba907ab7499f87533658ce14547e4492d7995e7758b4896dfe0ad457184d7b9da6a1a29e5725101d4d6627ccf72f4687abb82e440abce70303510ec3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e9010ce89fb9df4b843e1fbe299d59ebd5e82281c2f92b2b62f310d374ace56b3c7d06e64654da89e36881240558b2204799232e61f68c27064abd00f83cfec9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0ef712e2bcbac659c48e94aab9be6d9724aead0de69043f1353ed8b636b66e59343be3a3207a259288663b8bdef90ba7c173ab271b9e5a04ceb2b3f872d2bbc6"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-12 06:57:36.622634) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 06:57:36.622968) ========= 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=6dbc10da6d83fee962c624be000001a8-1468330623.740340-2115176594 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004676 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 06:57:36.707275) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-12 06:57:36.707619) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-12 06:57:36.707926) ========= ========= Total master_lag: 0.17 =========