builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-048 starttime: 1468508703.37 results: success (0) buildid: 20160714053013 builduid: 6219fd58294247a5a4715e9faa93dc3c revision: 1d5210d6f9614812ebdfad13a0d6e25d4513c03e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-14 08:05:03.371692) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-14 08:05:03.372162) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-14 08:05:03.372441) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-14 08:05:03.388369) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 08:05:03.388732) ========= 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=fa44defc139c4ba8574fe040000001db-1468508308.717854-1747155146 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-14 08:05: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% 22.4M=0.001s 2016-07-14 08:05:04 (22.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.100804 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 08:05:03.507165) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 08:05:03.507495) ========= 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=fa44defc139c4ba8574fe040000001db-1468508308.717854-1747155146 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019885 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 08:05:03.557125) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 08:05:03.557445) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 1d5210d6f9614812ebdfad13a0d6e25d4513c03e --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 1d5210d6f9614812ebdfad13a0d6e25d4513c03e --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=fa44defc139c4ba8574fe040000001db-1468508308.717854-1747155146 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-14 08:05:04,262 truncating revision to first 12 chars 2016-07-14 08:05:04,262 Setting DEBUG logging. 2016-07-14 08:05:04,262 attempt 1/10 2016-07-14 08:05:04,262 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/1d5210d6f961?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-14 08:05:04,859 unpacking tar archive at: fx-team-1d5210d6f961/testing/mozharness/ program finished with exit code 0 elapsedTime=0.928398 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 08:05:04.499651) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-14 08:05:04.500017) ========= script_repo_revision: 1d5210d6f9614812ebdfad13a0d6e25d4513c03e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-14 08:05:04.500447) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-14 08:05:04.500754) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-14 08:05:04.510614) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-07-14 08:05:04.510968) ========= /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=fa44defc139c4ba8574fe040000001db-1468508308.717854-1747155146 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:05:05 INFO - MultiFileLogger online at 20160714 08:05:05 in /builds/slave/test 08:05: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 08:05:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:05:05 INFO - {'append_to_log': False, 08:05:05 INFO - 'base_work_dir': '/builds/slave/test', 08:05:05 INFO - 'blob_upload_branch': 'Fx-Team', 08:05:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:05:05 INFO - 'branch': 'Fx-Team', 08:05:05 INFO - 'buildbot_json_path': 'buildprops.json', 08:05:05 INFO - 'config_files': ('talos/linux_config.py',), 08:05:05 INFO - 'default_actions': ('clobber', 08:05:05 INFO - 'read-buildbot-config', 08:05:05 INFO - 'download-and-extract', 08:05:05 INFO - 'populate-webroot', 08:05:05 INFO - 'create-virtualenv', 08:05:05 INFO - 'install', 08:05:05 INFO - 'run-tests'), 08:05:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:05:05 INFO - 'download_minidump_stackwalk': True, 08:05:05 INFO - 'download_symbols': 'ondemand', 08:05:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:05:05 INFO - 'tooltool.py': '/tools/tooltool.py', 08:05:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:05:05 INFO - '/tools/misc-python/virtualenv.py')}, 08:05:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:05:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:05:05 INFO - 'installer_path': 'installer.exe', 08:05:05 INFO - 'log_level': 'info', 08:05:05 INFO - 'log_name': 'talos', 08:05:05 INFO - 'log_to_console': True, 08:05:05 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:05:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:05:05 INFO - 'opt_config_files': (), 08:05:05 INFO - 'pip_index': False, 08:05:05 INFO - 'sps_profile': False, 08:05:05 INFO - 'sps_profile_interval': 0, 08:05:05 INFO - 'suite': 'dromaeojs', 08:05:05 INFO - 'system_bits': '32', 08:05:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:05:05 INFO - 'title': 'talos-linux64-ix-048', 08:05:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:05:05 INFO - 'use_talos_json': True, 08:05:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:05:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:05:05 INFO - 'work_dir': 'build'} 08:05:05 INFO - ##### 08:05:05 INFO - ##### Running clobber step. 08:05:05 INFO - ##### 08:05:05 INFO - Running pre-action listener: _resource_record_pre_action 08:05:05 INFO - Running main action method: clobber 08:05:05 INFO - rmtree: /builds/slave/test/build 08:05:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:05:06 INFO - Running post-action listener: _resource_record_post_action 08:05:06 INFO - ##### 08:05:06 INFO - ##### Finished clobber step (success) 08:05:06 INFO - ##### 08:05:06 INFO - ##### 08:05:06 INFO - ##### Running read-buildbot-config step. 08:05:06 INFO - ##### 08:05:06 INFO - Running pre-action listener: _resource_record_pre_action 08:05:06 INFO - Running main action method: read_buildbot_config 08:05:06 INFO - Using buildbot properties: 08:05:06 INFO - { 08:05:06 INFO - "project": "", 08:05:06 INFO - "product": "firefox", 08:05:06 INFO - "script_repo_revision": "production", 08:05:06 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 08:05:06 INFO - "repository": "", 08:05:06 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 08:05:06 INFO - "buildid": "20160714053013", 08:05:06 INFO - "pgo_build": "True", 08:05:06 INFO - "basedir": "/builds/slave/test", 08:05:06 INFO - "buildnumber": 288, 08:05:06 INFO - "slavename": "talos-linux64-ix-048", 08:05:06 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 08:05:06 INFO - "platform": "ubuntu64_hw", 08:05:06 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 08:05:06 INFO - "branch": "fx-team", 08:05:06 INFO - "repo_path": "integration/fx-team", 08:05:06 INFO - "revision": "1d5210d6f9614812ebdfad13a0d6e25d4513c03e", 08:05:06 INFO - "stage_platform": "linux64-pgo", 08:05:06 INFO - "builduid": "6219fd58294247a5a4715e9faa93dc3c", 08:05:06 INFO - "slavebuilddir": "test" 08:05:06 INFO - } 08:05:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/FAsVQeQoRj2zL56XiX8OuA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 08:05:06 INFO - Running post-action listener: _resource_record_post_action 08:05:06 INFO - ##### 08:05:06 INFO - ##### Finished read-buildbot-config step (success) 08:05:06 INFO - ##### 08:05:06 INFO - ##### 08:05:06 INFO - ##### Running download-and-extract step. 08:05:06 INFO - ##### 08:05:06 INFO - Running pre-action listener: _resource_record_pre_action 08:05:06 INFO - Running main action method: download_and_extract 08:05:06 INFO - mkdir: /builds/slave/test/build/tests 08:05: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')]} 08:05:06 INFO - https://queue.taskcluster.net/v1/task/FAsVQeQoRj2zL56XiX8OuA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:05:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FAsVQeQoRj2zL56XiX8OuA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:05:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FAsVQeQoRj2zL56XiX8OuA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:05:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FAsVQeQoRj2zL56XiX8OuA/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 08:05:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FAsVQeQoRj2zL56XiX8OuA/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 08:05:08 INFO - Downloaded 1361 bytes. 08:05:08 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:05:08 INFO - Using the following test package requirements: 08:05:08 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:05:08 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:05:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:05:08 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:05:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:05:08 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:05:08 INFO - u'jsshell-linux-x86_64.zip'], 08:05:08 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:05:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:05:08 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:05:08 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:05:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:05:08 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:05:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:05:08 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:05:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:05:08 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:05:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:05:08 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:05:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:05:08 INFO - https://queue.taskcluster.net/v1/task/FAsVQeQoRj2zL56XiX8OuA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:05:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FAsVQeQoRj2zL56XiX8OuA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:05:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FAsVQeQoRj2zL56XiX8OuA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:05:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FAsVQeQoRj2zL56XiX8OuA/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 08:05:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FAsVQeQoRj2zL56XiX8OuA/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 08:05:10 INFO - Downloaded 24327085 bytes. 08:05: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'] 08:05: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 08:05:11 INFO - Return code: 0 08:05:11 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 08:05: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')]} 08:05:11 INFO - https://queue.taskcluster.net/v1/task/FAsVQeQoRj2zL56XiX8OuA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:05:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FAsVQeQoRj2zL56XiX8OuA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:05:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FAsVQeQoRj2zL56XiX8OuA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:05:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FAsVQeQoRj2zL56XiX8OuA/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 08:05:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FAsVQeQoRj2zL56XiX8OuA/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 08:05:12 INFO - Downloaded 24327085 bytes. 08:05:12 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'] 08:05:12 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 08:05:14 INFO - Return code: 0 08:05:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:05:14 INFO - https://queue.taskcluster.net/v1/task/FAsVQeQoRj2zL56XiX8OuA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:05:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FAsVQeQoRj2zL56XiX8OuA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:05:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FAsVQeQoRj2zL56XiX8OuA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:05:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FAsVQeQoRj2zL56XiX8OuA/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 08:05:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FAsVQeQoRj2zL56XiX8OuA/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 08:05:15 INFO - Downloaded 14403317 bytes. 08:05:15 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'] 08:05:15 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 08:05:15 INFO - Return code: 0 08:05:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:05:15 INFO - https://queue.taskcluster.net/v1/task/FAsVQeQoRj2zL56XiX8OuA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:05:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FAsVQeQoRj2zL56XiX8OuA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:05:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FAsVQeQoRj2zL56XiX8OuA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:05:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FAsVQeQoRj2zL56XiX8OuA/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 08:05:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FAsVQeQoRj2zL56XiX8OuA/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 08:05:17 INFO - Downloaded 60810775 bytes. 08:05:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FAsVQeQoRj2zL56XiX8OuA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:05:17 INFO - mkdir: /builds/slave/test/properties 08:05:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:05:17 INFO - Writing to file /builds/slave/test/properties/build_url 08:05:17 INFO - Contents: 08:05:17 INFO - build_url:https://queue.taskcluster.net/v1/task/FAsVQeQoRj2zL56XiX8OuA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:05:18 INFO - Running post-action listener: _resource_record_post_action 08:05:18 INFO - Running post-action listener: set_extra_try_arguments 08:05:18 INFO - ##### 08:05:18 INFO - ##### Finished download-and-extract step (success) 08:05:18 INFO - ##### 08:05:18 INFO - ##### 08:05:18 INFO - ##### Running populate-webroot step. 08:05:18 INFO - ##### 08:05:18 INFO - Running pre-action listener: _resource_record_pre_action 08:05:18 INFO - Running main action method: populate_webroot 08:05:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:05:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:05:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:05:18 INFO - '--tppagecycles', 08:05:18 INFO - '7'], 08:05:18 INFO - 'tests': ['tsvgm']}}, 08:05:18 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:05:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:05:18 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:05:18 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:05:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:05:18 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:05:18 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:05:18 INFO - 'talos_options': ['--disable-e10s'], 08:05:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:05:18 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:05:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:05:18 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:05:18 INFO - 'talos_options': ['--disable-e10s'], 08:05:18 INFO - 'tests': ['damp', 'tps']}, 08:05:18 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:05:18 INFO - 'tests': ['damp', 'tps']}, 08:05:18 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:05:18 INFO - 'tests': ['dromaeo_dom']}, 08:05:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:05:18 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:05:18 INFO - 'tests': ['basic_compositor_video']}, 08:05:18 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:05:18 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:05:18 INFO - 'tests': ['a11yr', 08:05:18 INFO - 'ts_paint', 08:05:18 INFO - 'tpaint', 08:05:18 INFO - 'sessionrestore', 08:05:18 INFO - 'sessionrestore_no_auto_restore', 08:05:18 INFO - 'tabpaint']}, 08:05:18 INFO - 'other-e10s': {'tests': ['a11yr', 08:05:18 INFO - 'ts_paint', 08:05:18 INFO - 'tpaint', 08:05:18 INFO - 'sessionrestore', 08:05:18 INFO - 'sessionrestore_no_auto_restore', 08:05:18 INFO - 'tabpaint']}, 08:05:18 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:05:18 INFO - 'ts_paint', 08:05:18 INFO - 'tpaint', 08:05:18 INFO - 'sessionrestore', 08:05:18 INFO - 'sessionrestore_no_auto_restore', 08:05:18 INFO - 'tabpaint']}, 08:05:18 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:05:18 INFO - 'ts_paint', 08:05:18 INFO - 'tpaint', 08:05:18 INFO - 'sessionrestore', 08:05:18 INFO - 'sessionrestore_no_auto_restore', 08:05:18 INFO - 'tabpaint']}, 08:05:18 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:05:18 INFO - 'tests': ['a11yr', 08:05:18 INFO - 'ts_paint', 08:05:18 INFO - 'tpaint', 08:05:18 INFO - 'sessionrestore', 08:05:18 INFO - 'sessionrestore_no_auto_restore', 08:05:18 INFO - 'tabpaint']}, 08:05:18 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:05:18 INFO - 'tests': ['a11yr', 08:05:18 INFO - 'ts_paint', 08:05:18 INFO - 'tpaint', 08:05:18 INFO - 'sessionrestore', 08:05:18 INFO - 'sessionrestore_no_auto_restore', 08:05:18 INFO - 'tabpaint']}, 08:05:18 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:05:18 INFO - 'tests': ['tsvgx', 08:05:18 INFO - 'tsvgr_opacity', 08:05:18 INFO - 'tart', 08:05:18 INFO - 'tscrollx', 08:05:18 INFO - 'cart']}, 08:05:18 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:05:18 INFO - 'tsvgr_opacity', 08:05:18 INFO - 'tart', 08:05:18 INFO - 'tscrollx', 08:05:18 INFO - 'cart']}, 08:05:18 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:05:18 INFO - 'talos_options': ['--disable-e10s'], 08:05:18 INFO - 'tests': ['tp5o']}, 08:05:18 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:05:18 INFO - 'tests': ['tp5o']}, 08:05:18 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:05:18 INFO - 'talos_options': ['--disable-e10s', 08:05:18 INFO - '--xperf_path', 08:05:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:05:18 INFO - 'tests': ['tp5n']}, 08:05:18 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:05:18 INFO - 'talos_options': ['--xperf_path', 08:05:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:05:18 INFO - 'tests': ['tp5n']}}, 08:05:18 INFO - 'talos.zip': {'path': '', 08:05:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:05:18 INFO - Running post-action listener: _resource_record_post_action 08:05:18 INFO - ##### 08:05:18 INFO - ##### Finished populate-webroot step (success) 08:05:18 INFO - ##### 08:05:18 INFO - ##### 08:05:18 INFO - ##### Running create-virtualenv step. 08:05:18 INFO - ##### 08:05:18 INFO - Running pre-action listener: _resource_record_pre_action 08:05:18 INFO - Running main action method: create_virtualenv 08:05:18 INFO - Creating virtualenv /builds/slave/test/build/venv 08:05:18 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:05:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:05:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:05:18 INFO - Using real prefix '/usr' 08:05:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:05:19 INFO - Installing distribute.............................................................................................................................................................................................done. 08:05:21 INFO - Installing pip.................done. 08:05:21 INFO - Return code: 0 08:05:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:05:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:05:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:05:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a97030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bfa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d58180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d563b0>, '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 0x1d572b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d57740>, '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': 'fa44defc139c4ba8574fe040000001db-1468508308.717854-1747155146', '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 08:05:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:05:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:05:21 INFO - Using env: {'DISPLAY': ':0', 08:05:21 INFO - 'HOME': '/home/cltbld', 08:05:21 INFO - 'LANG': 'en_US.UTF-8', 08:05:21 INFO - 'LANGUAGE': 'en_US:en', 08:05:21 INFO - 'LOGNAME': 'cltbld', 08:05:21 INFO - 'MAIL': '/var/mail/cltbld', 08:05:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:21 INFO - 'MOZ_NO_REMOTE': '1', 08:05:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:05:21 INFO - 'NO_EM_RESTART': '1', 08:05:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:05:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:21 INFO - 'PWD': '/builds/slave/test', 08:05:21 INFO - 'SHELL': '/bin/bash', 08:05:21 INFO - 'SHLVL': '1', 08:05:21 INFO - 'TERM': 'linux', 08:05:21 INFO - 'TMOUT': '86400', 08:05:21 INFO - 'USER': 'cltbld', 08:05:21 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1468508308.717854-1747155146', 08:05:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:21 INFO - '_': '/tools/buildbot/bin/python'} 08:05:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:21 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:05:21 INFO - Cleaning up... 08:05:21 INFO - Return code: 0 08:05:21 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:05:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:05:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:05:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a97030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bfa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d58180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d563b0>, '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 0x1d572b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d57740>, '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': 'fa44defc139c4ba8574fe040000001db-1468508308.717854-1747155146', '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 08:05:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:05:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:05:21 INFO - Using env: {'DISPLAY': ':0', 08:05:21 INFO - 'HOME': '/home/cltbld', 08:05:21 INFO - 'LANG': 'en_US.UTF-8', 08:05:21 INFO - 'LANGUAGE': 'en_US:en', 08:05:21 INFO - 'LOGNAME': 'cltbld', 08:05:21 INFO - 'MAIL': '/var/mail/cltbld', 08:05:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:21 INFO - 'MOZ_NO_REMOTE': '1', 08:05:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:05:21 INFO - 'NO_EM_RESTART': '1', 08:05:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:05:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:21 INFO - 'PWD': '/builds/slave/test', 08:05:21 INFO - 'SHELL': '/bin/bash', 08:05:21 INFO - 'SHLVL': '1', 08:05:21 INFO - 'TERM': 'linux', 08:05:21 INFO - 'TMOUT': '86400', 08:05:21 INFO - 'USER': 'cltbld', 08:05:21 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1468508308.717854-1747155146', 08:05:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:21 INFO - '_': '/tools/buildbot/bin/python'} 08:05:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:21 INFO - Downloading/unpacking psutil>=3.1.1 08:05:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:05:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:05:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:05:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:05:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:05:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:05:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:05:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:05:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:05:23 INFO - Installing collected packages: psutil 08:05:23 INFO - Running setup.py install for psutil 08:05:23 INFO - building 'psutil._psutil_linux' extension 08:05:23 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 08:05:23 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 08:05:23 INFO - building 'psutil._psutil_posix' extension 08:05:23 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 08:05:24 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 08:05:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:05:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:05:24 INFO - Successfully installed psutil 08:05:24 INFO - Cleaning up... 08:05:24 INFO - Return code: 0 08:05:24 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:05:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:05:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:05:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a97030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bfa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d58180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d563b0>, '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 0x1d572b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d57740>, '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': 'fa44defc139c4ba8574fe040000001db-1468508308.717854-1747155146', '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 08:05:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:05:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:05:24 INFO - Using env: {'DISPLAY': ':0', 08:05:24 INFO - 'HOME': '/home/cltbld', 08:05:24 INFO - 'LANG': 'en_US.UTF-8', 08:05:24 INFO - 'LANGUAGE': 'en_US:en', 08:05:24 INFO - 'LOGNAME': 'cltbld', 08:05:24 INFO - 'MAIL': '/var/mail/cltbld', 08:05:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:24 INFO - 'MOZ_NO_REMOTE': '1', 08:05:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:05:24 INFO - 'NO_EM_RESTART': '1', 08:05:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:05:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:24 INFO - 'PWD': '/builds/slave/test', 08:05:24 INFO - 'SHELL': '/bin/bash', 08:05:24 INFO - 'SHLVL': '1', 08:05:24 INFO - 'TERM': 'linux', 08:05:24 INFO - 'TMOUT': '86400', 08:05:24 INFO - 'USER': 'cltbld', 08:05:24 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1468508308.717854-1747155146', 08:05:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:24 INFO - '_': '/tools/buildbot/bin/python'} 08:05:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:24 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:05:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:05:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:05:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:05:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:05:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:05:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:05:26 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:05:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:05:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:05:26 INFO - Installing collected packages: mozsystemmonitor 08:05:26 INFO - Running setup.py install for mozsystemmonitor 08:05:26 INFO - Successfully installed mozsystemmonitor 08:05:26 INFO - Cleaning up... 08:05:26 INFO - Return code: 0 08:05:26 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:05:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:05:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:05:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a97030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bfa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d58180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d563b0>, '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 0x1d572b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d57740>, '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': 'fa44defc139c4ba8574fe040000001db-1468508308.717854-1747155146', '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 08:05:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:05:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:05:26 INFO - Using env: {'DISPLAY': ':0', 08:05:26 INFO - 'HOME': '/home/cltbld', 08:05:26 INFO - 'LANG': 'en_US.UTF-8', 08:05:26 INFO - 'LANGUAGE': 'en_US:en', 08:05:26 INFO - 'LOGNAME': 'cltbld', 08:05:26 INFO - 'MAIL': '/var/mail/cltbld', 08:05:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:26 INFO - 'MOZ_NO_REMOTE': '1', 08:05:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:05:26 INFO - 'NO_EM_RESTART': '1', 08:05:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:05:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:26 INFO - 'PWD': '/builds/slave/test', 08:05:26 INFO - 'SHELL': '/bin/bash', 08:05:26 INFO - 'SHLVL': '1', 08:05:26 INFO - 'TERM': 'linux', 08:05:26 INFO - 'TMOUT': '86400', 08:05:26 INFO - 'USER': 'cltbld', 08:05:26 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1468508308.717854-1747155146', 08:05:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:26 INFO - '_': '/tools/buildbot/bin/python'} 08:05:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:26 INFO - Downloading/unpacking jsonschema==2.5.1 08:05: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 08:05: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 08:05: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 08:05: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 08:05: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 08:05: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 08:05:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:05:28 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:05: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 08:05: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 08:05: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 08:05: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 08:05: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 08:05: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 08:05:28 INFO - Downloading functools32-3.2.3-2.tar.gz 08:05:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:05:28 INFO - warning: no files found matching '*.txt' 08:05:28 INFO - no previously-included directories found matching 'build' 08:05:28 INFO - no previously-included directories found matching 'dist' 08:05:28 INFO - no previously-included directories found matching '.git*' 08:05:28 INFO - Installing collected packages: jsonschema, functools32 08:05:28 INFO - Running setup.py install for functools32 08:05:29 INFO - warning: no files found matching '*.txt' 08:05:29 INFO - no previously-included directories found matching 'build' 08:05:29 INFO - no previously-included directories found matching 'dist' 08:05:29 INFO - no previously-included directories found matching '.git*' 08:05:29 INFO - Successfully installed jsonschema functools32 08:05:29 INFO - Cleaning up... 08:05:29 INFO - Return code: 0 08:05:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:05: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')]} 08:05:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05: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')]} 08:05:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a97030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bfa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d58180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d563b0>, '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 0x1d572b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d57740>, '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': 'fa44defc139c4ba8574fe040000001db-1468508308.717854-1747155146', '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 08:05:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:05:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:05:29 INFO - Using env: {'DISPLAY': ':0', 08:05:29 INFO - 'HOME': '/home/cltbld', 08:05:29 INFO - 'LANG': 'en_US.UTF-8', 08:05:29 INFO - 'LANGUAGE': 'en_US:en', 08:05:29 INFO - 'LOGNAME': 'cltbld', 08:05:29 INFO - 'MAIL': '/var/mail/cltbld', 08:05:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:29 INFO - 'MOZ_NO_REMOTE': '1', 08:05:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:05:29 INFO - 'NO_EM_RESTART': '1', 08:05:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:05:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:29 INFO - 'PWD': '/builds/slave/test', 08:05:29 INFO - 'SHELL': '/bin/bash', 08:05:29 INFO - 'SHLVL': '1', 08:05:29 INFO - 'TERM': 'linux', 08:05:29 INFO - 'TMOUT': '86400', 08:05:29 INFO - 'USER': 'cltbld', 08:05:29 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1468508308.717854-1747155146', 08:05:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:29 INFO - '_': '/tools/buildbot/bin/python'} 08:05:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:29 INFO - Downloading/unpacking blobuploader==1.2.4 08:05:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:05:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:05:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:05:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:05:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:05:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:05:31 INFO - Downloading blobuploader-1.2.4.tar.gz 08:05:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:05:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:05:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:05:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:05:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:05:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:05:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:05:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:05:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:05:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:05:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:05:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:05:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:05:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:05:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:05:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:05:31 INFO - Downloading docopt-0.6.1.tar.gz 08:05:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:05:32 INFO - Installing collected packages: blobuploader, requests, docopt 08:05:32 INFO - Running setup.py install for blobuploader 08:05:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:05:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:05:32 INFO - Running setup.py install for requests 08:05:32 INFO - Running setup.py install for docopt 08:05:32 INFO - Successfully installed blobuploader requests docopt 08:05:32 INFO - Cleaning up... 08:05:32 INFO - Return code: 0 08:05:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:05: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')]} 08:05:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05: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')]} 08:05:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a97030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bfa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d58180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d563b0>, '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 0x1d572b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d57740>, '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': 'fa44defc139c4ba8574fe040000001db-1468508308.717854-1747155146', '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 08:05:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:05:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:05:32 INFO - Using env: {'DISPLAY': ':0', 08:05:32 INFO - 'HOME': '/home/cltbld', 08:05:32 INFO - 'LANG': 'en_US.UTF-8', 08:05:32 INFO - 'LANGUAGE': 'en_US:en', 08:05:32 INFO - 'LOGNAME': 'cltbld', 08:05:32 INFO - 'MAIL': '/var/mail/cltbld', 08:05:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:32 INFO - 'MOZ_NO_REMOTE': '1', 08:05:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:05:32 INFO - 'NO_EM_RESTART': '1', 08:05:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:05:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:32 INFO - 'PWD': '/builds/slave/test', 08:05:32 INFO - 'SHELL': '/bin/bash', 08:05:32 INFO - 'SHLVL': '1', 08:05:32 INFO - 'TERM': 'linux', 08:05:32 INFO - 'TMOUT': '86400', 08:05:32 INFO - 'USER': 'cltbld', 08:05:32 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1468508308.717854-1747155146', 08:05:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:32 INFO - '_': '/tools/buildbot/bin/python'} 08:05:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:05:32 INFO - Running setup.py (path:/tmp/pip-xAmZ8Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:05:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:05:32 INFO - Running setup.py (path:/tmp/pip-ywGA7n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:05:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:05:33 INFO - Running setup.py (path:/tmp/pip-qa79JP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:05:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:05:33 INFO - Running setup.py (path:/tmp/pip-QzSQuG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:05:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:05:33 INFO - Running setup.py (path:/tmp/pip-QrOU1t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:05:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:05:33 INFO - Running setup.py (path:/tmp/pip-ziw9PN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:05:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:05:33 INFO - Running setup.py (path:/tmp/pip-TwL1Mm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:05:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:05:33 INFO - Running setup.py (path:/tmp/pip-eydbaf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:05:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:05:33 INFO - Running setup.py (path:/tmp/pip-hWFNhd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:05:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:05:33 INFO - Running setup.py (path:/tmp/pip-ABPBQm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:05:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:05:33 INFO - Running setup.py (path:/tmp/pip-qdqq2o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:05:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:05:33 INFO - Running setup.py (path:/tmp/pip-9qEBBN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:05:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:05:33 INFO - Running setup.py (path:/tmp/pip-12LAWV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:05:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:05:33 INFO - Running setup.py (path:/tmp/pip-wTWHtW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:05:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:05:33 INFO - Running setup.py (path:/tmp/pip-pkPrD6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:05:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:05:33 INFO - Running setup.py (path:/tmp/pip-932gj6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:05:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:05:34 INFO - Running setup.py (path:/tmp/pip-2scaAQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:05:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:05:34 INFO - Running setup.py install for manifestparser 08:05:34 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:05:34 INFO - Running setup.py install for mozcrash 08:05:34 INFO - Running setup.py install for mozdebug 08:05:34 INFO - Running setup.py install for mozdevice 08:05:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:05:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:05:34 INFO - Running setup.py install for mozfile 08:05:34 INFO - Running setup.py install for mozhttpd 08:05:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:05:34 INFO - Running setup.py install for mozinfo 08:05:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:05:34 INFO - Running setup.py install for mozInstall 08:05:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:05:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:05:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:05:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:05:34 INFO - Running setup.py install for mozleak 08:05:35 INFO - Running setup.py install for mozlog 08:05:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:05:35 INFO - Running setup.py install for moznetwork 08:05:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:05:35 INFO - Running setup.py install for mozprocess 08:05:35 INFO - Running setup.py install for mozprofile 08:05:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:05:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:05:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:05:35 INFO - Running setup.py install for mozrunner 08:05:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:05:35 INFO - Running setup.py install for mozscreenshot 08:05:35 INFO - Running setup.py install for moztest 08:05:35 INFO - Running setup.py install for mozversion 08:05:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:05:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:05:35 INFO - Cleaning up... 08:05:35 INFO - Return code: 0 08:05:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:05:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:05:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:05:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a97030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bfa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d58180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d563b0>, '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 0x1d572b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d57740>, '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': 'fa44defc139c4ba8574fe040000001db-1468508308.717854-1747155146', '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 08:05:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:05:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:05:35 INFO - Using env: {'DISPLAY': ':0', 08:05:35 INFO - 'HOME': '/home/cltbld', 08:05:35 INFO - 'LANG': 'en_US.UTF-8', 08:05:35 INFO - 'LANGUAGE': 'en_US:en', 08:05:35 INFO - 'LOGNAME': 'cltbld', 08:05:35 INFO - 'MAIL': '/var/mail/cltbld', 08:05:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:35 INFO - 'MOZ_NO_REMOTE': '1', 08:05:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:05:35 INFO - 'NO_EM_RESTART': '1', 08:05:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:05:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:35 INFO - 'PWD': '/builds/slave/test', 08:05:35 INFO - 'SHELL': '/bin/bash', 08:05:35 INFO - 'SHLVL': '1', 08:05:35 INFO - 'TERM': 'linux', 08:05:35 INFO - 'TMOUT': '86400', 08:05:35 INFO - 'USER': 'cltbld', 08:05:35 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1468508308.717854-1747155146', 08:05:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:35 INFO - '_': '/tools/buildbot/bin/python'} 08:05:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:05:36 INFO - Running setup.py (path:/tmp/pip-QiNGRy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:05:36 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:05:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:05:36 INFO - Running setup.py (path:/tmp/pip-IVUyNO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:05:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:05:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:05:36 INFO - Running setup.py (path:/tmp/pip-__71mL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:05:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:05:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:05:36 INFO - Running setup.py (path:/tmp/pip-MtHzFw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:05:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:05:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:05:36 INFO - Running setup.py (path:/tmp/pip-ny64cn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:05:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:05:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:05:36 INFO - Running setup.py (path:/tmp/pip-idYHSZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:05:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:05:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:05:36 INFO - Running setup.py (path:/tmp/pip-wyhcTD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:05:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:05:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:05:36 INFO - Running setup.py (path:/tmp/pip-sagzdw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:05:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:05:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:05:36 INFO - Running setup.py (path:/tmp/pip-9457y3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:05:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:05:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:05:36 INFO - Running setup.py (path:/tmp/pip-4bjEB4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:05:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:05:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:05:36 INFO - Running setup.py (path:/tmp/pip-xsxExj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:05:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:05:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:05:36 INFO - Running setup.py (path:/tmp/pip-MzK2vE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:05:37 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)) 08:05:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:05:37 INFO - Running setup.py (path:/tmp/pip-pabHTB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:05:37 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)) 08:05:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:05:37 INFO - Running setup.py (path:/tmp/pip-hk0UEt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:05:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:05:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:05:37 INFO - Running setup.py (path:/tmp/pip-NQj48p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:05:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:05:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:05:37 INFO - Running setup.py (path:/tmp/pip-CYn0vl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:05:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:05:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:05:37 INFO - Running setup.py (path:/tmp/pip-3mHPIv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:05:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:05:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:05:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:05:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:05:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:05:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:05:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:05:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:05:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:05:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:05:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:05:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:05:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:05:39 INFO - Downloading blessings-1.6.tar.gz 08:05:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:05:39 INFO - Installing collected packages: blessings 08:05:39 INFO - Running setup.py install for blessings 08:05:39 INFO - Successfully installed blessings 08:05:39 INFO - Cleaning up... 08:05:39 INFO - Return code: 0 08:05:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:05:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:05:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:05:39 INFO - Reading from file tmpfile_stdout 08:05:39 INFO - Current package versions: 08:05:39 INFO - argparse == 1.2.1 08:05:39 INFO - blessings == 1.6 08:05:39 INFO - blobuploader == 1.2.4 08:05:39 INFO - docopt == 0.6.1 08:05:39 INFO - functools32 == 3.2.3-2 08:05:39 INFO - jsonschema == 2.5.1 08:05:39 INFO - manifestparser == 1.1 08:05:39 INFO - mozInstall == 1.12 08:05:39 INFO - mozcrash == 0.17 08:05:39 INFO - mozdebug == 0.1 08:05:39 INFO - mozdevice == 0.48 08:05:39 INFO - mozfile == 1.2 08:05:39 INFO - mozhttpd == 0.7 08:05:39 INFO - mozinfo == 0.9 08:05:39 INFO - mozleak == 0.1 08:05:39 INFO - mozlog == 3.2 08:05:39 INFO - moznetwork == 0.27 08:05:39 INFO - mozprocess == 0.23 08:05:39 INFO - mozprofile == 0.28 08:05:39 INFO - mozrunner == 6.12 08:05:39 INFO - mozscreenshot == 0.1 08:05:39 INFO - mozsystemmonitor == 0.3 08:05:39 INFO - moztest == 0.7 08:05:39 INFO - mozversion == 1.4 08:05:39 INFO - psutil == 3.1.1 08:05:39 INFO - requests == 1.2.3 08:05:39 INFO - wsgiref == 0.1.2 08:05:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:05:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:05:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:05:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a97030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bfa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d58180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d563b0>, '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 0x1d572b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d57740>, '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': 'fa44defc139c4ba8574fe040000001db-1468508308.717854-1747155146', '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 08:05:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:05:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:05:39 INFO - Using env: {'DISPLAY': ':0', 08:05:39 INFO - 'HOME': '/home/cltbld', 08:05:39 INFO - 'LANG': 'en_US.UTF-8', 08:05:39 INFO - 'LANGUAGE': 'en_US:en', 08:05:39 INFO - 'LOGNAME': 'cltbld', 08:05:39 INFO - 'MAIL': '/var/mail/cltbld', 08:05:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:39 INFO - 'MOZ_NO_REMOTE': '1', 08:05:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:05:39 INFO - 'NO_EM_RESTART': '1', 08:05:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:05:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:39 INFO - 'PWD': '/builds/slave/test', 08:05:39 INFO - 'SHELL': '/bin/bash', 08:05:39 INFO - 'SHLVL': '1', 08:05:39 INFO - 'TERM': 'linux', 08:05:39 INFO - 'TMOUT': '86400', 08:05:39 INFO - 'USER': 'cltbld', 08:05:39 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1468508308.717854-1747155146', 08:05:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:39 INFO - '_': '/tools/buildbot/bin/python'} 08:05:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:05:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:05:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:05:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:05:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:05:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:05:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:05:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:05:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:05:39 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:05:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:05:39 INFO - Cleaning up... 08:05:39 INFO - Return code: 0 08:05:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:05:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:05:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:05:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a97030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bfa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d58180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d563b0>, '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 0x1d572b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d57740>, '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': 'fa44defc139c4ba8574fe040000001db-1468508308.717854-1747155146', '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 08:05:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:05:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:05:39 INFO - Using env: {'DISPLAY': ':0', 08:05:39 INFO - 'HOME': '/home/cltbld', 08:05:39 INFO - 'LANG': 'en_US.UTF-8', 08:05:39 INFO - 'LANGUAGE': 'en_US:en', 08:05:39 INFO - 'LOGNAME': 'cltbld', 08:05:39 INFO - 'MAIL': '/var/mail/cltbld', 08:05:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:39 INFO - 'MOZ_NO_REMOTE': '1', 08:05:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:05:39 INFO - 'NO_EM_RESTART': '1', 08:05:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:05:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:39 INFO - 'PWD': '/builds/slave/test', 08:05:39 INFO - 'SHELL': '/bin/bash', 08:05:39 INFO - 'SHLVL': '1', 08:05:39 INFO - 'TERM': 'linux', 08:05:39 INFO - 'TMOUT': '86400', 08:05:39 INFO - 'USER': 'cltbld', 08:05:39 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1468508308.717854-1747155146', 08:05:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:39 INFO - '_': '/tools/buildbot/bin/python'} 08:05:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:40 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:05:40 INFO - Cleaning up... 08:05:40 INFO - Return code: 0 08:05:40 INFO - Running post-action listener: _resource_record_post_action 08:05:40 INFO - Running post-action listener: _start_resource_monitoring 08:05:40 INFO - Starting resource monitoring. 08:05:40 INFO - ##### 08:05:40 INFO - ##### Finished create-virtualenv step (success) 08:05:40 INFO - ##### 08:05:40 INFO - ##### 08:05:40 INFO - ##### Running install step. 08:05:40 INFO - ##### 08:05:40 INFO - Running pre-action listener: _resource_record_pre_action 08:05:40 INFO - Running main action method: install 08:05:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:05:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:05:40 INFO - Reading from file tmpfile_stdout 08:05:40 INFO - Detecting whether we're running mozinstall >=1.0... 08:05:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:05:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:05:40 INFO - Reading from file tmpfile_stdout 08:05:40 INFO - Output received: 08:05:40 INFO - Usage: mozinstall [options] installer 08:05:40 INFO - Options: 08:05:40 INFO - -h, --help show this help message and exit 08:05:40 INFO - -d DEST, --destination=DEST 08:05:40 INFO - Directory to install application into. [default: 08:05:40 INFO - "/builds/slave/test"] 08:05:40 INFO - --app=APP Application being installed. [default: firefox] 08:05:40 INFO - mkdir: /builds/slave/test/build/application 08:05:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:05:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:05:57 INFO - Reading from file tmpfile_stdout 08:05:57 INFO - Output received: 08:05:57 INFO - /builds/slave/test/build/application/firefox/firefox 08:05:57 INFO - Running post-action listener: _resource_record_post_action 08:05:57 INFO - ##### 08:05:57 INFO - ##### Finished install step (success) 08:05:57 INFO - ##### 08:05:57 INFO - ##### 08:05:57 INFO - ##### Running run-tests step. 08:05:57 INFO - ##### 08:05:57 INFO - Running pre-action listener: _resource_record_pre_action 08:05:57 INFO - Running main action method: run_tests 08:05:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:05:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:05:57 INFO - Python 2.7.3 08:05:57 INFO - Return code: 0 08:05:57 INFO - grabbing minidump binary from tooltool 08:05:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:05:57 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d563b0>, '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 0x1d572b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d57740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:05:57 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:05:57 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 08:05:57 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:05:57 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:05:57 INFO - Return code: 0 08:05:57 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:05:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:05:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:05:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:05:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:05:57 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/FAsVQeQoRj2zL56XiX8OuA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--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 08:05:57 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/FAsVQeQoRj2zL56XiX8OuA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-048 --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 08:05:57 INFO - Using env: {'DISPLAY': ':0', 08:05:57 INFO - 'HOME': '/home/cltbld', 08:05:57 INFO - 'LANG': 'en_US.UTF-8', 08:05:57 INFO - 'LANGUAGE': 'en_US:en', 08:05:57 INFO - 'LOGNAME': 'cltbld', 08:05:57 INFO - 'MAIL': '/var/mail/cltbld', 08:05:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:05:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:05:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:57 INFO - 'MOZ_NO_REMOTE': '1', 08:05:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:05:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:05:57 INFO - 'NO_EM_RESTART': '1', 08:05:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:05:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:57 INFO - 'PWD': '/builds/slave/test', 08:05:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:05:57 INFO - 'SHELL': '/bin/bash', 08:05:57 INFO - 'SHLVL': '1', 08:05:57 INFO - 'TERM': 'linux', 08:05:57 INFO - 'TMOUT': '86400', 08:05:57 INFO - 'USER': 'cltbld', 08:05:57 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1468508308.717854-1747155146', 08:05:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:57 INFO - '_': '/tools/buildbot/bin/python'} 08:05:57 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/FAsVQeQoRj2zL56XiX8OuA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--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 08:05:58 INFO - mozversion application_buildid: 20160714053013 08:05:58 INFO - mozversion application_changeset: 1d5210d6f9614812ebdfad13a0d6e25d4513c03e 08:05:58 INFO - mozversion application_display_name: Nightly 08:05:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:05:58 INFO - mozversion application_name: Firefox 08:05:58 INFO - mozversion application_remotingname: firefox 08:05:58 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:05:58 INFO - mozversion application_vendor: Mozilla 08:05:58 INFO - mozversion application_version: 50.0a1 08:05:58 INFO - mozversion platform_buildid: 20160714053013 08:05:58 INFO - mozversion platform_changeset: 1d5210d6f9614812ebdfad13a0d6e25d4513c03e 08:05:58 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:05:58 INFO - mozversion platform_version: 50.0a1 08:05:58 INFO - using testdate: 1468508758 08:05:58 INFO - actual date: 1468508758 08:05:58 INFO - starting webserver on 'localhost:42424' 08:05:58 INFO - SUITE-START | Running 2 tests 08:05:58 INFO - TEST-START | dromaeo_css 08:05:58 INFO - operating with platform_type : linux_ 08:05:58 INFO - Initialising browser for dromaeo_css test... 08:05:58 INFO - TEST-INFO | started process 7864 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgVi41R/profile http://localhost:42424/getInfo.html) 08:06:02 INFO - PROCESS | 7864 | __metrics Screen width/height:1600/1200 08:06:02 INFO - PROCESS | 7864 | colorDepth:24 08:06:02 INFO - PROCESS | 7864 | Browser inner width/height: 1024/697 08:06:02 INFO - PROCESS | 7864 | __metrics 08:06:03 INFO - PROCESS | 7864 | 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" 08:06:03 INFO - PROCESS | 7864 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:06:03 INFO - PROCESS | 7864 | console.error: PushService: 08:06:03 INFO - PROCESS | 7864 | stateChangeProcessEnqueue: Error transitioning state 08:06:03 INFO - PROCESS | 7864 | UnknownError 08:06:04 INFO - TEST-INFO | 7864: exit 0 08:06:04 INFO - Browser initialized. 08:06:04 INFO - Running cycle 1/1 for dromaeo_css test... 08:06:04 INFO - TEST-INFO | started process 7947 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgVi41R/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:06:15 INFO - PROCESS | 7947 | RSS: Main: 157859840 08:06:15 INFO - PROCESS | 7947 | 08:07:07 INFO - PROCESS | 7947 | 1468508827410 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] 08:09:15 INFO - PROCESS | 7947 | Cycle 1(1): loaded http://localhost:42424/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42424/tests/dromaeo/cssquery-ext.html) 08:09:16 INFO - PROCESS | 7947 | RSS: Main: 254181376 08:09:16 INFO - PROCESS | 7947 | 08:12:18 INFO - PROCESS | 7947 | Cycle 1(1): loaded http://localhost:42424/tests/dromaeo/cssquery-ext.html (next: http://localhost:42424/tests/dromaeo/cssquery-jquery.html) 08:12:19 INFO - PROCESS | 7947 | RSS: Main: 245927936 08:12:19 INFO - PROCESS | 7947 | 08:15:21 INFO - PROCESS | 7947 | Cycle 1(1): loaded http://localhost:42424/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42424/tests/dromaeo/cssquery-mootools.html) 08:15:22 INFO - PROCESS | 7947 | RSS: Main: 246894592 08:15:22 INFO - PROCESS | 7947 | 08:18:24 INFO - PROCESS | 7947 | Cycle 1(1): loaded http://localhost:42424/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42424/tests/dromaeo/cssquery-prototype.html) 08:18:24 INFO - PROCESS | 7947 | RSS: Main: 237309952 08:18:24 INFO - PROCESS | 7947 | 08:21:27 INFO - PROCESS | 7947 | Cycle 1(1): loaded http://localhost:42424/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42424/tests/dromaeo/cssquery-yui.html) 08:21:28 INFO - PROCESS | 7947 | RSS: Main: 221503488 08:21:28 INFO - PROCESS | 7947 | 08:24:30 INFO - PROCESS | 7947 | Cycle 1(1): loaded http://localhost:42424/tests/dromaeo/cssquery-yui.html (next: http://localhost:42424/tests/dromaeo/cssquery-dojo.html) 08:24:31 INFO - PROCESS | 7947 | RSS: Main: 276684800 08:24:31 INFO - PROCESS | 7947 | 08:24:31 INFO - PROCESS | 7947 | __start_tp_report 08:24:31 INFO - PROCESS | 7947 | _x_x_mozilla_page_load 08:24:31 INFO - PROCESS | 7947 | _x_x_mozilla_page_load_details 08:24:31 INFO - PROCESS | 7947 | |i|pagename|runs| 08:24:31 INFO - PROCESS | 7947 | |0;dojo.html;3015.2763336799176;3019.5923550320704;3048.932873494276;3051.603291572096;3062.5253085771715;5190.06578815813;5193.350831146106;5226.921596176051;5312.362516498021;5348.598855085865;5231.450697676746;5253.159494480884;5255.448177941318;5275.947240527594;5315.574754019679;4739.668223224376;4820.903581928359;4833.130036593412;4833.154198015333;4951.3810773653295;4875.171220892439;4882;4902.4852390498845;4932.827351042714;4946.060248552782;4732.952670473285;4745.833895813647;4766.142094423002;4780.259059845729;4789.3294938708605;4755.0489902019735;4782.995570930108;4844.006978569385;4846.466888642247;4890.706557606555;4779.283107533898;4786.473487916326;4786.617070634341;4802.783874725611;4868.415790105175;5161.638685291993;5180.922286165711;5226.5818734501145;5288.968651113035;5297.8145764898045;5610.354809196913;5637.943620563783;5638.661680299195;5644.887102257973;5657.405972372882;5531.446855314477;5632.464915832989;5687.146927960797;5690.487856092972;5702.857428564277;5208;5264.7367631618645;5269.683818970874;5336.759845806948;5337.439568845293;5790;5795.985702502046;5799.2750906136735;5803.390643982406;5806.042003069446;5427.185922111636;5484.2047903053835;5611.6071874969175;5647.887042259132;5654.74553645087;5663.745131469093;5701.087825947829;5704.058830293038;5756.079027355603;5760.971195144081;5626.127950167731;5679;5681.176229446707;5684.459976302244;5721.22763426932;5497.340319161726;5581.776728930879;5623;5696.715164241771;5704.942950570441;4342.218400687843;4351.6518678505645;4356.085222103394;4386.934195987063;4391.407160033418;3858.4212368145004;3861.343571592836;3872.496575445174;3881.514810648669;3907.5897030811925;5205.167173252262;5267.683938963598;5296.4703529647495;5358.758855851496;5369.19462080691;5707.229524014288;5716.085426331767;5724.341700704473;5735.483806457439;5770.798022069207;5357.464253574689;5373.247745315659;5389.622726409114;5399.70301633414;5401.027814993339;4829.396325459317;4852.539008794159;4904.60763138948;4910.533499317559;4976.676516026447;5864.560157988082;5873.148393483007;5874.206982057453;5878.206442130343;5881.941180588139;5697.3448053474385;5710.37185909558;5712.714364281853;5713.857153571194;5714;5632.2678051853;5667.489925906688;5689.8862022758485;5690.630109042899;5711.171880077449;5398.352197736297;5442;5446.754896029609;5446.809361672323;5457.5633949283165;5494.450554944633;5532.75102620375;5557.861053473695;5558.91661625084;5600.243967064394;5456.645318054314;5494.5054945055135;5512.586556008235;5520.944790552204;5552.389237183826;5496.0931446310915;5518.061929471919;5518.751656175402;5528.198411230269;5530.087535556588;5295.655782374133;5417.918731219113;5441;5460.890782184413;5521.420250873761;5578.30271216098;5605.523530499953;5639.182318563703;5650.406707295675;5694.288213973254;5491.533219676372;5509.311336082989;5517.69652669107;5520.972395137998;5524.06090964529 08:24:31 INFO - PROCESS | 7947 | |1;ext.html;587.0958723565709;615.2893408113629;629.2794750011237;629.7764293675742;636.9840105032474;32580.511292330604;35406.46890296647;35455.82272088639;43734.781326093325;44569.55430445694;45549;45566.772166139126;45927.77036114815;45985.54014459854;46067.30899036517;8930.91069089309;9062.093790620951;9087.409318394317;9088.863667045;9089.318301127441;8902.599383027748;8979.46123232608;8985.236254918307;8991.145841145113;8992.415492992966;8930.240929520998;8962.551872406386;8962.775930601721;8976.326775491863;8980.910190898105;8915.153060459246;8985.550722463884;8992.8651070234;9005.864912026325;9013.324000699908;8980.236679882153;9011.549422528848;9027.638894444215;9046.321525885585;9048.41185322952;42363.788181058895;42676.78661606703;42708.14583708309;42718.78640606777;42721.145577088595;3505.3865573524786;3555.1467647764607;3676.74262801604;3927.7643341399607;4140.068484590973;33233;33589;33843;33845.49231761501;34973.30053398943;4304.504981927087;4514.503404625489;4621.3299071634765;4634.351190833286;4639.489656137822;342658;342743.9999999975;342894;343662;344603;60821;61614;61626.38373616296;61627.999999999105;61726.38273617296;63708;64373;64519.677401612695;64536;64616.353836461974;16618.6676266474;16828;16859.494215173563;16879.40922067722;16890.324387024626;12537.686557836127;12540.937295313464;12556.309402982924;12583.496660133675;12612.55856045034;16810.106059582427;18521.907390462962;18657.53356166107;18658.44024679262;18847.811521884607;6210.565260431817;6257.788589031629;6352.396522330371;6473.335831147746;6530.118434011442;970.4759429907912;1071.5874388360537;1079.3254216114929;1135.3585224348217;1165.8367828504017;32675.509867352008;32701.345973080406;32845.67154328474;33152.50271245933;33518.162045949044;1106.1427393769893;1118.7147277444199;1135.5968631135993;1200.8258802473592;1244.7199380139396;17220.31118755261;17408;17590;17630.121373297854;17695.911520442573;557953;560501;571474;828511;832096;59356;59729.40270597238;60024;60048.69975650094;60059;1253.5173958026044;1321.4846209978116;1360.4966162519931;1361.4486133116104;1383.5019393018506;30174.84912575423;34446.31107377889;34661.30677386388;34730.479042814884;34810.65189348176;53674.46325536694;54844.725776372456;54904.450955491535;54905;54954.17568736552;502143;514788;519296.24574402545;519498;526580;37727.62272377241;44347.33478997882;44890.326645101006;45417.77291113523;45884.31173532466;49535.752321239604;49571.50428495669;49741;50535.49464505308;51627;42066.7896660527;42293;42303.576964229964;43090.353644694726;43754;42269;42513.78743106265;42813.785931070146;43088;43744.78127609342;41776;42398.788006059774;43241.783791080845;43400.78299608608;43466.56533434751;36518.26963460769;37355.43966840554;37672.62327376801;37899.81050094732;38388;28056.579151313155;28686.856565717873;28793.424131516833;28910.421791564473;28918.42163156683 08:24:31 INFO - PROCESS | 7947 | |2;jquery.html;399.4846647824307;402.2718878829319;405.165359359719;406.59137566745414;414.074543395511;13059.072138965888;18376.264949402026;19872.60254794905;19902.50243743907;20660;15815.762763558556;18786;19426.805731942677;19615.607687846234;19815.5046123847;5346.331708536423;5502.064649009678;5504.311961004874;5516.668999860001;5522.2544956430975;5597.972010139943;5687.687177205252;5724.7996320128805;5816.8836623267725;5819.534437245032;5683.971580142114;5713.885722285552;5735.283089613798;5740.081586946089;5740.282464691913;5577.9959607270675;5706.914396284038;5711.029125048752;5712.285964254468;5766.106253530709;5146.433892271847;5166.173412254021;5175.197844334134;5196.142636464979;5202.505761952609;23633.29100126999;23668.644970325287;23917.402064948514;24725.381865453328;24728.3817904552;2571.7042540107755;2591.481703659276;2664.120840122755;2982.776291778125;3172.952405713916;14554;14742.262886855615;14743.483978060824;15173.696526069527;15311.081335119929;1974.3385965701507;2056.95886082279;2075.0765909170427;2082.5314304281414;2084.94710171364;81512.59243703802;82577;82962.58518707428;84181;85537.14462855353;10446.843297350546;10720.142388608892;10943.4528273586;10965.56137754481;10986.450677466255;15103.622409439851;15182.848171518364;15250.542483725507;15254;15278.618034549003;7871.291583757489;7986.440949133505;8040.437169398203;8127.715529956541;8163.510189388656;6943.305669433117;7805.80485487856;7890.092639346434;7962.960185199037;8023.59882005909;6345.270293916259;6597.34026597346;6746.190457145174;6839.316068393121;6906.551074180162;1877.680794264951;1937.5543624966056;1976.7133765603908;1991.8904460254535;2004.629143608437;914.6387177065022;958.4297343080856;989.4656885281867;1049.490996866519;1177.8115501519715;18968.905155474135;20539.38381848547;20652;20796.896015520128;20811.29453171078;1031.7111208861381;1031.9484025798681;1043.3009883378154;1053.9578416863394;1084.0893649334596;11347.20569560123;11716.648500544998;11854.288742675468;11959.162858599988;11973.940130299292;476087;476510;479130;513437;513989;83229.58385208156;84003.15996839953;85317;85445;87098;1003.6386900715737;1040.157472447305;1060.0724366179593;1061.5488417422564;1064.5475672839013;17929.73105403394;18449.907750461163;18693.532661683566;18916.432507024812;19082.618347633248;41823.7908810454;44081.55918440774;44988.55011449844;45598.31602525898;46002.30996535122;61844.381556183864;62936.68531657312;63684.59295092024;64367;66588;8526.658933642584;8550.486970781772;8737.694180703898;8919.152680495343;9275.86086208694;10322.587096516356;13798.93100534491;13895.791563126764;14186.148831070168;14326.283685815459;11464.82802757976;12030.458629361874;12139.453724582592;12185.756284874431;12279.631611051684;11032.338059716443;11314.264572802742;11514.30914145154;11610.361430121424;11669.416529173337;10739.570417183537;11544.19190656646;11667.372300948735;11724.648260552198;11947.044236461235;7748.845023099394;8015.559144246889;8061.1938806118915;8337.916620833714;8912.821743565222;10508.579656813641;11050;11097.722556936142;11197.328160310408;11307.434628268718 08:24:31 INFO - PROCESS | 7947 | |3;mootools.html;1253.110291692898;1421.7796241582555;1449.9782503262452;1550.302363936229;1780.0921530019687;7725.18885517021;8044.477108987911;8051.074126475457;8160.469569477979;8224.218699223578;8021.518708877471;8163;8175;8200.507969521834;8216.055153657331;2042.7242322286525;2288.4622113803243;2307.861528308307;2332.556814205304;2369.277370402027;2365.006697187177;2372.240882917467;2372.988135059331;2375.1449478187924;2377;2267.047839907243;2314.259436980167;2328.0338659456306;2331.6152834782242;2342.7071616047992;1949.6393167264102;2014.8186663200236;2018.1019446346381;2198.835087368454;2254.763249858766;2292.1633603734685;2304.481491664379;2307.3770082077913;2314.1206341590255;2316.0851463671756;8319.292860106898;8362.790930226733;8382.371322150862;8395.580220988988;8403.663853445854;5008.549230569266;5128.897422051576;5135.152699804527;5135.87160320995;5140.049090918192;3330.533725278463;3341.114604629775;3468.4623883298127;3500.562429696288;3506.333796578642;1184.881511848817;1190.1014733875954;1202.0744027099172;1228.7603917236142;1248.2323371126784;11529.365884876328;11534.59628912984;11544.711382215428;11552.306861588331;11553;4358.106588149421;4430.091831174602;4579.587837094611;4611.746353950565;4613.008203236253;9806.215502759762;9807.26445516589;9808;9817.410955342559;9820.459874706818;5126.128558145124;5131.435542090367;5131.897362052738;5135.768890399941;5136.203888397305;4132.834686612502;4484.506704262529;4611.492735799059;4641.327007583949;4691.695039822401;3878.941815872764;3929.724919255682;3982.26328129297;4021.7586944783407;4047.210793895221;1089.6458650938478;1225.2036176485178;1257.7107265329025;1260.571405722059;1268.8033354830015;962.605331813953;967.1778987860263;982.8673129127619;988.8615593816871;995.7112437393075;5778.191053252548;5806.767729290866;5990.940090599125;6003.5797494174985;6026;984.7784248544164;987.1115995604014;996.3623281100101;1010.751721623794;1037.6108959140322;4137.834486620502;4183.142455796555;4183.184279065553;4222.767747773841;4291.849785257564;10153.64462243818;10493.895061049292;10551.94724026375;10570.365778053341;10600.681979540626;10229.77242730877;10358.482075896325;10446.843297350546;10458.790824183627;10472.476376181314;7898.723544675909;7912.971313729063;7995.560244186626;8017.719379821679;8031.237032481905;5796.275465566804;5848.210491583752;5909.970450147894;5946.613470124428;5993.910091348721;9591.42451452915;9617.71146865595;9655.468949207861;9678.467684277432;9738.123568878835;9293.628254869729;9564.834989105804;9663.855042174233;9664.71005869825;9716;7552.509086909334;7657.0811502620045;7706.460547761603;7706.499077559941;7716.035495563055;7811.062672479112;8007.279344858991;8058.355331573577;8219.54792486419;8283.130271321665;6092.299385570716;7373.29953654402;7458.03045604068;7468.10382754073;7665.3101220890385;7193.352598266181;7221.819454513679;7232.602206878672;7290.198078211286;7418.517796343221;6763.5941843489545;6763.763268285783;6764.053032575542;6819.931800682129;6828.317168283132;4922.606191504743;4998.4501704813165;5005.374328208974;5008.69947803133;5096.694198348111;4954.455009948975;4987;5006.349174607278;5104.69371837691;5114.820981265638 08:24:31 INFO - PROCESS | 7947 | |4;prototype.html;332.6606861001778;333.225251290749;336.50869730193915;340.3686162169176;341.515048630944;5205.713685747282;5219.191025391061;5260.4213536511;5279.313689220406;5291.523762861341;5198.68807871527;5213.087709650815;5242.659227150232;5242.951409718062;5263.578913686905;3928.3910993795935;3956.2592459317807;3979.9801000994953;4036.609248231485;4049.068714195722;3752.5496940367193;4114.362273847559;4127.938080928789;4136.503619565641;4138.668906487489;4071.1857628474277;4077.3476243800997;4091.509018917719;4091.509018917719;4096.713230073896;3933.5083114610675;4030.8992275193064;4093.5497095319492;4100.405441211023;4111.9103437589065;3429.5198672185916;3568.9107772305642;3574.267275208602;3635.672789448936;3637.290728307981;5050.444451110375;5071.518205770482;5083.79664813407;5086.567641750456;5100.112958205487;4470.463544374663;4667.95332046682;4668.019715859674;4682.2508398656055;4689.179393606105;5433.646812957145;5458.263134476834;5461.344638643349;5470.276862788209;5474.616776825624;3948.4866967294356;3951.2097580483733;3964.861229856941;3969.702272329587;3969.8412063517426;5152.201408781607;5385.065139498944;5646.85882852932;5668.064769313059;5675.51758100562;3995.4805875236034;4018.1160144768105;4018.136100738297;4029.2143032109043;4029.4157347184496;4053.3919912013434;4065.7560546367313;4078.6940979426663;4080.143169934347;4086.7547947123267;4541.545845415432;4610.976945115253;4648.5357112509455;4661.184292748755;4673.878269215364;5454.072807622713;5456.836294911159;5460.399356070829;5477.534409575231;5545.805896793673;1385.9930700346433;1397.503886120433;1405.5150972914328;1406.1000959386001;1410.9012369134268;875.6672464463463;914.9295324470386;917.7109210598641;921.9904204895629;924.0713083351324;4697.95302046982;4708.599769019604;4723.220668589713;4732.438295362522;4762.833300834454;4957.851764129804;4981.2030075187795;4985.205326082607;5002.549770520671;5007.672966663837;4630.398161199508;4653.441587009581;4710.597595226459;4725.078609671081;4779.330893674888;2627.697814751328;2641.8298042349256;2649.45686134342;2696.824706394117;2703.594460830891;5063.265826455217;5100.719460429637;5105.310783044316;5108.923366149511;5138.434772175057;5079.774343292036;5086.465921078234;5087.745612719349;5376.973115134399;5813.273340832396;5819.359870414251;5825.592208545361;5842.357340692521;5849.532037436995;5861.329521086555;5574.888502230014;5600;5616.185653080199;5617.550595952396;5618.241537392563;5458.9454105458435;5576.609637325349;5591.8881622368135;5602.803901863415;5615.691136987505;5585.748641311232;5637.802676906289;5823.272090988627;5828.562857785599;5835.241418615723;4044.8584299549375;4084.938725919173;4089.734167279117;4091.2635725569685;4091.468109145792;5551.583631227593;5672.319321681424;5672.659640421422;5701.600887937804;5701.9736447439855;5484.149956756709;5558.833235002957;5566.638168519034;5571.464983432447;5581.888362232814;5435.266239057677;5453.836384908459;5513.5037846592395;5529.645236916981;5539.556835453234;5268.81559145428;5446.863828404322;5453.372862120907;5493.23094766741;5493.560515158858;5521.420250873601;5537.972310138423;5542.61201715876;5547.140193270049;5562.415946325577;5389.191621256686;5424.3761967372675;5425.376081750492;5453.7545810439415;5458.399576046552 08:24:31 INFO - PROCESS | 7947 | |5;yui.html;798.5568009754587;801.9879701804472;841.932645388369;843.211597156659;848.3255811629757;15742.449014284488;16393.262303196356;16413.671726565477;17241.48275551732;17994.640107197847;14939.551813445587;15003.624909377271;15044.849551504481;15110.320035598397;15115.319810608522;671.3521451799013;820.0856045509274;832.2260297922929;832.7959649885756;833.170994860112;805.8066064144592;828.5401602110857;830.9709160179365;831.3806214370303;831.6091437024619;861.8879545659056;864.5374724522381;868.6047848229041;869.6086760957594;870.5386145342947;706.2125729811274;718.6334969165763;863.8099618084011;864.148813418782;864.9135086491364;521.2754271562532;611.0833749375936;629.6820105846518;632.9019002054689;633.5850018238061;15573.688526229525;15739.055656660637;15748.291326890318;15755.684886302324;15761.921190393974;13449.66375840602;13615.455381784717;13629.454821807116;13715.451381944711;13905.79141312881;12300.384980750927;12451.501939922393;12506.749865002648;12521.373931303398;12542.24746515203;4502.549745025504;4522.547745225484;4649.465311489188;4702.835400760991;4769.880752981168;75491;75638;76167.6191619044;76330;79047.20952790456;11015.449227538591;11092.112630989663;11138.443077846076;11314.490847911864;11701.180917335874;20006.89962052072;20030;20070.49823754418;20088.89955550213;20205.89897050505;8256.1331060239;8318.585830466625;8413.242808147295;8437.620307086196;8480.236778689947;4411.801468933906;4559.475660299042;4630.86107416778;4713.34013238147;4812.687175333592;3364.512145738903;3453.568303962005;3466.7226621870695;3468.4450487921813;3505.4040813061843;636.5798572941836;642.5084810120262;654.3097032630525;693.5595896605691;701.4003027411592;658.397566226897;763.576215200558;765.1086484245791;775.6160700453199;798.8442253760577;9604.327697061139;10442.2168337375;10593.046625803714;10599;10610.310329828537;599.7031469422576;706.9646517674096;710.6446776611695;717.1680850213727;763.8854171874264;4633.7683115844075;4762.547557981986;4795.712257264575;4800.255960326155;4854.635902307341;123063;126656;127720;127820;129667.35166324297;110176.4491177555;110272;111233.21367504359;112152;113910.43044784723;95608;96524.51737741266;100146.4992675032;100210;100534;9146.451212927246;9298.279818233648;9348.20540254086;9421.85435416724;9425.434473931586;55584;56894.7155264221;58076.41923580879;58717.70641146767;59234;53548;80713.59643201981;80891.19108808837;80925;81169.59415202886;11697.23967942081;11867.109966752701;11902.285862848257;11962.820557691815;12105.213161144497;14104.435822567393;14261.144331340152;14399;14453.638659033608;14494.710105798036;12936.547220847226;13340.466381344637;13606.183628982293;13694.65763355924;13752.518661846787;14139.575812725634;14476.420943162155;14765.630859228606;14898.553043408716;15385.69228615399;13775.173489590657;13789.931050344683;14321.212333321768;14507;15087.849121508645;11138.888611113785;11526.250793698382;11591.5942942;11895.82156267674;12039.398030098635;11403.552465107965;11731.824022639837;11915.880841191823;11991;11997.580084697343 08:24:31 INFO - PROCESS | 7947 | __end_tp_report 08:24:31 INFO - PROCESS | 7947 | __start_cc_report 08:24:31 INFO - PROCESS | 7947 | _x_x_mozilla_cycle_collect,883 08:24:31 INFO - PROCESS | 7947 | __end_cc_report 08:24:31 INFO - PROCESS | 7947 | __startTimestamp1468509871228__endTimestamp 08:24:31 INFO - PROCESS | 7947 | 08:24:31 INFO - PROCESS | 7947 | ------- Summary: start ------- 08:24:31 INFO - PROCESS | 7947 | Number of tests: 6 08:24:31 INFO - PROCESS | 7947 | 08:24:31 INFO - PROCESS | 7947 | [#0] dojo.html Cycles:165 Average:5250.80 Median:5446.81 stddev:590.70 (10.8%) stddev-sans-first:565.88 08:24:31 INFO - PROCESS | 7947 | Values: 3015.3 3019.6 3048.9 3051.6 3062.5 5190.1 5193.4 5226.9 5312.4 5348.6 5231.5 5253.2 5255.4 5275.9 5315.6 4739.7 4820.9 4833.1 4833.2 4951.4 4875.2 4882.0 4902.5 4932.8 4946.1 4733.0 4745.8 4766.1 4780.3 4789.3 4755.0 4783.0 4844.0 4846.5 4890.7 4779.3 4786.5 4786.6 4802.8 4868.4 5161.6 5180.9 5226.6 5289.0 5297.8 5610.4 5637.9 5638.7 5644.9 5657.4 5531.4 5632.5 5687.1 5690.5 5702.9 5208.0 5264.7 5269.7 5336.8 5337.4 5790.0 5796.0 5799.3 5803.4 5806.0 5427.2 5484.2 5611.6 5647.9 5654.7 5663.7 5701.1 5704.1 5756.1 5761.0 5626.1 5679.0 5681.2 5684.5 5721.2 5497.3 5581.8 5623.0 5696.7 5704.9 4342.2 4351.7 4356.1 4386.9 4391.4 3858.4 3861.3 3872.5 3881.5 3907.6 5205.2 5267.7 5296.5 5358.8 5369.2 5707.2 5716.1 5724.3 5735.5 5770.8 5357.5 5373.2 5389.6 5399.7 5401.0 4829.4 4852.5 4904.6 4910.5 4976.7 5864.6 5873.1 5874.2 5878.2 5881.9 5697.3 5710.4 5712.7 5713.9 5714.0 5632.3 5667.5 5689.9 5690.6 5711.2 5398.4 5442.0 5446.8 5446.8 5457.6 5494.5 5532.8 5557.9 5558.9 5600.2 5456.6 5494.5 5512.6 5520.9 5552.4 5496.1 5518.1 5518.8 5528.2 5530.1 5295.7 5417.9 5441.0 5460.9 5521.4 5578.3 5605.5 5639.2 5650.4 5694.3 5491.5 5509.3 5517.7 5521.0 5524.1 08:24:31 INFO - PROCESS | 7947 | 08:24:31 INFO - PROCESS | 7947 | [#1] ext.html Cycles:180 Average:67090.27 Median:43433.67 stddev:142387.40 (327.8%) stddev-sans-first:142699.28 08:24:31 INFO - PROCESS | 7947 | Values: 587.1 615.3 629.3 629.8 637.0 32580.5 35406.5 35455.8 43734.8 44569.6 45549.0 45566.8 45927.8 45985.5 46067.3 8930.9 9062.1 9087.4 9088.9 9089.3 8902.6 8979.5 8985.2 8991.1 8992.4 8930.2 8962.6 8962.8 8976.3 8980.9 8915.2 8985.6 8992.9 9005.9 9013.3 8980.2 9011.5 9027.6 9046.3 9048.4 42363.8 42676.8 42708.1 42718.8 42721.1 3505.4 3555.1 3676.7 3927.8 4140.1 33233.0 33589.0 33843.0 33845.5 34973.3 4304.5 4514.5 4621.3 4634.4 4639.5 342658.0 342744.0 342894.0 343662.0 344603.0 60821.0 61614.0 61626.4 61628.0 61726.4 63708.0 64373.0 64519.7 64536.0 64616.4 16618.7 16828.0 16859.5 16879.4 16890.3 12537.7 12540.9 12556.3 12583.5 12612.6 16810.1 18521.9 18657.5 18658.4 18847.8 6210.6 6257.8 6352.4 6473.3 6530.1 970.5 1071.6 1079.3 1135.4 1165.8 32675.5 32701.3 32845.7 33152.5 33518.2 1106.1 1118.7 1135.6 1200.8 1244.7 17220.3 17408.0 17590.0 17630.1 17695.9 557953.0 560501.0 571474.0 828511.0 832096.0 59356.0 59729.4 60024.0 60048.7 60059.0 1253.5 1321.5 1360.5 1361.4 1383.5 30174.8 34446.3 34661.3 34730.5 34810.7 53674.5 54844.7 54904.5 54905.0 54954.2 502143.0 514788.0 519296.2 519498.0 526580.0 37727.6 44347.3 44890.3 45417.8 45884.3 49535.8 49571.5 49741.0 50535.5 51627.0 42066.8 42293.0 42303.6 43090.4 43754.0 42269.0 42513.8 42813.8 43088.0 43744.8 41776.0 42398.8 43241.8 43400.8 43466.6 36518.3 37355.4 37672.6 37899.8 38388.0 28056.6 28686.9 28793.4 28910.4 28918.4 08:24:31 INFO - PROCESS | 7947 | 08:24:31 INFO - PROCESS | 7947 | [#2] jquery.html Cycles:180 Average:29399.02 Median:24726.88 stddev:81071.16 (327.9%) stddev-sans-first:81269.34 08:24:31 INFO - PROCESS | 7947 | Values: 399.5 402.3 405.2 406.6 414.1 13059.1 18376.3 19872.6 19902.5 20660.0 15815.8 18786.0 19426.8 19615.6 19815.5 5346.3 5502.1 5504.3 5516.7 5522.3 5598.0 5687.7 5724.8 5816.9 5819.5 5684.0 5713.9 5735.3 5740.1 5740.3 5578.0 5706.9 5711.0 5712.3 5766.1 5146.4 5166.2 5175.2 5196.1 5202.5 23633.3 23668.6 23917.4 24725.4 24728.4 2571.7 2591.5 2664.1 2982.8 3173.0 14554.0 14742.3 14743.5 15173.7 15311.1 1974.3 2057.0 2075.1 2082.5 2084.9 81512.6 82577.0 82962.6 84181.0 85537.1 10446.8 10720.1 10943.5 10965.6 10986.5 15103.6 15182.8 15250.5 15254.0 15278.6 7871.3 7986.4 8040.4 8127.7 8163.5 6943.3 7805.8 7890.1 7963.0 8023.6 6345.3 6597.3 6746.2 6839.3 6906.6 1877.7 1937.6 1976.7 1991.9 2004.6 914.6 958.4 989.5 1049.5 1177.8 18968.9 20539.4 20652.0 20796.9 20811.3 1031.7 1031.9 1043.3 1054.0 1084.1 11347.2 11716.6 11854.3 11959.2 11973.9 476087.0 476510.0 479130.0 513437.0 513989.0 83229.6 84003.2 85317.0 85445.0 87098.0 1003.6 1040.2 1060.1 1061.5 1064.5 17929.7 18449.9 18693.5 18916.4 19082.6 41823.8 44081.6 44988.6 45598.3 46002.3 61844.4 62936.7 63684.6 64367.0 66588.0 8526.7 8550.5 8737.7 8919.2 9275.9 10322.6 13798.9 13895.8 14186.1 14326.3 11464.8 12030.5 12139.5 12185.8 12279.6 11032.3 11314.3 11514.3 11610.4 11669.4 10739.6 11544.2 11667.4 11724.6 11947.0 7748.8 8015.6 8061.2 8337.9 8912.8 10508.6 11050.0 11097.7 11197.3 11307.4 08:24:31 INFO - PROCESS | 7947 | 08:24:31 INFO - PROCESS | 7947 | [#3] mootools.html Cycles:180 Average:5583.55 Median:5100.69 stddev:3090.70 (60.6%) stddev-sans-first:3082.23 08:24:31 INFO - PROCESS | 7947 | Values: 1253.1 1421.8 1450.0 1550.3 1780.1 7725.2 8044.5 8051.1 8160.5 8224.2 8021.5 8163.0 8175.0 8200.5 8216.1 2042.7 2288.5 2307.9 2332.6 2369.3 2365.0 2372.2 2373.0 2375.1 2377.0 2267.0 2314.3 2328.0 2331.6 2342.7 1949.6 2014.8 2018.1 2198.8 2254.8 2292.2 2304.5 2307.4 2314.1 2316.1 8319.3 8362.8 8382.4 8395.6 8403.7 5008.5 5128.9 5135.2 5135.9 5140.0 3330.5 3341.1 3468.5 3500.6 3506.3 1184.9 1190.1 1202.1 1228.8 1248.2 11529.4 11534.6 11544.7 11552.3 11553.0 4358.1 4430.1 4579.6 4611.7 4613.0 9806.2 9807.3 9808.0 9817.4 9820.5 5126.1 5131.4 5131.9 5135.8 5136.2 4132.8 4484.5 4611.5 4641.3 4691.7 3878.9 3929.7 3982.3 4021.8 4047.2 1089.6 1225.2 1257.7 1260.6 1268.8 962.6 967.2 982.9 988.9 995.7 5778.2 5806.8 5990.9 6003.6 6026.0 984.8 987.1 996.4 1010.8 1037.6 4137.8 4183.1 4183.2 4222.8 4291.8 10153.6 10493.9 10551.9 10570.4 10600.7 10229.8 10358.5 10446.8 10458.8 10472.5 7898.7 7913.0 7995.6 8017.7 8031.2 5796.3 5848.2 5910.0 5946.6 5993.9 9591.4 9617.7 9655.5 9678.5 9738.1 9293.6 9564.8 9663.9 9664.7 9716.0 7552.5 7657.1 7706.5 7706.5 7716.0 7811.1 8007.3 8058.4 8219.5 8283.1 6092.3 7373.3 7458.0 7468.1 7665.3 7193.4 7221.8 7232.6 7290.2 7418.5 6763.6 6763.8 6764.1 6819.9 6828.3 4922.6 4998.5 5005.4 5008.7 5096.7 4954.5 4987.0 5006.3 5104.7 5114.8 08:24:31 INFO - PROCESS | 7947 | 08:24:31 INFO - PROCESS | 7947 | [#4] prototype.html Cycles:180 Average:4531.60 Median:5086.52 stddev:1332.60 (26.2%) stddev-sans-first:1298.53 08:24:31 INFO - PROCESS | 7947 | Values: 332.7 333.2 336.5 340.4 341.5 5205.7 5219.2 5260.4 5279.3 5291.5 5198.7 5213.1 5242.7 5243.0 5263.6 3928.4 3956.3 3980.0 4036.6 4049.1 3752.5 4114.4 4127.9 4136.5 4138.7 4071.2 4077.3 4091.5 4091.5 4096.7 3933.5 4030.9 4093.5 4100.4 4111.9 3429.5 3568.9 3574.3 3635.7 3637.3 5050.4 5071.5 5083.8 5086.6 5100.1 4470.5 4668.0 4668.0 4682.3 4689.2 5433.6 5458.3 5461.3 5470.3 5474.6 3948.5 3951.2 3964.9 3969.7 3969.8 5152.2 5385.1 5646.9 5668.1 5675.5 3995.5 4018.1 4018.1 4029.2 4029.4 4053.4 4065.8 4078.7 4080.1 4086.8 4541.5 4611.0 4648.5 4661.2 4673.9 5454.1 5456.8 5460.4 5477.5 5545.8 1386.0 1397.5 1405.5 1406.1 1410.9 875.7 914.9 917.7 922.0 924.1 4698.0 4708.6 4723.2 4732.4 4762.8 4957.9 4981.2 4985.2 5002.5 5007.7 4630.4 4653.4 4710.6 4725.1 4779.3 2627.7 2641.8 2649.5 2696.8 2703.6 5063.3 5100.7 5105.3 5108.9 5138.4 5079.8 5086.5 5087.7 5377.0 5813.3 5819.4 5825.6 5842.4 5849.5 5861.3 5574.9 5600.0 5616.2 5617.6 5618.2 5458.9 5576.6 5591.9 5602.8 5615.7 5585.7 5637.8 5823.3 5828.6 5835.2 4044.9 4084.9 4089.7 4091.3 4091.5 5551.6 5672.3 5672.7 5701.6 5702.0 5484.1 5558.8 5566.6 5571.5 5581.9 5435.3 5453.8 5513.5 5529.6 5539.6 5268.8 5446.9 5453.4 5493.2 5493.6 5521.4 5538.0 5542.6 5547.1 5562.4 5389.2 5424.4 5425.4 5453.8 5458.4 08:24:31 INFO - PROCESS | 7947 | 08:24:31 INFO - PROCESS | 7947 | [#5] yui.html Cycles:180 Average:22121.98 Median:3486.92 stddev:32958.36 (945.2%) stddev-sans-first:33011.93 08:24:31 INFO - PROCESS | 7947 | Values: 798.6 802.0 841.9 843.2 848.3 15742.4 16393.3 16413.7 17241.5 17994.6 14939.6 15003.6 15044.8 15110.3 15115.3 671.4 820.1 832.2 832.8 833.2 805.8 828.5 831.0 831.4 831.6 861.9 864.5 868.6 869.6 870.5 706.2 718.6 863.8 864.1 864.9 521.3 611.1 629.7 632.9 633.6 15573.7 15739.1 15748.3 15755.7 15761.9 13449.7 13615.5 13629.5 13715.5 13905.8 12300.4 12451.5 12506.7 12521.4 12542.2 4502.5 4522.5 4649.5 4702.8 4769.9 75491.0 75638.0 76167.6 76330.0 79047.2 11015.4 11092.1 11138.4 11314.5 11701.2 20006.9 20030.0 20070.5 20088.9 20205.9 8256.1 8318.6 8413.2 8437.6 8480.2 4411.8 4559.5 4630.9 4713.3 4812.7 3364.5 3453.6 3466.7 3468.4 3505.4 636.6 642.5 654.3 693.6 701.4 658.4 763.6 765.1 775.6 798.8 9604.3 10442.2 10593.0 10599.0 10610.3 599.7 707.0 710.6 717.2 763.9 4633.8 4762.5 4795.7 4800.3 4854.6 123063.0 126656.0 127720.0 127820.0 129667.4 110176.4 110272.0 111233.2 112152.0 113910.4 95608.0 96524.5 100146.5 100210.0 100534.0 9146.5 9298.3 9348.2 9421.9 9425.4 55584.0 56894.7 58076.4 58717.7 59234.0 53548.0 80713.6 80891.2 80925.0 81169.6 11697.2 11867.1 11902.3 11962.8 12105.2 14104.4 14261.1 14399.0 14453.6 14494.7 12936.5 13340.5 13606.2 13694.7 13752.5 14139.6 14476.4 14765.6 14898.6 15385.7 13775.2 13789.9 14321.2 14507.0 15087.8 11138.9 11526.3 11591.6 11895.8 12039.4 11403.6 11731.8 11915.9 11991.0 11997.6 08:24:31 INFO - PROCESS | 7947 | -------- Summary: end -------- 08:24:31 INFO - PROCESS | 7947 | 08:24:31 INFO - TEST-INFO | 7947: exit 0 08:24:31 INFO - TEST-OK | dromaeo_css | took 1113897ms 08:24:31 INFO - TEST-START | kraken 08:24:31 INFO - operating with platform_type : linux_ 08:24:31 INFO - Initialising browser for kraken test... 08:24:31 INFO - TEST-INFO | started process 8132 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp64R6WO/profile http://localhost:42424/getInfo.html) 08:24:35 INFO - PROCESS | 8132 | __metrics Screen width/height:1600/1200 08:24:35 INFO - PROCESS | 8132 | colorDepth:24 08:24:35 INFO - PROCESS | 8132 | Browser inner width/height: 1024/697 08:24:35 INFO - PROCESS | 8132 | __metrics 08:24:36 INFO - PROCESS | 8132 | 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" 08:24:36 INFO - PROCESS | 8132 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:24:37 INFO - TEST-INFO | 8132: exit 0 08:24:37 INFO - Browser initialized. 08:24:37 INFO - Running cycle 1/1 for kraken test... 08:24:37 INFO - TEST-INFO | started process 8215 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp64R6WO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:24:49 INFO - PROCESS | 8215 | RSS: Main: 157351936 08:24:49 INFO - PROCESS | 8215 | 08:24:52 INFO - PROCESS | 8215 | Cycle 1(1): loaded http://localhost:42424/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42424/tests/kraken/driver.html?testName=audio-beat-detection) 08:24:53 INFO - PROCESS | 8215 | RSS: Main: 215920640 08:24:53 INFO - PROCESS | 8215 | 08:24:55 INFO - PROCESS | 8215 | Cycle 1(1): loaded http://localhost:42424/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42424/tests/kraken/driver.html?testName=audio-dft) 08:24:56 INFO - PROCESS | 8215 | RSS: Main: 203251712 08:24:56 INFO - PROCESS | 8215 | 08:24:59 INFO - PROCESS | 8215 | Cycle 1(1): loaded http://localhost:42424/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42424/tests/kraken/driver.html?testName=audio-fft) 08:25:00 INFO - PROCESS | 8215 | RSS: Main: 269307904 08:25:00 INFO - PROCESS | 8215 | 08:25:02 INFO - PROCESS | 8215 | Cycle 1(1): loaded http://localhost:42424/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42424/tests/kraken/driver.html?testName=audio-oscillator) 08:25:02 INFO - PROCESS | 8215 | RSS: Main: 180719616 08:25:02 INFO - PROCESS | 8215 | 08:25:04 INFO - PROCESS | 8215 | Cycle 1(1): loaded http://localhost:42424/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42424/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:25:05 INFO - PROCESS | 8215 | RSS: Main: 184496128 08:25:05 INFO - PROCESS | 8215 | 08:25:08 INFO - PROCESS | 8215 | Cycle 1(1): loaded http://localhost:42424/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42424/tests/kraken/driver.html?testName=imaging-darkroom) 08:25:09 INFO - PROCESS | 8215 | RSS: Main: 219570176 08:25:09 INFO - PROCESS | 8215 | 08:25:12 INFO - PROCESS | 8215 | Cycle 1(1): loaded http://localhost:42424/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42424/tests/kraken/driver.html?testName=imaging-desaturate) 08:25:13 INFO - PROCESS | 8215 | RSS: Main: 221401088 08:25:13 INFO - PROCESS | 8215 | 08:25:15 INFO - PROCESS | 8215 | Cycle 1(1): loaded http://localhost:42424/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42424/tests/kraken/driver.html?testName=json-parse-financial) 08:25:16 INFO - PROCESS | 8215 | RSS: Main: 221413376 08:25:16 INFO - PROCESS | 8215 | 08:25:18 INFO - PROCESS | 8215 | Cycle 1(1): loaded http://localhost:42424/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42424/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:25:18 INFO - PROCESS | 8215 | RSS: Main: 208912384 08:25:18 INFO - PROCESS | 8215 | 08:25:20 INFO - PROCESS | 8215 | Cycle 1(1): loaded http://localhost:42424/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42424/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:25:21 INFO - PROCESS | 8215 | RSS: Main: 212955136 08:25:21 INFO - PROCESS | 8215 | 08:25:22 INFO - PROCESS | 8215 | Cycle 1(1): loaded http://localhost:42424/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42424/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:25:23 INFO - PROCESS | 8215 | RSS: Main: 210063360 08:25:23 INFO - PROCESS | 8215 | 08:25:26 INFO - PROCESS | 8215 | Cycle 1(1): loaded http://localhost:42424/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42424/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:25:26 INFO - PROCESS | 8215 | RSS: Main: 223543296 08:25:26 INFO - PROCESS | 8215 | 08:25:29 INFO - PROCESS | 8215 | Cycle 1(1): loaded http://localhost:42424/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42424/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:25:30 INFO - PROCESS | 8215 | RSS: Main: 225546240 08:25:30 INFO - PROCESS | 8215 | 08:25:31 INFO - PROCESS | 8215 | Cycle 1(1): loaded http://localhost:42424/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42424/tests/kraken/driver.html?testName=ai-astar) 08:25:31 INFO - PROCESS | 8215 | RSS: Main: 267616256 08:25:31 INFO - PROCESS | 8215 | 08:25:31 INFO - PROCESS | 8215 | __start_tp_report 08:25:31 INFO - PROCESS | 8215 | _x_x_mozilla_page_load 08:25:31 INFO - PROCESS | 8215 | _x_x_mozilla_page_load_details 08:25:31 INFO - PROCESS | 8215 | |i|pagename|runs| 08:25:31 INFO - PROCESS | 8215 | |0;ai-astar;103;112;112;113;112;112;112;113;111;112 08:25:31 INFO - PROCESS | 8215 | |1;audio-beat-detection;143;121;120;179;120;118;141;118;156;117 08:25:31 INFO - PROCESS | 8215 | |2;audio-dft;162;161;160;161;160;161;161;162;162;161 08:25:31 INFO - PROCESS | 8215 | |3;audio-fft;76;75;76;110;76;76;74;75;101;75 08:25:31 INFO - PROCESS | 8215 | |4;audio-oscillator;84;84;114;84;84;87;131;84;84;132 08:25:31 INFO - PROCESS | 8215 | |5;imaging-gaussian-blur;117;118;118;118;118;118;117;117;117;117 08:25:31 INFO - PROCESS | 8215 | |6;imaging-darkroom;147;146;146;145;146;146;146;147;147;145 08:25:31 INFO - PROCESS | 8215 | |7;imaging-desaturate;95;95;95;94;95;95;95;95;95;95 08:25:31 INFO - PROCESS | 8215 | |8;json-parse-financial;51;50;51;52;51;52;52;51;50;51 08:25:31 INFO - PROCESS | 8215 | |9;json-stringify-tinderbox;61;62;61;61;61;61;62;62;61;62 08:25:31 INFO - PROCESS | 8215 | |10;stanford-crypto-aes;77;78;80;74;74;74;74;80;74;79 08:25:31 INFO - PROCESS | 8215 | |11;stanford-crypto-ccm;129;124;116;118;118;129;123;125;201;119 08:25:31 INFO - PROCESS | 8215 | |12;stanford-crypto-pbkdf2;154;157;157;159;158;157;159;158;153;157 08:25:31 INFO - PROCESS | 8215 | |13;stanford-crypto-sha256-iterative;62;64;65;62;63;62;66;63;61;61 08:25:31 INFO - PROCESS | 8215 | __end_tp_report 08:25:31 INFO - PROCESS | 8215 | __start_cc_report 08:25:31 INFO - PROCESS | 8215 | _x_x_mozilla_cycle_collect,1637 08:25:31 INFO - PROCESS | 8215 | __end_cc_report 08:25:31 INFO - PROCESS | 8215 | __startTimestamp1468509931920__endTimestamp 08:25:31 INFO - PROCESS | 8215 | 08:25:31 INFO - PROCESS | 8215 | ------- Summary: start ------- 08:25:31 INFO - PROCESS | 8215 | Number of tests: 14 08:25:31 INFO - PROCESS | 8215 | 08:25:31 INFO - PROCESS | 8215 | [#0] ai-astar Cycles:10 Average:111.20 Median:112.00 stddev:2.94 (2.6%) stddev-sans-first:0.60 08:25:31 INFO - PROCESS | 8215 | Values: 103.0 112.0 112.0 113.0 112.0 112.0 112.0 113.0 111.0 112.0 08:25:31 INFO - PROCESS | 8215 | 08:25:31 INFO - PROCESS | 8215 | [#1] audio-beat-detection Cycles:10 Average:133.30 Median:131.00 stddev:21.07 (16.1%) stddev-sans-first:22.06 08:25:31 INFO - PROCESS | 8215 | Values: 143.0 121.0 120.0 179.0 120.0 118.0 141.0 118.0 156.0 117.0 08:25:31 INFO - PROCESS | 8215 | 08:25:31 INFO - PROCESS | 8215 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.00 stddev:0.74 (0.5%) stddev-sans-first:0.71 08:25:31 INFO - PROCESS | 8215 | Values: 162.0 161.0 160.0 161.0 160.0 161.0 161.0 162.0 162.0 161.0 08:25:31 INFO - PROCESS | 8215 | 08:25:31 INFO - PROCESS | 8215 | [#3] audio-fft Cycles:10 Average:81.40 Median:75.50 stddev:12.89 (17.1%) stddev-sans-first:13.53 08:25:31 INFO - PROCESS | 8215 | Values: 76.0 75.0 76.0 110.0 76.0 76.0 74.0 75.0 101.0 75.0 08:25:31 INFO - PROCESS | 8215 | 08:25:31 INFO - PROCESS | 8215 | [#4] audio-oscillator Cycles:10 Average:96.80 Median:84.00 stddev:20.50 (24.4%) stddev-sans-first:21.22 08:25:31 INFO - PROCESS | 8215 | Values: 84.0 84.0 114.0 84.0 84.0 87.0 131.0 84.0 84.0 132.0 08:25:31 INFO - PROCESS | 8215 | 08:25:31 INFO - PROCESS | 8215 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 08:25:31 INFO - PROCESS | 8215 | Values: 117.0 118.0 118.0 118.0 118.0 118.0 117.0 117.0 117.0 117.0 08:25:31 INFO - PROCESS | 8215 | 08:25:31 INFO - PROCESS | 8215 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.74 (0.5%) stddev-sans-first:0.71 08:25:31 INFO - PROCESS | 8215 | Values: 147.0 146.0 146.0 145.0 146.0 146.0 146.0 147.0 147.0 145.0 08:25:31 INFO - PROCESS | 8215 | 08:25:31 INFO - PROCESS | 8215 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 08:25:31 INFO - PROCESS | 8215 | Values: 95.0 95.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 08:25:31 INFO - PROCESS | 8215 | 08:25:31 INFO - PROCESS | 8215 | [#8] json-parse-financial Cycles:10 Average:51.10 Median:51.00 stddev:0.74 (1.4%) stddev-sans-first:0.78 08:25:31 INFO - PROCESS | 8215 | Values: 51.0 50.0 51.0 52.0 51.0 52.0 52.0 51.0 50.0 51.0 08:25:31 INFO - PROCESS | 8215 | 08:25:31 INFO - PROCESS | 8215 | [#9] json-stringify-tinderbox Cycles:10 Average:61.40 Median:61.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 08:25:31 INFO - PROCESS | 8215 | Values: 61.0 62.0 61.0 61.0 61.0 61.0 62.0 62.0 61.0 62.0 08:25:31 INFO - PROCESS | 8215 | 08:25:31 INFO - PROCESS | 8215 | [#10] stanford-crypto-aes Cycles:10 Average:76.40 Median:77.50 stddev:2.67 (3.5%) stddev-sans-first:2.83 08:25:31 INFO - PROCESS | 8215 | Values: 77.0 78.0 80.0 74.0 74.0 74.0 74.0 80.0 74.0 79.0 08:25:31 INFO - PROCESS | 8215 | 08:25:31 INFO - PROCESS | 8215 | [#11] stanford-crypto-ccm Cycles:10 Average:130.20 Median:124.50 stddev:25.29 (20.3%) stddev-sans-first:26.82 08:25:31 INFO - PROCESS | 8215 | Values: 129.0 124.0 116.0 118.0 118.0 129.0 123.0 125.0 201.0 119.0 08:25:31 INFO - PROCESS | 8215 | 08:25:31 INFO - PROCESS | 8215 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.90 Median:157.50 stddev:1.97 (1.3%) stddev-sans-first:1.79 08:25:31 INFO - PROCESS | 8215 | Values: 154.0 157.0 157.0 159.0 158.0 157.0 159.0 158.0 153.0 157.0 08:25:31 INFO - PROCESS | 8215 | 08:25:31 INFO - PROCESS | 8215 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.90 Median:63.00 stddev:1.66 (2.6%) stddev-sans-first:1.73 08:25:31 INFO - PROCESS | 8215 | Values: 62.0 64.0 65.0 62.0 63.0 62.0 66.0 63.0 61.0 61.0 08:25:31 INFO - PROCESS | 8215 | -------- Summary: end -------- 08:25:31 INFO - PROCESS | 8215 | 08:25:32 INFO - TEST-INFO | 8215: exit 0 08:25:32 INFO - TEST-OK | kraken | took 60992ms 08:25:32 INFO - SUITE-END | took 1174s 08:25:33 INFO - Completed test suite (00:19:35) 08:25:33 INFO - javascript benchmark 08:25:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3015.2763336799176, 3019.5923550320704, 3048.932873494276, 3051.603291572096, 3062.5253085771715, 5190.06578815813, 5193.350831146106, 5226.921596176051, 5312.362516498021, 5348.598855085865, 5231.450697676746, 5253.159494480884, 5255.448177941318, 5275.947240527594, 5315.574754019679, 4739.668223224376, 4820.903581928359, 4833.130036593412, 4833.154198015333, 4951.3810773653295, 4875.171220892439, 4882.0, 4902.4852390498845, 4932.827351042714, 4946.060248552782, 4732.952670473285, 4745.833895813647, 4766.142094423002, 4780.259059845729, 4789.3294938708605, 4755.0489902019735, 4782.995570930108, 4844.006978569385, 4846.466888642247, 4890.706557606555, 4779.283107533898, 4786.473487916326, 4786.617070634341, 4802.783874725611, 4868.415790105175, 5161.638685291993, 5180.922286165711, 5226.5818734501145, 5288.968651113035, 5297.8145764898045, 5610.354809196913, 5637.943620563783, 5638.661680299195, 5644.887102257973, 5657.405972372882, 5531.446855314477, 5632.464915832989, 5687.146927960797, 5690.487856092972, 5702.857428564277, 5208.0, 5264.7367631618645, 5269.683818970874, 5336.759845806948, 5337.439568845293, 5790.0, 5795.985702502046, 5799.2750906136735, 5803.390643982406, 5806.042003069446, 5427.185922111636, 5484.2047903053835, 5611.6071874969175, 5647.887042259132, 5654.74553645087, 5663.745131469093, 5701.087825947829, 5704.058830293038, 5756.079027355603, 5760.971195144081, 5626.127950167731, 5679.0, 5681.176229446707, 5684.459976302244, 5721.22763426932, 5497.340319161726, 5581.776728930879, 5623.0, 5696.715164241771, 5704.942950570441, 4342.218400687843, 4351.6518678505645, 4356.085222103394, 4386.934195987063, 4391.407160033418, 3858.4212368145004, 3861.343571592836, 3872.496575445174, 3881.514810648669, 3907.5897030811925, 5205.167173252262, 5267.683938963598, 5296.4703529647495, 5358.758855851496, 5369.19462080691, 5707.229524014288, 5716.085426331767, 5724.341700704473, 5735.483806457439, 5770.798022069207, 5357.464253574689, 5373.247745315659, 5389.622726409114, 5399.70301633414, 5401.027814993339, 4829.396325459317, 4852.539008794159, 4904.60763138948, 4910.533499317559, 4976.676516026447, 5864.560157988082, 5873.148393483007, 5874.206982057453, 5878.206442130343, 5881.941180588139, 5697.3448053474385, 5710.37185909558, 5712.714364281853, 5713.857153571194, 5714.0, 5632.2678051853, 5667.489925906688, 5689.8862022758485, 5690.630109042899, 5711.171880077449, 5398.352197736297, 5442.0, 5446.754896029609, 5446.809361672323, 5457.5633949283165, 5494.450554944633, 5532.75102620375, 5557.861053473695, 5558.91661625084, 5600.243967064394, 5456.645318054314, 5494.5054945055135, 5512.586556008235, 5520.944790552204, 5552.389237183826, 5496.0931446310915, 5518.061929471919, 5518.751656175402, 5528.198411230269, 5530.087535556588, 5295.655782374133, 5417.918731219113, 5441.0, 5460.890782184413, 5521.420250873761, 5578.30271216098, 5605.523530499953, 5639.182318563703, 5650.406707295675, 5694.288213973254, 5491.533219676372, 5509.311336082989, 5517.69652669107, 5520.972395137998, 5524.06090964529], "value": 5211.016274706764, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [587.0958723565709, 615.2893408113629, 629.2794750011237, 629.7764293675742, 636.9840105032474, 32580.511292330604, 35406.46890296647, 35455.82272088639, 43734.781326093325, 44569.55430445694, 45549.0, 45566.772166139126, 45927.77036114815, 45985.54014459854, 46067.30899036517, 8930.91069089309, 9062.093790620951, 9087.409318394317, 9088.863667045, 9089.318301127441, 8902.599383027748, 8979.46123232608, 8985.236254918307, 8991.145841145113, 8992.415492992966, 8930.240929520998, 8962.551872406386, 8962.775930601721, 8976.326775491863, 8980.910190898105, 8915.153060459246, 8985.550722463884, 8992.8651070234, 9005.864912026325, 9013.324000699908, 8980.236679882153, 9011.549422528848, 9027.638894444215, 9046.321525885585, 9048.41185322952, 42363.788181058895, 42676.78661606703, 42708.14583708309, 42718.78640606777, 42721.145577088595, 3505.3865573524786, 3555.1467647764607, 3676.74262801604, 3927.7643341399607, 4140.068484590973, 33233.0, 33589.0, 33843.0, 33845.49231761501, 34973.30053398943, 4304.504981927087, 4514.503404625489, 4621.3299071634765, 4634.351190833286, 4639.489656137822, 342658.0, 342743.9999999975, 342894.0, 343662.0, 344603.0, 60821.0, 61614.0, 61626.38373616296, 61627.999999999105, 61726.38273617296, 63708.0, 64373.0, 64519.677401612695, 64536.0, 64616.353836461974, 16618.6676266474, 16828.0, 16859.494215173563, 16879.40922067722, 16890.324387024626, 12537.686557836127, 12540.937295313464, 12556.309402982924, 12583.496660133675, 12612.55856045034, 16810.106059582427, 18521.907390462962, 18657.53356166107, 18658.44024679262, 18847.811521884607, 6210.565260431817, 6257.788589031629, 6352.396522330371, 6473.335831147746, 6530.118434011442, 970.4759429907912, 1071.5874388360537, 1079.3254216114929, 1135.3585224348217, 1165.8367828504017, 32675.509867352008, 32701.345973080406, 32845.67154328474, 33152.50271245933, 33518.162045949044, 1106.1427393769893, 1118.7147277444199, 1135.5968631135993, 1200.8258802473592, 1244.7199380139396, 17220.31118755261, 17408.0, 17590.0, 17630.121373297854, 17695.911520442573, 557953.0, 560501.0, 571474.0, 828511.0, 832096.0, 59356.0, 59729.40270597238, 60024.0, 60048.69975650094, 60059.0, 1253.5173958026044, 1321.4846209978116, 1360.4966162519931, 1361.4486133116104, 1383.5019393018506, 30174.84912575423, 34446.31107377889, 34661.30677386388, 34730.479042814884, 34810.65189348176, 53674.46325536694, 54844.725776372456, 54904.450955491535, 54905.0, 54954.17568736552, 502143.0, 514788.0, 519296.24574402545, 519498.0, 526580.0, 37727.62272377241, 44347.33478997882, 44890.326645101006, 45417.77291113523, 45884.31173532466, 49535.752321239604, 49571.50428495669, 49741.0, 50535.49464505308, 51627.0, 42066.7896660527, 42293.0, 42303.576964229964, 43090.353644694726, 43754.0, 42269.0, 42513.78743106265, 42813.785931070146, 43088.0, 43744.78127609342, 41776.0, 42398.788006059774, 43241.783791080845, 43400.78299608608, 43466.56533434751, 36518.26963460769, 37355.43966840554, 37672.62327376801, 37899.81050094732, 38388.0, 28056.579151313155, 28686.856565717873, 28793.424131516833, 28910.421791564473, 28918.42163156683], "value": 20951.60614482207, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [399.4846647824307, 402.2718878829319, 405.165359359719, 406.59137566745414, 414.074543395511, 13059.072138965888, 18376.264949402026, 19872.60254794905, 19902.50243743907, 20660.0, 15815.762763558556, 18786.0, 19426.805731942677, 19615.607687846234, 19815.5046123847, 5346.331708536423, 5502.064649009678, 5504.311961004874, 5516.668999860001, 5522.2544956430975, 5597.972010139943, 5687.687177205252, 5724.7996320128805, 5816.8836623267725, 5819.534437245032, 5683.971580142114, 5713.885722285552, 5735.283089613798, 5740.081586946089, 5740.282464691913, 5577.9959607270675, 5706.914396284038, 5711.029125048752, 5712.285964254468, 5766.106253530709, 5146.433892271847, 5166.173412254021, 5175.197844334134, 5196.142636464979, 5202.505761952609, 23633.29100126999, 23668.644970325287, 23917.402064948514, 24725.381865453328, 24728.3817904552, 2571.7042540107755, 2591.481703659276, 2664.120840122755, 2982.776291778125, 3172.952405713916, 14554.0, 14742.262886855615, 14743.483978060824, 15173.696526069527, 15311.081335119929, 1974.3385965701507, 2056.95886082279, 2075.0765909170427, 2082.5314304281414, 2084.94710171364, 81512.59243703802, 82577.0, 82962.58518707428, 84181.0, 85537.14462855353, 10446.843297350546, 10720.142388608892, 10943.4528273586, 10965.56137754481, 10986.450677466255, 15103.622409439851, 15182.848171518364, 15250.542483725507, 15254.0, 15278.618034549003, 7871.291583757489, 7986.440949133505, 8040.437169398203, 8127.715529956541, 8163.510189388656, 6943.305669433117, 7805.80485487856, 7890.092639346434, 7962.960185199037, 8023.59882005909, 6345.270293916259, 6597.34026597346, 6746.190457145174, 6839.316068393121, 6906.551074180162, 1877.680794264951, 1937.5543624966056, 1976.7133765603908, 1991.8904460254535, 2004.629143608437, 914.6387177065022, 958.4297343080856, 989.4656885281867, 1049.490996866519, 1177.8115501519715, 18968.905155474135, 20539.38381848547, 20652.0, 20796.896015520128, 20811.29453171078, 1031.7111208861381, 1031.9484025798681, 1043.3009883378154, 1053.9578416863394, 1084.0893649334596, 11347.20569560123, 11716.648500544998, 11854.288742675468, 11959.162858599988, 11973.940130299292, 476087.0, 476510.0, 479130.0, 513437.0, 513989.0, 83229.58385208156, 84003.15996839953, 85317.0, 85445.0, 87098.0, 1003.6386900715737, 1040.157472447305, 1060.0724366179593, 1061.5488417422564, 1064.5475672839013, 17929.73105403394, 18449.907750461163, 18693.532661683566, 18916.432507024812, 19082.618347633248, 41823.7908810454, 44081.55918440774, 44988.55011449844, 45598.31602525898, 46002.30996535122, 61844.381556183864, 62936.68531657312, 63684.59295092024, 64367.0, 66588.0, 8526.658933642584, 8550.486970781772, 8737.694180703898, 8919.152680495343, 9275.86086208694, 10322.587096516356, 13798.93100534491, 13895.791563126764, 14186.148831070168, 14326.283685815459, 11464.82802757976, 12030.458629361874, 12139.453724582592, 12185.756284874431, 12279.631611051684, 11032.338059716443, 11314.264572802742, 11514.30914145154, 11610.361430121424, 11669.416529173337, 10739.570417183537, 11544.19190656646, 11667.372300948735, 11724.648260552198, 11947.044236461235, 7748.845023099394, 8015.559144246889, 8061.1938806118915, 8337.916620833714, 8912.821743565222, 10508.579656813641, 11050.0, 11097.722556936142, 11197.328160310408, 11307.434628268718], "value": 9519.732453314937, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1253.110291692898, 1421.7796241582555, 1449.9782503262452, 1550.302363936229, 1780.0921530019687, 7725.18885517021, 8044.477108987911, 8051.074126475457, 8160.469569477979, 8224.218699223578, 8021.518708877471, 8163.0, 8175.0, 8200.507969521834, 8216.055153657331, 2042.7242322286525, 2288.4622113803243, 2307.861528308307, 2332.556814205304, 2369.277370402027, 2365.006697187177, 2372.240882917467, 2372.988135059331, 2375.1449478187924, 2377.0, 2267.047839907243, 2314.259436980167, 2328.0338659456306, 2331.6152834782242, 2342.7071616047992, 1949.6393167264102, 2014.8186663200236, 2018.1019446346381, 2198.835087368454, 2254.763249858766, 2292.1633603734685, 2304.481491664379, 2307.3770082077913, 2314.1206341590255, 2316.0851463671756, 8319.292860106898, 8362.790930226733, 8382.371322150862, 8395.580220988988, 8403.663853445854, 5008.549230569266, 5128.897422051576, 5135.152699804527, 5135.87160320995, 5140.049090918192, 3330.533725278463, 3341.114604629775, 3468.4623883298127, 3500.562429696288, 3506.333796578642, 1184.881511848817, 1190.1014733875954, 1202.0744027099172, 1228.7603917236142, 1248.2323371126784, 11529.365884876328, 11534.59628912984, 11544.711382215428, 11552.306861588331, 11553.0, 4358.106588149421, 4430.091831174602, 4579.587837094611, 4611.746353950565, 4613.008203236253, 9806.215502759762, 9807.26445516589, 9808.0, 9817.410955342559, 9820.459874706818, 5126.128558145124, 5131.435542090367, 5131.897362052738, 5135.768890399941, 5136.203888397305, 4132.834686612502, 4484.506704262529, 4611.492735799059, 4641.327007583949, 4691.695039822401, 3878.941815872764, 3929.724919255682, 3982.26328129297, 4021.7586944783407, 4047.210793895221, 1089.6458650938478, 1225.2036176485178, 1257.7107265329025, 1260.571405722059, 1268.8033354830015, 962.605331813953, 967.1778987860263, 982.8673129127619, 988.8615593816871, 995.7112437393075, 5778.191053252548, 5806.767729290866, 5990.940090599125, 6003.5797494174985, 6026.0, 984.7784248544164, 987.1115995604014, 996.3623281100101, 1010.751721623794, 1037.6108959140322, 4137.834486620502, 4183.142455796555, 4183.184279065553, 4222.767747773841, 4291.849785257564, 10153.64462243818, 10493.895061049292, 10551.94724026375, 10570.365778053341, 10600.681979540626, 10229.77242730877, 10358.482075896325, 10446.843297350546, 10458.790824183627, 10472.476376181314, 7898.723544675909, 7912.971313729063, 7995.560244186626, 8017.719379821679, 8031.237032481905, 5796.275465566804, 5848.210491583752, 5909.970450147894, 5946.613470124428, 5993.910091348721, 9591.42451452915, 9617.71146865595, 9655.468949207861, 9678.467684277432, 9738.123568878835, 9293.628254869729, 9564.834989105804, 9663.855042174233, 9664.71005869825, 9716.0, 7552.509086909334, 7657.0811502620045, 7706.460547761603, 7706.499077559941, 7716.035495563055, 7811.062672479112, 8007.279344858991, 8058.355331573577, 8219.54792486419, 8283.130271321665, 6092.299385570716, 7373.29953654402, 7458.03045604068, 7468.10382754073, 7665.3101220890385, 7193.352598266181, 7221.819454513679, 7232.602206878672, 7290.198078211286, 7418.517796343221, 6763.5941843489545, 6763.763268285783, 6764.053032575542, 6819.931800682129, 6828.317168283132, 4922.606191504743, 4998.4501704813165, 5005.374328208974, 5008.69947803133, 5096.694198348111, 4954.455009948975, 4987.0, 5006.349174607278, 5104.69371837691, 5114.820981265638], "value": 4520.593911545477, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [332.6606861001778, 333.225251290749, 336.50869730193915, 340.3686162169176, 341.515048630944, 5205.713685747282, 5219.191025391061, 5260.4213536511, 5279.313689220406, 5291.523762861341, 5198.68807871527, 5213.087709650815, 5242.659227150232, 5242.951409718062, 5263.578913686905, 3928.3910993795935, 3956.2592459317807, 3979.9801000994953, 4036.609248231485, 4049.068714195722, 3752.5496940367193, 4114.362273847559, 4127.938080928789, 4136.503619565641, 4138.668906487489, 4071.1857628474277, 4077.3476243800997, 4091.509018917719, 4091.509018917719, 4096.713230073896, 3933.5083114610675, 4030.8992275193064, 4093.5497095319492, 4100.405441211023, 4111.9103437589065, 3429.5198672185916, 3568.9107772305642, 3574.267275208602, 3635.672789448936, 3637.290728307981, 5050.444451110375, 5071.518205770482, 5083.79664813407, 5086.567641750456, 5100.112958205487, 4470.463544374663, 4667.95332046682, 4668.019715859674, 4682.2508398656055, 4689.179393606105, 5433.646812957145, 5458.263134476834, 5461.344638643349, 5470.276862788209, 5474.616776825624, 3948.4866967294356, 3951.2097580483733, 3964.861229856941, 3969.702272329587, 3969.8412063517426, 5152.201408781607, 5385.065139498944, 5646.85882852932, 5668.064769313059, 5675.51758100562, 3995.4805875236034, 4018.1160144768105, 4018.136100738297, 4029.2143032109043, 4029.4157347184496, 4053.3919912013434, 4065.7560546367313, 4078.6940979426663, 4080.143169934347, 4086.7547947123267, 4541.545845415432, 4610.976945115253, 4648.5357112509455, 4661.184292748755, 4673.878269215364, 5454.072807622713, 5456.836294911159, 5460.399356070829, 5477.534409575231, 5545.805896793673, 1385.9930700346433, 1397.503886120433, 1405.5150972914328, 1406.1000959386001, 1410.9012369134268, 875.6672464463463, 914.9295324470386, 917.7109210598641, 921.9904204895629, 924.0713083351324, 4697.95302046982, 4708.599769019604, 4723.220668589713, 4732.438295362522, 4762.833300834454, 4957.851764129804, 4981.2030075187795, 4985.205326082607, 5002.549770520671, 5007.672966663837, 4630.398161199508, 4653.441587009581, 4710.597595226459, 4725.078609671081, 4779.330893674888, 2627.697814751328, 2641.8298042349256, 2649.45686134342, 2696.824706394117, 2703.594460830891, 5063.265826455217, 5100.719460429637, 5105.310783044316, 5108.923366149511, 5138.434772175057, 5079.774343292036, 5086.465921078234, 5087.745612719349, 5376.973115134399, 5813.273340832396, 5819.359870414251, 5825.592208545361, 5842.357340692521, 5849.532037436995, 5861.329521086555, 5574.888502230014, 5600.0, 5616.185653080199, 5617.550595952396, 5618.241537392563, 5458.9454105458435, 5576.609637325349, 5591.8881622368135, 5602.803901863415, 5615.691136987505, 5585.748641311232, 5637.802676906289, 5823.272090988627, 5828.562857785599, 5835.241418615723, 4044.8584299549375, 4084.938725919173, 4089.734167279117, 4091.2635725569685, 4091.468109145792, 5551.583631227593, 5672.319321681424, 5672.659640421422, 5701.600887937804, 5701.9736447439855, 5484.149956756709, 5558.833235002957, 5566.638168519034, 5571.464983432447, 5581.888362232814, 5435.266239057677, 5453.836384908459, 5513.5037846592395, 5529.645236916981, 5539.556835453234, 5268.81559145428, 5446.863828404322, 5453.372862120907, 5493.23094766741, 5493.560515158858, 5521.420250873601, 5537.972310138423, 5542.61201715876, 5547.140193270049, 5562.415946325577, 5389.191621256686, 5424.3761967372675, 5425.376081750492, 5453.7545810439415, 5458.399576046552], "value": 4110.970965502324, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [798.5568009754587, 801.9879701804472, 841.932645388369, 843.211597156659, 848.3255811629757, 15742.449014284488, 16393.262303196356, 16413.671726565477, 17241.48275551732, 17994.640107197847, 14939.551813445587, 15003.624909377271, 15044.849551504481, 15110.320035598397, 15115.319810608522, 671.3521451799013, 820.0856045509274, 832.2260297922929, 832.7959649885756, 833.170994860112, 805.8066064144592, 828.5401602110857, 830.9709160179365, 831.3806214370303, 831.6091437024619, 861.8879545659056, 864.5374724522381, 868.6047848229041, 869.6086760957594, 870.5386145342947, 706.2125729811274, 718.6334969165763, 863.8099618084011, 864.148813418782, 864.9135086491364, 521.2754271562532, 611.0833749375936, 629.6820105846518, 632.9019002054689, 633.5850018238061, 15573.688526229525, 15739.055656660637, 15748.291326890318, 15755.684886302324, 15761.921190393974, 13449.66375840602, 13615.455381784717, 13629.454821807116, 13715.451381944711, 13905.79141312881, 12300.384980750927, 12451.501939922393, 12506.749865002648, 12521.373931303398, 12542.24746515203, 4502.549745025504, 4522.547745225484, 4649.465311489188, 4702.835400760991, 4769.880752981168, 75491.0, 75638.0, 76167.6191619044, 76330.0, 79047.20952790456, 11015.449227538591, 11092.112630989663, 11138.443077846076, 11314.490847911864, 11701.180917335874, 20006.89962052072, 20030.0, 20070.49823754418, 20088.89955550213, 20205.89897050505, 8256.1331060239, 8318.585830466625, 8413.242808147295, 8437.620307086196, 8480.236778689947, 4411.801468933906, 4559.475660299042, 4630.86107416778, 4713.34013238147, 4812.687175333592, 3364.512145738903, 3453.568303962005, 3466.7226621870695, 3468.4450487921813, 3505.4040813061843, 636.5798572941836, 642.5084810120262, 654.3097032630525, 693.5595896605691, 701.4003027411592, 658.397566226897, 763.576215200558, 765.1086484245791, 775.6160700453199, 798.8442253760577, 9604.327697061139, 10442.2168337375, 10593.046625803714, 10599.0, 10610.310329828537, 599.7031469422576, 706.9646517674096, 710.6446776611695, 717.1680850213727, 763.8854171874264, 4633.7683115844075, 4762.547557981986, 4795.712257264575, 4800.255960326155, 4854.635902307341, 123063.0, 126656.0, 127720.0, 127820.0, 129667.35166324297, 110176.4491177555, 110272.0, 111233.21367504359, 112152.0, 113910.43044784723, 95608.0, 96524.51737741266, 100146.4992675032, 100210.0, 100534.0, 9146.451212927246, 9298.279818233648, 9348.20540254086, 9421.85435416724, 9425.434473931586, 55584.0, 56894.7155264221, 58076.41923580879, 58717.70641146767, 59234.0, 53548.0, 80713.59643201981, 80891.19108808837, 80925.0, 81169.59415202886, 11697.23967942081, 11867.109966752701, 11902.285862848257, 11962.820557691815, 12105.213161144497, 14104.435822567393, 14261.144331340152, 14399.0, 14453.638659033608, 14494.710105798036, 12936.547220847226, 13340.466381344637, 13606.183628982293, 13694.65763355924, 13752.518661846787, 14139.575812725634, 14476.420943162155, 14765.630859228606, 14898.553043408716, 15385.69228615399, 13775.173489590657, 13789.931050344683, 14321.212333321768, 14507.0, 15087.849121508645, 11138.888611113785, 11526.250793698382, 11591.5942942, 11895.82156267674, 12039.398030098635, 11403.552465107965, 11731.824022639837, 11915.880841191823, 11991.0, 11997.580084697343], "value": 7762.702924614655, "unit": "score"}], "name": "dromaeo_css", "value": 7288.886717228235, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 112.0, 112.0, 113.0, 112.0, 112.0, 112.0, 113.0, 111.0, 112.0], "value": 111.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 121.0, 120.0, 179.0, 120.0, 118.0, 141.0, 118.0, 156.0, 117.0], "value": 133.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 160.0, 161.0, 160.0, 161.0, 161.0, 162.0, 162.0, 161.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 110.0, 76.0, 76.0, 74.0, 75.0, 101.0, 75.0], "value": 81.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 114.0, 84.0, 84.0, 87.0, 131.0, 84.0, 84.0, 132.0], "value": 96.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 118.0, 118.0, 118.0, 117.0, 117.0, 117.0, 117.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 145.0, 146.0, 146.0, 146.0, 147.0, 147.0, 145.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 50.0, 51.0, 52.0, 51.0, 52.0, 52.0, 51.0, 50.0, 51.0], "value": 51.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 61.0, 61.0, 61.0, 61.0, 62.0, 62.0, 61.0, 62.0], "value": 61.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 78.0, 80.0, 74.0, 74.0, 74.0, 74.0, 80.0, 74.0, 79.0], "value": 76.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 124.0, 116.0, 118.0, 118.0, 129.0, 123.0, 125.0, 201.0, 119.0], "value": 130.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 157.0, 157.0, 159.0, 158.0, 157.0, 159.0, 158.0, 153.0, 157.0], "value": 156.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 64.0, 65.0, 62.0, 63.0, 62.0, 66.0, 63.0, 61.0, 61.0], "value": 62.9, "unit": "score"}], "name": "kraken", "value": 1481.2000000000003, "alertThreshold": 2.0}]} 08:25:33 INFO - Return code: 0 08:25:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:25:33 INFO - # TBPL SUCCESS # 08:25:33 INFO - Running post-action listener: _resource_record_post_action 08:25:33 INFO - ##### 08:25:33 INFO - ##### Finished run-tests step (success) 08:25:33 INFO - ##### 08:25:33 INFO - Running post-run listener: _resource_record_post_run 08:25:33 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 564277248; Read time: 16; Write time: 574148 08:25:33 INFO - TinderboxPrint: CPU usage
13.0% 08:25:33 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 08:25:33 INFO - TinderboxPrint: I/O write bytes / time
564,277,248 / 574,148 08:25:33 INFO - TinderboxPrint: CPU idle
8,272.9 (86.9%) 08:25:33 INFO - TinderboxPrint: CPU user
1,196.0 (12.6%) 08:25:33 INFO - TinderboxPrint: Swap in / out
0 / 0 08:25:33 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 0; Write bytes: 270319616; Read time: 0; Write time: 267192 08:25:33 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 293957632; Read time: 0; Write time: 306956 08:25:33 INFO - Running post-run listener: _upload_blobber_files 08:25:33 INFO - Blob upload gear active. 08:25:33 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:25:33 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 08:25:33 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'] 08:25:33 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 08:25:34 INFO - (blobuploader) - INFO - Open directory for files ... 08:25:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:25:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:25:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:25:37 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:25:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:25:37 INFO - (blobuploader) - INFO - Done attempting. 08:25:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:25:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:25:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:25:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:25:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:25:38 INFO - (blobuploader) - INFO - Done attempting. 08:25:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:25:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:25:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:25:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:25:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:25:39 INFO - (blobuploader) - INFO - Done attempting. 08:25:39 INFO - (blobuploader) - INFO - Iteration through files over. 08:25:39 INFO - Return code: 0 08:25:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:25:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:25:39 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/439d01b306aa1183d3368729680c6901cec1e3b05f9f86ac309f23f30ef7f5e11b8237ebecde3617a4e84bb1ac87bcc82882f9ca6f1bfa1ebf0430ab339a1216", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6acc25e54167a866c2c02bb2820bfea993943bba034e799d32c83d3fec1fcf44374409a9ad01ac34bbfb5ab6f8f0042bbc109554844ec7d726e3f522e0ce5ad1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3a03f22f1598c74a61bb8966f79394109e9c47bb2b1dbb7391b8aeed549440f6c5df08d87b6e7c1fe26834c9e01c7d0df788b4aaa8e8052fd1034bd42ba02fff"} 08:25:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:25:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:25:39 INFO - Contents: 08:25:39 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/439d01b306aa1183d3368729680c6901cec1e3b05f9f86ac309f23f30ef7f5e11b8237ebecde3617a4e84bb1ac87bcc82882f9ca6f1bfa1ebf0430ab339a1216", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6acc25e54167a866c2c02bb2820bfea993943bba034e799d32c83d3fec1fcf44374409a9ad01ac34bbfb5ab6f8f0042bbc109554844ec7d726e3f522e0ce5ad1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3a03f22f1598c74a61bb8966f79394109e9c47bb2b1dbb7391b8aeed549440f6c5df08d87b6e7c1fe26834c9e01c7d0df788b4aaa8e8052fd1034bd42ba02fff"} 08:25:39 INFO - Running post-run listener: copy_logs_to_upload_dir 08:25:39 INFO - Copying logs to upload dir... 08:25:39 INFO - mkdir: /builds/slave/test/build/upload/logs 08:25:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.295145 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-07-14 08:25:38.810423) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-14 08:25:38.813996) ========= 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=fa44defc139c4ba8574fe040000001db-1468508308.717854-1747155146 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/439d01b306aa1183d3368729680c6901cec1e3b05f9f86ac309f23f30ef7f5e11b8237ebecde3617a4e84bb1ac87bcc82882f9ca6f1bfa1ebf0430ab339a1216", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6acc25e54167a866c2c02bb2820bfea993943bba034e799d32c83d3fec1fcf44374409a9ad01ac34bbfb5ab6f8f0042bbc109554844ec7d726e3f522e0ce5ad1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3a03f22f1598c74a61bb8966f79394109e9c47bb2b1dbb7391b8aeed549440f6c5df08d87b6e7c1fe26834c9e01c7d0df788b4aaa8e8052fd1034bd42ba02fff"} build_url:https://queue.taskcluster.net/v1/task/FAsVQeQoRj2zL56XiX8OuA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011325 build_url: 'https://queue.taskcluster.net/v1/task/FAsVQeQoRj2zL56XiX8OuA/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/439d01b306aa1183d3368729680c6901cec1e3b05f9f86ac309f23f30ef7f5e11b8237ebecde3617a4e84bb1ac87bcc82882f9ca6f1bfa1ebf0430ab339a1216", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6acc25e54167a866c2c02bb2820bfea993943bba034e799d32c83d3fec1fcf44374409a9ad01ac34bbfb5ab6f8f0042bbc109554844ec7d726e3f522e0ce5ad1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3a03f22f1598c74a61bb8966f79394109e9c47bb2b1dbb7391b8aeed549440f6c5df08d87b6e7c1fe26834c9e01c7d0df788b4aaa8e8052fd1034bd42ba02fff"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-14 08:25:38.839171) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 08:25:38.839500) ========= 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=fa44defc139c4ba8574fe040000001db-1468508308.717854-1747155146 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004448 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 08:25:38.925794) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-14 08:25:38.926132) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-14 08:25:38.926477) ========= ========= Total master_lag: 0.16 =========