builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-035 starttime: 1468251903.57 results: success (0) buildid: 20160711072227 builduid: 22992587034e46f485b6c816aff8012b revision: 214884d507ee369c1cf14edb26527c4f9a97bf48 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-11 08:45:03.573817) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-11 08:45:03.574338) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-11 08:45:03.574639) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-11 08:45:03.593073) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 08:45:03.593485) ========= 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=ed14279e38b05397cf4aa391000001a4-1468251734.370168-765231984 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-11 08:45: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% 17.1M=0.001s 2016-07-11 08:45:04 (17.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.094496 ========= master_lag: 0.31 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 08:45:03.998142) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 08:45:03.998471) ========= 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=ed14279e38b05397cf4aa391000001a4-1468251734.370168-765231984 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018452 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 08:45:04.029383) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-11 08:45:04.032819) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 214884d507ee369c1cf14edb26527c4f9a97bf48 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 214884d507ee369c1cf14edb26527c4f9a97bf48 --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=ed14279e38b05397cf4aa391000001a4-1468251734.370168-765231984 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-11 08:45:05,155 truncating revision to first 12 chars 2016-07-11 08:45:05,155 Setting DEBUG logging. 2016-07-11 08:45:05,155 attempt 1/10 2016-07-11 08:45:05,155 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/214884d507ee?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-11 08:45:06,396 unpacking tar archive at: mozilla-central-214884d507ee/testing/mozharness/ program finished with exit code 0 elapsedTime=1.605229 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-11 08:45:05.653469) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-11 08:45:05.653806) ========= script_repo_revision: 214884d507ee369c1cf14edb26527c4f9a97bf48 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-11 08:45:05.654363) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-11 08:45:05.654859) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-11 08:45:05.665549) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-07-11 08:45:05.665818) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 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', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=ed14279e38b05397cf4aa391000001a4-1468251734.370168-765231984 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:45:06 INFO - MultiFileLogger online at 20160711 08:45:06 in /builds/slave/test 08:45:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 08:45:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:45:06 INFO - {'append_to_log': False, 08:45:06 INFO - 'base_work_dir': '/builds/slave/test', 08:45:06 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 08:45:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:45:06 INFO - 'branch': 'Firefox-Non-PGO', 08:45:06 INFO - 'buildbot_json_path': 'buildprops.json', 08:45:06 INFO - 'config_files': ('talos/linux_config.py',), 08:45:06 INFO - 'default_actions': ('clobber', 08:45:06 INFO - 'read-buildbot-config', 08:45:06 INFO - 'download-and-extract', 08:45:06 INFO - 'populate-webroot', 08:45:06 INFO - 'create-virtualenv', 08:45:06 INFO - 'install', 08:45:06 INFO - 'run-tests'), 08:45:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:45:06 INFO - 'download_minidump_stackwalk': True, 08:45:06 INFO - 'download_symbols': 'ondemand', 08:45:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:45:06 INFO - 'tooltool.py': '/tools/tooltool.py', 08:45:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:45:06 INFO - '/tools/misc-python/virtualenv.py')}, 08:45:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:45:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:45:06 INFO - 'installer_path': 'installer.exe', 08:45:06 INFO - 'log_level': 'info', 08:45:06 INFO - 'log_name': 'talos', 08:45:06 INFO - 'log_to_console': True, 08:45:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:45:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:45:06 INFO - 'opt_config_files': (), 08:45:06 INFO - 'pip_index': False, 08:45:06 INFO - 'sps_profile': False, 08:45:06 INFO - 'sps_profile_interval': 0, 08:45:06 INFO - 'suite': 'dromaeojs', 08:45:06 INFO - 'system_bits': '32', 08:45:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:45:06 INFO - 'title': 'talos-linux64-ix-035', 08:45:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:45:06 INFO - 'use_talos_json': True, 08:45:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:45:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:45:06 INFO - 'work_dir': 'build'} 08:45:06 INFO - ##### 08:45:06 INFO - ##### Running clobber step. 08:45:06 INFO - ##### 08:45:06 INFO - Running pre-action listener: _resource_record_pre_action 08:45:06 INFO - Running main action method: clobber 08:45:06 INFO - rmtree: /builds/slave/test/build 08:45:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:45:07 INFO - Running post-action listener: _resource_record_post_action 08:45:07 INFO - ##### 08:45:07 INFO - ##### Finished clobber step (success) 08:45:07 INFO - ##### 08:45:07 INFO - ##### 08:45:07 INFO - ##### Running read-buildbot-config step. 08:45:07 INFO - ##### 08:45:07 INFO - Running pre-action listener: _resource_record_pre_action 08:45:07 INFO - Running main action method: read_buildbot_config 08:45:07 INFO - Using buildbot properties: 08:45:07 INFO - { 08:45:07 INFO - "project": "", 08:45:07 INFO - "product": "firefox", 08:45:07 INFO - "script_repo_revision": "production", 08:45:07 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 08:45:07 INFO - "repository": "", 08:45:07 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 08:45:07 INFO - "buildid": "20160711072227", 08:45:07 INFO - "pgo_build": "False", 08:45:07 INFO - "basedir": "/builds/slave/test", 08:45:07 INFO - "buildnumber": 143, 08:45:07 INFO - "slavename": "talos-linux64-ix-035", 08:45:07 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 08:45:07 INFO - "platform": "ubuntu64_hw", 08:45:07 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 08:45:07 INFO - "branch": "mozilla-central", 08:45:07 INFO - "repo_path": "mozilla-central", 08:45:07 INFO - "revision": "214884d507ee369c1cf14edb26527c4f9a97bf48", 08:45:07 INFO - "stage_platform": "linux64", 08:45:07 INFO - "builduid": "22992587034e46f485b6c816aff8012b", 08:45:07 INFO - "slavebuilddir": "test" 08:45:07 INFO - } 08:45:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/dF1r_xBQS6GuOywinxjs7Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 08:45:07 INFO - Running post-action listener: _resource_record_post_action 08:45:07 INFO - ##### 08:45:07 INFO - ##### Finished read-buildbot-config step (success) 08:45:07 INFO - ##### 08:45:07 INFO - ##### 08:45:07 INFO - ##### Running download-and-extract step. 08:45:07 INFO - ##### 08:45:07 INFO - Running pre-action listener: _resource_record_pre_action 08:45:07 INFO - Running main action method: download_and_extract 08:45:07 INFO - mkdir: /builds/slave/test/build/tests 08:45:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:45:07 INFO - https://queue.taskcluster.net/v1/task/dF1r_xBQS6GuOywinxjs7Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:45:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dF1r_xBQS6GuOywinxjs7Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:45:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dF1r_xBQS6GuOywinxjs7Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:45:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dF1r_xBQS6GuOywinxjs7Q/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:45:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dF1r_xBQS6GuOywinxjs7Q/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:45:08 INFO - Downloaded 1361 bytes. 08:45:08 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:45:08 INFO - Using the following test package requirements: 08:45:08 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:45:08 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:45:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:45:08 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:45:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:45:08 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:45:08 INFO - u'jsshell-linux-x86_64.zip'], 08:45:08 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:45:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:45:08 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:45:08 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:45:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:45:08 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:45:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:45:08 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:45:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:45:08 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:45:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:45:08 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:45: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:45:08 INFO - https://queue.taskcluster.net/v1/task/dF1r_xBQS6GuOywinxjs7Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:45:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dF1r_xBQS6GuOywinxjs7Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:45:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dF1r_xBQS6GuOywinxjs7Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:45:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dF1r_xBQS6GuOywinxjs7Q/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:45:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dF1r_xBQS6GuOywinxjs7Q/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:45:09 INFO - Downloaded 22737688 bytes. 08:45:09 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:45:09 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:45:10 INFO - Return code: 0 08:45:10 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:45:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:45:10 INFO - https://queue.taskcluster.net/v1/task/dF1r_xBQS6GuOywinxjs7Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:45:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dF1r_xBQS6GuOywinxjs7Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:45:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dF1r_xBQS6GuOywinxjs7Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:45:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dF1r_xBQS6GuOywinxjs7Q/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:45:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dF1r_xBQS6GuOywinxjs7Q/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:45:11 INFO - Downloaded 22737688 bytes. 08:45:11 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:45:11 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:45:12 INFO - Return code: 0 08:45:12 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:45:12 INFO - https://queue.taskcluster.net/v1/task/dF1r_xBQS6GuOywinxjs7Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:45:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dF1r_xBQS6GuOywinxjs7Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:45:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dF1r_xBQS6GuOywinxjs7Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:45:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dF1r_xBQS6GuOywinxjs7Q/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:45:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dF1r_xBQS6GuOywinxjs7Q/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:45:14 INFO - Downloaded 14403333 bytes. 08:45:14 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:45:14 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 08:45:14 INFO - Return code: 0 08:45: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:45:14 INFO - https://queue.taskcluster.net/v1/task/dF1r_xBQS6GuOywinxjs7Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:45:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dF1r_xBQS6GuOywinxjs7Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:45:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dF1r_xBQS6GuOywinxjs7Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:45:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dF1r_xBQS6GuOywinxjs7Q/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:45:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dF1r_xBQS6GuOywinxjs7Q/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:45:16 INFO - Downloaded 56653007 bytes. 08:45:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dF1r_xBQS6GuOywinxjs7Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:45:16 INFO - mkdir: /builds/slave/test/properties 08:45:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:45:16 INFO - Writing to file /builds/slave/test/properties/build_url 08:45:16 INFO - Contents: 08:45:16 INFO - build_url:https://queue.taskcluster.net/v1/task/dF1r_xBQS6GuOywinxjs7Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:45:17 INFO - Running post-action listener: _resource_record_post_action 08:45:17 INFO - Running post-action listener: set_extra_try_arguments 08:45:17 INFO - ##### 08:45:17 INFO - ##### Finished download-and-extract step (success) 08:45:17 INFO - ##### 08:45:17 INFO - ##### 08:45:17 INFO - ##### Running populate-webroot step. 08:45:17 INFO - ##### 08:45:17 INFO - Running pre-action listener: _resource_record_pre_action 08:45:17 INFO - Running main action method: populate_webroot 08:45:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:45:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:45:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:45:17 INFO - '--tppagecycles', 08:45:17 INFO - '7'], 08:45:17 INFO - 'tests': ['tsvgm']}}, 08:45:17 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:45:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:45:17 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:45:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:45:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:45:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:45:17 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:45:17 INFO - 'talos_options': ['--disable-e10s'], 08:45:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:45:17 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:45:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:45:17 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:45:17 INFO - 'talos_options': ['--disable-e10s'], 08:45:17 INFO - 'tests': ['damp', 'tps']}, 08:45:17 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:45:17 INFO - 'tests': ['damp', 'tps']}, 08:45:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:45:17 INFO - 'tests': ['dromaeo_dom']}, 08:45:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:45:17 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:45:17 INFO - 'tests': ['basic_compositor_video']}, 08:45:17 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:45:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:45:17 INFO - 'tests': ['a11yr', 08:45:17 INFO - 'ts_paint', 08:45:17 INFO - 'tpaint', 08:45:17 INFO - 'sessionrestore', 08:45:17 INFO - 'sessionrestore_no_auto_restore', 08:45:17 INFO - 'tabpaint']}, 08:45:17 INFO - 'other-e10s': {'tests': ['a11yr', 08:45:17 INFO - 'ts_paint', 08:45:17 INFO - 'tpaint', 08:45:17 INFO - 'sessionrestore', 08:45:17 INFO - 'sessionrestore_no_auto_restore', 08:45:17 INFO - 'tabpaint']}, 08:45:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:45:17 INFO - 'ts_paint', 08:45:17 INFO - 'tpaint', 08:45:17 INFO - 'sessionrestore', 08:45:17 INFO - 'sessionrestore_no_auto_restore', 08:45:17 INFO - 'tabpaint']}, 08:45:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:45:17 INFO - 'ts_paint', 08:45:17 INFO - 'tpaint', 08:45:17 INFO - 'sessionrestore', 08:45:17 INFO - 'sessionrestore_no_auto_restore', 08:45:17 INFO - 'tabpaint']}, 08:45:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:45:17 INFO - 'tests': ['a11yr', 08:45:17 INFO - 'ts_paint', 08:45:17 INFO - 'tpaint', 08:45:17 INFO - 'sessionrestore', 08:45:17 INFO - 'sessionrestore_no_auto_restore', 08:45:17 INFO - 'tabpaint']}, 08:45:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:45:17 INFO - 'tests': ['a11yr', 08:45:17 INFO - 'ts_paint', 08:45:17 INFO - 'tpaint', 08:45:17 INFO - 'sessionrestore', 08:45:17 INFO - 'sessionrestore_no_auto_restore', 08:45:17 INFO - 'tabpaint']}, 08:45:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:45:17 INFO - 'tests': ['tsvgx', 08:45:17 INFO - 'tsvgr_opacity', 08:45:17 INFO - 'tart', 08:45:17 INFO - 'tscrollx', 08:45:17 INFO - 'cart']}, 08:45:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:45:17 INFO - 'tsvgr_opacity', 08:45:17 INFO - 'tart', 08:45:17 INFO - 'tscrollx', 08:45:17 INFO - 'cart']}, 08:45:17 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:45:17 INFO - 'talos_options': ['--disable-e10s'], 08:45:17 INFO - 'tests': ['tp5o']}, 08:45:17 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:45:17 INFO - 'tests': ['tp5o']}, 08:45:17 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:45:17 INFO - 'talos_options': ['--disable-e10s', 08:45:17 INFO - '--xperf_path', 08:45:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:45:17 INFO - 'tests': ['tp5n']}, 08:45:17 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:45:17 INFO - 'talos_options': ['--xperf_path', 08:45:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:45:17 INFO - 'tests': ['tp5n']}}, 08:45:17 INFO - 'talos.zip': {'path': '', 08:45:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:45:17 INFO - Running post-action listener: _resource_record_post_action 08:45:17 INFO - ##### 08:45:17 INFO - ##### Finished populate-webroot step (success) 08:45:17 INFO - ##### 08:45:17 INFO - ##### 08:45:17 INFO - ##### Running create-virtualenv step. 08:45:17 INFO - ##### 08:45:17 INFO - Running pre-action listener: _resource_record_pre_action 08:45:17 INFO - Running main action method: create_virtualenv 08:45:17 INFO - Creating virtualenv /builds/slave/test/build/venv 08:45:17 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:45:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:45:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:45:17 INFO - Using real prefix '/usr' 08:45:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:45:18 INFO - Installing distribute.............................................................................................................................................................................................done. 08:45:20 INFO - Installing pip.................done. 08:45:20 INFO - Return code: 0 08:45:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:45:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:45:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:45:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd01030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfc2180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc03b0>, '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 0xfc12b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfc1740>, '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': 'ed14279e38b05397cf4aa391000001a4-1468251734.370168-765231984', '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:45:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:45:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:45:20 INFO - Using env: {'DISPLAY': ':0', 08:45:20 INFO - 'HOME': '/home/cltbld', 08:45:20 INFO - 'LANG': 'en_US.UTF-8', 08:45:20 INFO - 'LANGUAGE': 'en_US:en', 08:45:20 INFO - 'LOGNAME': 'cltbld', 08:45:20 INFO - 'MAIL': '/var/mail/cltbld', 08:45:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:20 INFO - 'MOZ_NO_REMOTE': '1', 08:45:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:45:20 INFO - 'NO_EM_RESTART': '1', 08:45:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:45:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:20 INFO - 'PWD': '/builds/slave/test', 08:45:20 INFO - 'SHELL': '/bin/bash', 08:45:20 INFO - 'SHLVL': '1', 08:45:20 INFO - 'TERM': 'linux', 08:45:20 INFO - 'TMOUT': '86400', 08:45:20 INFO - 'USER': 'cltbld', 08:45:20 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1468251734.370168-765231984', 08:45:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:20 INFO - '_': '/tools/buildbot/bin/python'} 08:45:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:20 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:45:20 INFO - Cleaning up... 08:45:20 INFO - Return code: 0 08:45:20 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:45:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:45:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:45:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xd01030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfc2180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc03b0>, '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 0xfc12b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfc1740>, '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': 'ed14279e38b05397cf4aa391000001a4-1468251734.370168-765231984', '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:45:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:45:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:45:20 INFO - Using env: {'DISPLAY': ':0', 08:45:20 INFO - 'HOME': '/home/cltbld', 08:45:20 INFO - 'LANG': 'en_US.UTF-8', 08:45:20 INFO - 'LANGUAGE': 'en_US:en', 08:45:20 INFO - 'LOGNAME': 'cltbld', 08:45:20 INFO - 'MAIL': '/var/mail/cltbld', 08:45:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:20 INFO - 'MOZ_NO_REMOTE': '1', 08:45:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:45:20 INFO - 'NO_EM_RESTART': '1', 08:45:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:45:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:20 INFO - 'PWD': '/builds/slave/test', 08:45:20 INFO - 'SHELL': '/bin/bash', 08:45:20 INFO - 'SHLVL': '1', 08:45:20 INFO - 'TERM': 'linux', 08:45:20 INFO - 'TMOUT': '86400', 08:45:20 INFO - 'USER': 'cltbld', 08:45:20 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1468251734.370168-765231984', 08:45:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:20 INFO - '_': '/tools/buildbot/bin/python'} 08:45:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:20 INFO - Downloading/unpacking psutil>=3.1.1 08:45:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:45:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:45:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:45:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:45:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:45:22 INFO - Installing collected packages: psutil 08:45:22 INFO - Running setup.py install for psutil 08:45:22 INFO - building 'psutil._psutil_linux' extension 08:45:22 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 08:45:22 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 08:45:22 INFO - building 'psutil._psutil_posix' extension 08:45:22 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 08:45:23 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 08:45:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:45:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:45:23 INFO - Successfully installed psutil 08:45:23 INFO - Cleaning up... 08:45:23 INFO - Return code: 0 08:45:23 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:45:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:45:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:45:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd01030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfc2180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc03b0>, '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 0xfc12b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfc1740>, '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': 'ed14279e38b05397cf4aa391000001a4-1468251734.370168-765231984', '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:45:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:45:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:45:23 INFO - Using env: {'DISPLAY': ':0', 08:45:23 INFO - 'HOME': '/home/cltbld', 08:45:23 INFO - 'LANG': 'en_US.UTF-8', 08:45:23 INFO - 'LANGUAGE': 'en_US:en', 08:45:23 INFO - 'LOGNAME': 'cltbld', 08:45:23 INFO - 'MAIL': '/var/mail/cltbld', 08:45:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:23 INFO - 'MOZ_NO_REMOTE': '1', 08:45:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:45:23 INFO - 'NO_EM_RESTART': '1', 08:45:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:45:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:23 INFO - 'PWD': '/builds/slave/test', 08:45:23 INFO - 'SHELL': '/bin/bash', 08:45:23 INFO - 'SHLVL': '1', 08:45:23 INFO - 'TERM': 'linux', 08:45:23 INFO - 'TMOUT': '86400', 08:45:23 INFO - 'USER': 'cltbld', 08:45:23 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1468251734.370168-765231984', 08:45:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:23 INFO - '_': '/tools/buildbot/bin/python'} 08:45:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:23 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:45:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:45:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:45:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:25 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:45:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:45:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:45:25 INFO - Installing collected packages: mozsystemmonitor 08:45:25 INFO - Running setup.py install for mozsystemmonitor 08:45:25 INFO - Successfully installed mozsystemmonitor 08:45:25 INFO - Cleaning up... 08:45:25 INFO - Return code: 0 08:45:25 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:45:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:45:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:45:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xd01030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfc2180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc03b0>, '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 0xfc12b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfc1740>, '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': 'ed14279e38b05397cf4aa391000001a4-1468251734.370168-765231984', '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:45:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:45:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:45:25 INFO - Using env: {'DISPLAY': ':0', 08:45:25 INFO - 'HOME': '/home/cltbld', 08:45:25 INFO - 'LANG': 'en_US.UTF-8', 08:45:25 INFO - 'LANGUAGE': 'en_US:en', 08:45:25 INFO - 'LOGNAME': 'cltbld', 08:45:25 INFO - 'MAIL': '/var/mail/cltbld', 08:45:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:25 INFO - 'MOZ_NO_REMOTE': '1', 08:45:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:45:25 INFO - 'NO_EM_RESTART': '1', 08:45:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:45:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:25 INFO - 'PWD': '/builds/slave/test', 08:45:25 INFO - 'SHELL': '/bin/bash', 08:45:25 INFO - 'SHLVL': '1', 08:45:25 INFO - 'TERM': 'linux', 08:45:25 INFO - 'TMOUT': '86400', 08:45:25 INFO - 'USER': 'cltbld', 08:45:25 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1468251734.370168-765231984', 08:45:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:25 INFO - '_': '/tools/buildbot/bin/python'} 08:45:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:25 INFO - Downloading/unpacking jsonschema==2.5.1 08:45:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:45:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:45:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:45:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:45:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:45:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:45:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:27 INFO - Downloading functools32-3.2.3-2.tar.gz 08:45:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:45:28 INFO - warning: no files found matching '*.txt' 08:45:28 INFO - no previously-included directories found matching 'build' 08:45:28 INFO - no previously-included directories found matching 'dist' 08:45:28 INFO - no previously-included directories found matching '.git*' 08:45:28 INFO - Installing collected packages: jsonschema, functools32 08:45:28 INFO - Running setup.py install for functools32 08:45:28 INFO - warning: no files found matching '*.txt' 08:45:28 INFO - no previously-included directories found matching 'build' 08:45:28 INFO - no previously-included directories found matching 'dist' 08:45:28 INFO - no previously-included directories found matching '.git*' 08:45:28 INFO - Successfully installed jsonschema functools32 08:45:28 INFO - Cleaning up... 08:45:28 INFO - Return code: 0 08:45:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:45:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:45:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:45:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xd01030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfc2180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc03b0>, '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 0xfc12b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfc1740>, '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': 'ed14279e38b05397cf4aa391000001a4-1468251734.370168-765231984', '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:45:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:45:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:45:28 INFO - Using env: {'DISPLAY': ':0', 08:45:28 INFO - 'HOME': '/home/cltbld', 08:45:28 INFO - 'LANG': 'en_US.UTF-8', 08:45:28 INFO - 'LANGUAGE': 'en_US:en', 08:45:28 INFO - 'LOGNAME': 'cltbld', 08:45:28 INFO - 'MAIL': '/var/mail/cltbld', 08:45:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:28 INFO - 'MOZ_NO_REMOTE': '1', 08:45:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:45:28 INFO - 'NO_EM_RESTART': '1', 08:45:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:45:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:28 INFO - 'PWD': '/builds/slave/test', 08:45:28 INFO - 'SHELL': '/bin/bash', 08:45:28 INFO - 'SHLVL': '1', 08:45:28 INFO - 'TERM': 'linux', 08:45:28 INFO - 'TMOUT': '86400', 08:45:28 INFO - 'USER': 'cltbld', 08:45:28 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1468251734.370168-765231984', 08:45:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:28 INFO - '_': '/tools/buildbot/bin/python'} 08:45:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:28 INFO - Downloading/unpacking blobuploader==1.2.4 08:45: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:45: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:45: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:45: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:45: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:45: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:45:30 INFO - Downloading blobuploader-1.2.4.tar.gz 08:45:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:45:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:45:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:45:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:45:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:45:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:45:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:45:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:45:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:31 INFO - Downloading docopt-0.6.1.tar.gz 08:45:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:45:31 INFO - Installing collected packages: blobuploader, requests, docopt 08:45:31 INFO - Running setup.py install for blobuploader 08:45:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:45:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:45:31 INFO - Running setup.py install for requests 08:45:31 INFO - Running setup.py install for docopt 08:45:31 INFO - Successfully installed blobuploader requests docopt 08:45:31 INFO - Cleaning up... 08:45:31 INFO - Return code: 0 08:45:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:45:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:45:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:45:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd01030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfc2180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc03b0>, '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 0xfc12b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfc1740>, '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': 'ed14279e38b05397cf4aa391000001a4-1468251734.370168-765231984', '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:45:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:45:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:45:31 INFO - Using env: {'DISPLAY': ':0', 08:45:31 INFO - 'HOME': '/home/cltbld', 08:45:31 INFO - 'LANG': 'en_US.UTF-8', 08:45:31 INFO - 'LANGUAGE': 'en_US:en', 08:45:31 INFO - 'LOGNAME': 'cltbld', 08:45:31 INFO - 'MAIL': '/var/mail/cltbld', 08:45:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:31 INFO - 'MOZ_NO_REMOTE': '1', 08:45:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:45:31 INFO - 'NO_EM_RESTART': '1', 08:45:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:45:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:31 INFO - 'PWD': '/builds/slave/test', 08:45:31 INFO - 'SHELL': '/bin/bash', 08:45:31 INFO - 'SHLVL': '1', 08:45:31 INFO - 'TERM': 'linux', 08:45:31 INFO - 'TMOUT': '86400', 08:45:31 INFO - 'USER': 'cltbld', 08:45:31 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1468251734.370168-765231984', 08:45:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:31 INFO - '_': '/tools/buildbot/bin/python'} 08:45:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:45:32 INFO - Running setup.py (path:/tmp/pip-vWguO0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:45:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:45:32 INFO - Running setup.py (path:/tmp/pip-0yANwP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:45:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:45:32 INFO - Running setup.py (path:/tmp/pip-Ej7JQs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:45:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:45:32 INFO - Running setup.py (path:/tmp/pip-ZTjReS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:45:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:45:32 INFO - Running setup.py (path:/tmp/pip-kx81hm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:45:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:45:32 INFO - Running setup.py (path:/tmp/pip-AAsvsL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:45:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:45:32 INFO - Running setup.py (path:/tmp/pip-7bjsTB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:45:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:45:32 INFO - Running setup.py (path:/tmp/pip-ZT3jTB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:45:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:45:32 INFO - Running setup.py (path:/tmp/pip-ChHE38-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:45:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:45:32 INFO - Running setup.py (path:/tmp/pip-KXtDOV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:45:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:45:32 INFO - Running setup.py (path:/tmp/pip-e24BwW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:45:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:45:32 INFO - Running setup.py (path:/tmp/pip-N3torQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:45:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:45:32 INFO - Running setup.py (path:/tmp/pip-jO3Ozl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:45:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:45:32 INFO - Running setup.py (path:/tmp/pip-nf9AZp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:45:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:45:33 INFO - Running setup.py (path:/tmp/pip-3QpBld-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:45:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:45:33 INFO - Running setup.py (path:/tmp/pip-DzjISs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:45:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:45:33 INFO - Running setup.py (path:/tmp/pip-_E4ks_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:45:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:45:33 INFO - Running setup.py install for manifestparser 08:45:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:45:33 INFO - Running setup.py install for mozcrash 08:45:33 INFO - Running setup.py install for mozdebug 08:45:33 INFO - Running setup.py install for mozdevice 08:45:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:45:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:45:33 INFO - Running setup.py install for mozfile 08:45:33 INFO - Running setup.py install for mozhttpd 08:45:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:45:33 INFO - Running setup.py install for mozinfo 08:45:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:45:33 INFO - Running setup.py install for mozInstall 08:45:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:45:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:45:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:45:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:45:34 INFO - Running setup.py install for mozleak 08:45:34 INFO - Running setup.py install for mozlog 08:45:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:45:34 INFO - Running setup.py install for moznetwork 08:45:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:45:34 INFO - Running setup.py install for mozprocess 08:45:34 INFO - Running setup.py install for mozprofile 08:45:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:45:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:45:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:45:34 INFO - Running setup.py install for mozrunner 08:45:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:45:34 INFO - Running setup.py install for mozscreenshot 08:45:34 INFO - Running setup.py install for moztest 08:45:34 INFO - Running setup.py install for mozversion 08:45:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:45:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:45:35 INFO - Cleaning up... 08:45:35 INFO - Return code: 0 08:45:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:45: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:45:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45: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:45:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45: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 0xd01030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfc2180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc03b0>, '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 0xfc12b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfc1740>, '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': 'ed14279e38b05397cf4aa391000001a4-1468251734.370168-765231984', '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:45: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:45: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:45:35 INFO - Using env: {'DISPLAY': ':0', 08:45:35 INFO - 'HOME': '/home/cltbld', 08:45:35 INFO - 'LANG': 'en_US.UTF-8', 08:45:35 INFO - 'LANGUAGE': 'en_US:en', 08:45:35 INFO - 'LOGNAME': 'cltbld', 08:45:35 INFO - 'MAIL': '/var/mail/cltbld', 08:45:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:35 INFO - 'MOZ_NO_REMOTE': '1', 08:45:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:45:35 INFO - 'NO_EM_RESTART': '1', 08:45:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:45:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:35 INFO - 'PWD': '/builds/slave/test', 08:45:35 INFO - 'SHELL': '/bin/bash', 08:45:35 INFO - 'SHLVL': '1', 08:45:35 INFO - 'TERM': 'linux', 08:45:35 INFO - 'TMOUT': '86400', 08:45:35 INFO - 'USER': 'cltbld', 08:45:35 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1468251734.370168-765231984', 08:45:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:35 INFO - '_': '/tools/buildbot/bin/python'} 08:45:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:45:35 INFO - Running setup.py (path:/tmp/pip-bV38w6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:45:35 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:45:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:45:35 INFO - Running setup.py (path:/tmp/pip-thoEqg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:45:35 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:45:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:45:35 INFO - Running setup.py (path:/tmp/pip-wcNgs_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:45:35 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:45:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:45:35 INFO - Running setup.py (path:/tmp/pip-DFAGFT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:45:35 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:45:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:45:35 INFO - Running setup.py (path:/tmp/pip-5NyQBd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:45:35 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:45:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:45:35 INFO - Running setup.py (path:/tmp/pip-Ue_t4n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:45:35 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:45:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:45:35 INFO - Running setup.py (path:/tmp/pip-5ahUDl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:45:35 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:45:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:45:35 INFO - Running setup.py (path:/tmp/pip-IuRcyT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:45:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:45:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:45:35 INFO - Running setup.py (path:/tmp/pip-YsBste-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:45:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:45:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:45:35 INFO - Running setup.py (path:/tmp/pip-F5axZh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:45:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:45:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:45:35 INFO - Running setup.py (path:/tmp/pip-vIhZ3e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:45: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:45:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:45:36 INFO - Running setup.py (path:/tmp/pip-LRk_gh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:45:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:45:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:45:36 INFO - Running setup.py (path:/tmp/pip-l7v8M0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:45:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:45:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:45:36 INFO - Running setup.py (path:/tmp/pip-lwda6b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:45:36 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:45:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:45:36 INFO - Running setup.py (path:/tmp/pip-ObLY4z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:45:36 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:45:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:45:36 INFO - Running setup.py (path:/tmp/pip-j_y1DJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:45:36 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:45:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:45:36 INFO - Running setup.py (path:/tmp/pip-rSUFkz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:45:36 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:45:36 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:45:36 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:45:36 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:45:36 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:45:36 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:45:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:45:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:45:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:45:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:38 INFO - Downloading blessings-1.6.tar.gz 08:45:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:45:38 INFO - Installing collected packages: blessings 08:45:38 INFO - Running setup.py install for blessings 08:45:38 INFO - Successfully installed blessings 08:45:38 INFO - Cleaning up... 08:45:38 INFO - Return code: 0 08:45:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:45:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:45:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:45:38 INFO - Reading from file tmpfile_stdout 08:45:38 INFO - Current package versions: 08:45:38 INFO - argparse == 1.2.1 08:45:38 INFO - blessings == 1.6 08:45:38 INFO - blobuploader == 1.2.4 08:45:38 INFO - docopt == 0.6.1 08:45:38 INFO - functools32 == 3.2.3-2 08:45:38 INFO - jsonschema == 2.5.1 08:45:38 INFO - manifestparser == 1.1 08:45:38 INFO - mozInstall == 1.12 08:45:38 INFO - mozcrash == 0.17 08:45:38 INFO - mozdebug == 0.1 08:45:38 INFO - mozdevice == 0.48 08:45:38 INFO - mozfile == 1.2 08:45:38 INFO - mozhttpd == 0.7 08:45:38 INFO - mozinfo == 0.9 08:45:38 INFO - mozleak == 0.1 08:45:38 INFO - mozlog == 3.2 08:45:38 INFO - moznetwork == 0.27 08:45:38 INFO - mozprocess == 0.23 08:45:38 INFO - mozprofile == 0.28 08:45:38 INFO - mozrunner == 6.12 08:45:38 INFO - mozscreenshot == 0.1 08:45:38 INFO - mozsystemmonitor == 0.3 08:45:38 INFO - moztest == 0.7 08:45:38 INFO - mozversion == 1.4 08:45:38 INFO - psutil == 3.1.1 08:45:38 INFO - requests == 1.2.3 08:45:38 INFO - wsgiref == 0.1.2 08:45:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:45:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:45:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:45:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd01030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfc2180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc03b0>, '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 0xfc12b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfc1740>, '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': 'ed14279e38b05397cf4aa391000001a4-1468251734.370168-765231984', '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:45:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:45:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:45:38 INFO - Using env: {'DISPLAY': ':0', 08:45:38 INFO - 'HOME': '/home/cltbld', 08:45:38 INFO - 'LANG': 'en_US.UTF-8', 08:45:38 INFO - 'LANGUAGE': 'en_US:en', 08:45:38 INFO - 'LOGNAME': 'cltbld', 08:45:38 INFO - 'MAIL': '/var/mail/cltbld', 08:45:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:38 INFO - 'MOZ_NO_REMOTE': '1', 08:45:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:45:38 INFO - 'NO_EM_RESTART': '1', 08:45:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:45:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:38 INFO - 'PWD': '/builds/slave/test', 08:45:38 INFO - 'SHELL': '/bin/bash', 08:45:38 INFO - 'SHLVL': '1', 08:45:38 INFO - 'TERM': 'linux', 08:45:38 INFO - 'TMOUT': '86400', 08:45:38 INFO - 'USER': 'cltbld', 08:45:38 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1468251734.370168-765231984', 08:45:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:38 INFO - '_': '/tools/buildbot/bin/python'} 08:45:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45: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:45: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:45: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:45: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:45: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:45: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:45: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:45: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:45: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:45: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:45: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:45:39 INFO - Cleaning up... 08:45:39 INFO - Return code: 0 08:45:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:45: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:45:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45: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:45:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45: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 0xd01030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfc2180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc03b0>, '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 0xfc12b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfc1740>, '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': 'ed14279e38b05397cf4aa391000001a4-1468251734.370168-765231984', '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:45: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:45: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:45:39 INFO - Using env: {'DISPLAY': ':0', 08:45:39 INFO - 'HOME': '/home/cltbld', 08:45:39 INFO - 'LANG': 'en_US.UTF-8', 08:45:39 INFO - 'LANGUAGE': 'en_US:en', 08:45:39 INFO - 'LOGNAME': 'cltbld', 08:45:39 INFO - 'MAIL': '/var/mail/cltbld', 08:45:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:39 INFO - 'MOZ_NO_REMOTE': '1', 08:45:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:45:39 INFO - 'NO_EM_RESTART': '1', 08:45:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:45:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:39 INFO - 'PWD': '/builds/slave/test', 08:45:39 INFO - 'SHELL': '/bin/bash', 08:45:39 INFO - 'SHLVL': '1', 08:45:39 INFO - 'TERM': 'linux', 08:45:39 INFO - 'TMOUT': '86400', 08:45:39 INFO - 'USER': 'cltbld', 08:45:39 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1468251734.370168-765231984', 08:45:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:39 INFO - '_': '/tools/buildbot/bin/python'} 08:45:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:39 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:45:39 INFO - Cleaning up... 08:45:39 INFO - Return code: 0 08:45:39 INFO - Running post-action listener: _resource_record_post_action 08:45:39 INFO - Running post-action listener: _start_resource_monitoring 08:45:39 INFO - Starting resource monitoring. 08:45:39 INFO - ##### 08:45:39 INFO - ##### Finished create-virtualenv step (success) 08:45:39 INFO - ##### 08:45:39 INFO - ##### 08:45:39 INFO - ##### Running install step. 08:45:39 INFO - ##### 08:45:39 INFO - Running pre-action listener: _resource_record_pre_action 08:45:39 INFO - Running main action method: install 08:45:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:45:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:45:39 INFO - Reading from file tmpfile_stdout 08:45:39 INFO - Detecting whether we're running mozinstall >=1.0... 08:45:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:45:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:45:39 INFO - Reading from file tmpfile_stdout 08:45:39 INFO - Output received: 08:45:39 INFO - Usage: mozinstall [options] installer 08:45:39 INFO - Options: 08:45:39 INFO - -h, --help show this help message and exit 08:45:39 INFO - -d DEST, --destination=DEST 08:45:39 INFO - Directory to install application into. [default: 08:45:39 INFO - "/builds/slave/test"] 08:45:39 INFO - --app=APP Application being installed. [default: firefox] 08:45:39 INFO - mkdir: /builds/slave/test/build/application 08:45:39 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:45:39 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:45:55 INFO - Reading from file tmpfile_stdout 08:45:55 INFO - Output received: 08:45:55 INFO - /builds/slave/test/build/application/firefox/firefox 08:45:55 INFO - Running post-action listener: _resource_record_post_action 08:45:55 INFO - ##### 08:45:55 INFO - ##### Finished install step (success) 08:45:55 INFO - ##### 08:45:55 INFO - ##### 08:45:55 INFO - ##### Running run-tests step. 08:45:55 INFO - ##### 08:45:55 INFO - Running pre-action listener: _resource_record_pre_action 08:45:55 INFO - Running main action method: run_tests 08:45:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:45:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:45:55 INFO - Python 2.7.3 08:45:55 INFO - Return code: 0 08:45:55 INFO - grabbing minidump binary from tooltool 08:45:55 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:45:55 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 0xfc03b0>, '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 0xfc12b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfc1740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:45:55 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:45:55 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:45:55 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:45:56 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:45:56 INFO - Return code: 0 08:45:56 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:45:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:45:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:45:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:45:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:45:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dF1r_xBQS6GuOywinxjs7Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--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:45:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dF1r_xBQS6GuOywinxjs7Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-035 --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:45:56 INFO - Using env: {'DISPLAY': ':0', 08:45:56 INFO - 'HOME': '/home/cltbld', 08:45:56 INFO - 'LANG': 'en_US.UTF-8', 08:45:56 INFO - 'LANGUAGE': 'en_US:en', 08:45:56 INFO - 'LOGNAME': 'cltbld', 08:45:56 INFO - 'MAIL': '/var/mail/cltbld', 08:45:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:45:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:45:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:56 INFO - 'MOZ_NO_REMOTE': '1', 08:45:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:45:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:45:56 INFO - 'NO_EM_RESTART': '1', 08:45:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:45:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:56 INFO - 'PWD': '/builds/slave/test', 08:45:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:45:56 INFO - 'SHELL': '/bin/bash', 08:45:56 INFO - 'SHLVL': '1', 08:45:56 INFO - 'TERM': 'linux', 08:45:56 INFO - 'TMOUT': '86400', 08:45:56 INFO - 'USER': 'cltbld', 08:45:56 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1468251734.370168-765231984', 08:45:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:56 INFO - '_': '/tools/buildbot/bin/python'} 08:45:56 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dF1r_xBQS6GuOywinxjs7Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--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:45:56 INFO - mozversion application_buildid: 20160711072227 08:45:56 INFO - mozversion application_changeset: 214884d507ee369c1cf14edb26527c4f9a97bf48 08:45:56 INFO - mozversion application_display_name: Nightly 08:45:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:45:56 INFO - mozversion application_name: Firefox 08:45:56 INFO - mozversion application_remotingname: firefox 08:45:56 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:45:56 INFO - mozversion application_vendor: Mozilla 08:45:56 INFO - mozversion application_version: 50.0a1 08:45:56 INFO - mozversion platform_buildid: 20160711072227 08:45:56 INFO - mozversion platform_changeset: 214884d507ee369c1cf14edb26527c4f9a97bf48 08:45:56 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:45:56 INFO - mozversion platform_version: 50.0a1 08:45:56 INFO - using testdate: 1468251956 08:45:56 INFO - actual date: 1468251956 08:45:56 INFO - starting webserver on 'localhost:43740' 08:45:56 INFO - SUITE-START | Running 2 tests 08:45:56 INFO - TEST-START | dromaeo_css 08:45:56 INFO - operating with platform_type : linux_ 08:45:56 INFO - Initialising browser for dromaeo_css test... 08:45:56 INFO - TEST-INFO | started process 4539 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYavA36/profile http://localhost:43740/getInfo.html) 08:46:00 INFO - PROCESS | 4539 | __metrics Screen width/height:1600/1200 08:46:00 INFO - PROCESS | 4539 | colorDepth:24 08:46:00 INFO - PROCESS | 4539 | Browser inner width/height: 1024/697 08:46:00 INFO - PROCESS | 4539 | __metrics 08:46:01 INFO - PROCESS | 4539 | 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:46:01 INFO - PROCESS | 4539 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:46:02 INFO - TEST-INFO | 4539: exit 0 08:46:02 INFO - Browser initialized. 08:46:02 INFO - Running cycle 1/1 for dromaeo_css test... 08:46:02 INFO - TEST-INFO | started process 4620 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYavA36/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:46:14 INFO - PROCESS | 4620 | RSS: Main: 158945280 08:46:14 INFO - PROCESS | 4620 | 08:47:05 INFO - PROCESS | 4620 | 1468252025097 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:49:17 INFO - PROCESS | 4620 | Cycle 1(1): loaded http://localhost:43740/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43740/tests/dromaeo/cssquery-ext.html) 08:49:18 INFO - PROCESS | 4620 | RSS: Main: 238637056 08:49:18 INFO - PROCESS | 4620 | 08:52:21 INFO - PROCESS | 4620 | Cycle 1(1): loaded http://localhost:43740/tests/dromaeo/cssquery-ext.html (next: http://localhost:43740/tests/dromaeo/cssquery-jquery.html) 08:52:22 INFO - PROCESS | 4620 | RSS: Main: 243675136 08:52:22 INFO - PROCESS | 4620 | 08:55:24 INFO - PROCESS | 4620 | Cycle 1(1): loaded http://localhost:43740/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43740/tests/dromaeo/cssquery-mootools.html) 08:55:24 INFO - PROCESS | 4620 | RSS: Main: 243707904 08:55:24 INFO - PROCESS | 4620 | 08:58:27 INFO - PROCESS | 4620 | Cycle 1(1): loaded http://localhost:43740/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43740/tests/dromaeo/cssquery-prototype.html) 08:58:27 INFO - PROCESS | 4620 | RSS: Main: 243458048 08:58:27 INFO - PROCESS | 4620 | 09:01:30 INFO - PROCESS | 4620 | Cycle 1(1): loaded http://localhost:43740/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43740/tests/dromaeo/cssquery-yui.html) 09:01:31 INFO - PROCESS | 4620 | RSS: Main: 221216768 09:01:31 INFO - PROCESS | 4620 | 09:04:34 INFO - PROCESS | 4620 | Cycle 1(1): loaded http://localhost:43740/tests/dromaeo/cssquery-yui.html (next: http://localhost:43740/tests/dromaeo/cssquery-dojo.html) 09:04:34 INFO - PROCESS | 4620 | RSS: Main: 279855104 09:04:34 INFO - PROCESS | 4620 | 09:04:34 INFO - PROCESS | 4620 | __start_tp_report 09:04:34 INFO - PROCESS | 4620 | _x_x_mozilla_page_load 09:04:34 INFO - PROCESS | 4620 | _x_x_mozilla_page_load_details 09:04:34 INFO - PROCESS | 4620 | |i|pagename|runs| 09:04:34 INFO - PROCESS | 4620 | |0;dojo.html;2594.494073655637;2606.648102506161;2635.56513175326;2644.8280861743983;2651.178134778219;4641.605463535595;4698.801805539591;4762.357081793957;4771.546703063208;4787.784549695263;4697.4597921239065;4701.764911754407;4820.710757354561;4864.318995340655;4874.073925954066;4303.160883627694;4319.395284660158;4347.369631403445;4380.540043295456;4482.618977386926;4379.627731642814;4414.271645178542;4430.534793846648;4439.2675208590545;4468.994476242852;4095.1195492969155;4244.448221731186;4287.292596721569;4293.935590966138;4326.610605045561;4355.107203023373;4356.6514678825615;4398.054418300081;4402.339649052636;4405.7797110144365;4343.847965321199;4374.365716971021;4383.232934236496;4384.101259241879;4407.735535867826;4579.267317229227;4696.976515117437;4785.377900872864;4798.64010199233;4799.400074990626;5054.772535235923;5110.054639891632;5125.923111153335;5126.231065340192;5130.025295193901;4915.508449155056;5116.411612664554;5151.253068305112;5153.845384638467;5159.303494028333;4709.599684026827;4758.595519380822;4764.14245435818;4767.261074533453;4818.566329030404;5287.444818294024;5296.973515132399;5316.468353164652;5317.9202311965355;5322.4411436799355;4895.265710143436;4938.975305123451;5013.323201367842;5046.394432668103;5049.267856160836;5051.292819005343;5102.260172275073;5102.464241254689;5110.412302585176;5113;5049.596032317406;5058.038972595195;5061.5950723942;5066.695998240118;5111.156659151198;4855.878603034952;4982.551570358685;5044.798208071709;5052.216906379517;5056.974715126401;4317.503487098961;4397.582229688174;4398.296272596369;4436.3123715824095;4441.267190913528;3789.5452545694693;3796.6203379662365;3811.1424929390664;3830.9233815324096;3843.7501562398916;3815.465834783133;3870.748401353903;3957.109650328653;3962.0689138052535;3971.940420893689;4880.072786170616;4893.584045356113;4899.706017638881;4901.36282283308;4958.231474121517;3896.8441262349756;3904.39481880309;3909.237698648736;3918.4710064141545;3944.033711740642;4356.324769660708;4365.9126817463475;4394.648428125743;4399.010222699931;4446.9555304447185;4704.976475117603;4706.717596944194;4711.952880471152;4750.334953106637;4750.406199225097;4838.153323168502;4893.681910675795;4894.706317620954;4899.461059283547;4944;4658.743769092733;4711.528847115261;4716.457607375196;4755.524447555217;4761.071591039714;5017.448080711192;5029.874253143555;5035.0685123252315;5038;5092.592592592509;5028;5038.622103342337;5039.672421292605;5041.7227052511;5091.287219789158;4795.496472870438;4847.151748444078;4903.583195428429;4907.043126590281;4917.065757506062;4862.41651001882;4889.437714662859;4903.583195428429;4908.509149085063;4951.306817045544;4677.625789936729;4748.833790817304;4763.642726795573;4816.20532612115;4817.855464336076;4844.394450693663;4882.316475693335;4888.584470320063;4914.975425122851;4966.056449274626;4783.1390349737385;4787.904241915073;4800.951990480051;4801.759912004456;4852.587530059844 09:04:34 INFO - PROCESS | 4620 | |1;ext.html;569.2400645138737;579.4408395897959;586.7623612436964;588.3263663105743;591.2432086928733;26976.59535106975;29747.40505189895;29755.256118597074;43302.783486082604;44998.32502512465;41269.380959285634;41498.377524337084;41739.58260417395;41753.373699394535;41768;7888.447808653382;8030.919690803075;8035;8037.5177489350535;8082.1917808219005;7961.164077771838;8071.23323284287;8071.838563228732;8072.71745488908;8075.636596353178;8083.312918401943;8126.024877014766;8127.512349259034;8128.30909372704;8135.796605084861;8038.437309388345;8065.354771618257;8066.516009039447;8068.515889046676;8070.757877263692;7973.043234811859;8014;8033.879491807569;8039.07550631679;8039.758807235792;39510;39569.40645890314;39809;39859.20281594352;39991;3016.3967206558777;3112.035269066597;3112.1597168764306;3134.153778479798;3419;29415;29705.70294297051;29814.254643633867;30426.087217383512;31433.214169645715;3155.3410149497618;3193.1059303395086;3202.2154572129743;3214.453542897713;3277.475603903364;275770.999999998;276784;276818;277667;278702;53195.73402132965;53603;53621.73189134029;53685.73157134267;53758.19362709563;33440.83279583635;34536.48195277073;34582.654173458446;36305.818470908;36336.45495317572;14186.432542698176;14318.069325493809;14332.426702931974;14339.139651620728;14358.712825743636;10598.31110977784;10659.626913058006;10672.146228301717;10679.359238445562;10682.092022178202;18389.448316550526;18402;18424.539386515444;18555.536111597317;18582.628347432976;6508.707108180143;6715.731370745116;6723;6739.393454589111;6934.375906168469;719.9668475737334;782.2529484342439;786.3709032773758;822.3955392786297;832.1595188859295;26960.325991849968;28104.43791124166;28686.569701454497;28734;28825.85587072093;916.3768637326682;942.0673533202081;992.4343124419012;1017.5827910556784;1025.466757286207;14348.856511434751;14734.26328683583;15073.397064117313;15100.169490678118;15499.457518987007;390400;391499;395333;396133;397886;49327.50672493229;49643.50356496389;49699;49719.25421118686;50113;1072.9248952573246;1140.270227054669;1204.8915597596258;1207.8127890177036;1208.2689972566823;28480.572791407732;29146.854265728536;29307.267318317212;29641;29827.552586711652;42119;42466.78766606147;42644;42720.35919461273;42740.57259427366;293195;296697;296776;297072;298017;22220.66668999934;24549.754502454747;24944.75055249497;25598.744012559637;25700.228993130237;41208.38187427131;41546.376804347354;41672.58327416687;42474.36288455614;42632.360514592925;36148.27703445864;36241;36270.4559431614;36689;36932.261354772214;35037.124071898405;35797;35805.283894322485;35940.64059359373;38088;34882.30235395329;34997.12507187239;36790.8160459196;36985.075373115884;37351.25297493981;31766.523502147025;33203.50194747032;33273.16817079592;33405.16487087842;33446;24889.751102489467;25455;25495.745042549337;25878.353041173366;25918.870405647853 09:04:34 INFO - PROCESS | 4620 | |2;jquery.html;342.94745945516064;361.6239111324223;366.59308167933597;368.73635350724237;373.99582122002425;13310.800337994939;16722.41471548496;17059.573510662223;17883.28466861324;18808.34170804022;18058.909705451453;18174.818251817476;18326.175322110503;18419.447416577492;18490.907545462287;4503.662225333105;4786.952130478703;4788.832390866321;4845.612351011928;4851.272309153637;3509.4209455439823;4706.22347312693;5249.816256431026;5522.475364840334;5545.140503221987;5499.285092937913;5538.086215774392;5560.77756889724;5568.081266591008;5570.805021824237;5465.863353416156;5991.221141251609;6025.246844144482;6027.186329845458;6030.758769649209;3388.3562123196516;4991.3511243538105;5300.390455097675;5305.177697456862;5340.385855626575;12748.61754147377;12763.744725105538;12892.290923999177;13014.934925325313;13197.736045279136;1855.0910054073543;1885.1139964216795;1939.0983192815409;1944.922203111888;1979;9820.607175712963;10211.438370889598;10939.960703733212;10979;13948.581542553638;1738.5045262100368;1756.5432987423362;1773.8314860088271;1774.9911250443795;1780.2522940365077;70604.94092588616;72929.27070729277;73507.63246183789;73885.26114738837;73984.6300768498;8694.608742606599;9322.440653560672;9685.37045092081;9738.853917191247;9951.575058659195;11979.640610781691;12673.556425525063;12696.111272211041;12914.741705165845;12941.54704585335;7025;7053.400460960773;7255.52839065459;7289.307515785992;7304.123505179306;6701.430378417792;6704.865902681919;6800.081988931431;6817.727290908408;6823.55646882951;4166.749995000309;4171.395147703627;4195.160967806451;4294.9785251073545;4451.888702782457;1786.20513871326;1823.2798044772242;1832.7250912363252;1834.4496651004913;1869.3550724999852;863.7495126413395;868.7567481105301;912.2291663544295;990.4107056301489;995.4326034160459;16779.83220167807;17177;17491;17988.820111798977;18383.632327353647;856.7986523167051;871.6992637540038;876.1326286975848;903.796645754713;912.370464379576;6872.450203983669;10127.265638277771;10181.389116652876;10191;10292.742681433025;386203;386661;387701;388131;388899;78841.60579197182;81002.59498702468;82384;82748;82922.58538707267;781.6287263549882;788.8264581791997;802.9959850200712;812.2811311988814;813.1665043330515;15353.539393818204;15726.370945162065;15862.68274634524;16177.919110404373;16357.67284654324;38571.300008999104;38596.6140338593;39378.60621393749;39546;39698.60301397065;46699.53300467088;54539;54556;54585.1812222809;55225.72387138039;7189.856202876018;7442.244306459425;7452.329290363677;7473.9177359396135;7608.885866712115;10301.845472318071;11114.666560003212;11352.489137988645;11588.536458541901;11614.012808911337;5976.462118409364;7996.960015199887;9846.753831154278;10042.69871903844;10181.847272290774;9387.249020078514;9689.22486201088;9758.316917815684;9789.608415663293;9825.231458337568;9710.465924374228;10068.597256109673;10075.244356673426;10097.141742951932;10145.79708405813;7360.889586656312;7433.591152486449;7451.962740186264;7614.466987310835;7641.847163056819;7527.3601743850195;8890.64437422496;9724.124828765445;9733.464659443798;9848.507574621384 09:04:34 INFO - PROCESS | 4620 | |3;mootools.html;1226.4358395138236;1375.7111006688592;1409.3446547355477;1480.6890552983873;1674.4055860169647;6368.586041907272;7155.463340249483;7377.225391333913;7394.186639469654;7557.05536807899;7269.273072692728;7389.150247721514;7391.223921488247;7394.038774959261;7420.183779784219;1879.9906000469978;2089.6552068908686;2124.4901223706274;2145.7210562626838;2186.365953873375;2248.05581655705;2259.017327462551;2269.909203631853;2273.4089136824464;2274.3404412720374;2145.034734369532;2145.7210562626838;2228.721409823772;2233.2741858895924;2237.0827960536185;1850.6021205440761;1912.3498010676299;1920.817522335376;2052.415061707421;2148.924787632433;2153.332466935255;2188.1356864038776;2192.397090800027;2194.473326401668;2194.8792816395253;7522.924770752277;7566.697332106709;7577.280158385;7580.241975802431;7583.127940286882;4442.600165985044;4571.22289210835;4575.22221222393;4579.610733087658;4581.5647513486165;2774.7780177585946;2833.4616422879585;2834.2489240351324;2836.106626412694;2847.658281006272;862.7498025572577;876.5441970175473;892.7678803511069;916.0564618443015;918.7289749523907;10082.143017843493;10087.69736907894;10108.696739097766;10143.39139651616;10147.949260253652;4019.21625283067;4088.979555102265;4225.619694227535;4251.277282861921;4257.595528424795;8555.529445880537;8561.0582835888;8564.3148548116;8567;8579.571021449028;4511.187986162457;4532.4334458192725;4539.750313732777;4541.205289074399;4555.043440877386;3592.0660628236847;3999.7800120993625;4125.855595054219;4135.7518548887165;4175.68682348825;3415.0949998250485;3455.3953058215216;3502.4571191465366;3518.5074089627474;3538.6461353864406;999.1457304005116;1111.972200694973;1158.223989926751;1179.9469023893773;1182.5742732616252;735.764555342296;746.4476287547176;780.5004796929969;815.3640160674684;818.5048045932125;4712.434507859079;4742.1227072991605;4849.224124140192;4961.42943561495;4987.376577927759;840.0717207485762;840.82342708032;844.4342290665269;849.3417601358997;852.1606217875387;3181.236503239206;3326.4012477753754;3330.400527904952;3335.0661814691925;3374.848131834024;8649.61076751535;8943.821123577622;9046.095390461032;9068.138526839939;9092.499912504743;8981.14679105484;8998.68504602349;8999.19007289347;9002.009778924314;9014.459132451942;6796.320367963164;6855.4172895304455;6866.862662746817;6873.450123990069;6878.8624227516175;4848.903021939612;4888.755562221946;5018.473060328759;5094.108531007133;5113.565346945403;8307.750767476986;8328.791780205544;8332.375071869756;8378.706745263886;8549.102344254012;8584.227419532272;8600.354973376896;8700;8738.825223495622;8760.21158095749;6177.6911154443;6376.968115159394;6402.327755585597;6442.065900444503;6456.451201647913;6930.584164950119;7143.607101609254;7149.249328820607;7157.24848890859;7162.247963963917;6235.064740288812;6275.152854364785;6306.337834527309;6561.015847622894;6629.801105966829;6093.725782339717;6107.450329470369;6134.202553667995;6137.355577664281;6275.6862156892885;5771.971140144273;5784.479396854304;5801.274840644919;5810.331811841692;5816.883662326814;4173.144505376451;4285.164392943346;4341.348797680247;4345.826166953287;4404.427424434803;4217.367394890791;4407.49313828901;4415.867523974286;4497.257952437942;4527.253003254558 09:04:34 INFO - PROCESS | 4620 | |4;prototype.html;290.44524957331487;297.8763813017598;302.695790730316;307.9615048118985;311.41298652040894;4596.218642830719;4768.1894078006735;4798.136335459616;4814.229723244282;4832.540908613681;4583.335416364634;4722.433308003045;4727.149113159629;4732.2428411454175;4741.265103908891;3795.867144649938;3797.164623782777;3799.8290076946464;3803.6576708096336;3809.104860357814;3637.5271214742047;3665.999999999987;3805.752626079296;3806.0675134591925;3806.686693090879;3775.093977445407;3776.564905335982;3783.5270591176104;3783.81080945953;3786.5266841644793;3768.6231376862092;3773.471713960048;3779.7732136071786;3781.149241420686;3781.243751249761;3361.6974472297366;3368.6799754023327;3370.6292307846115;3373.190434295776;3403.9319213615836;4567.725936443824;4643.582077613031;4655.4878963314;4682.27424749161;4693.741844198567;4274.893127671802;4289.806958686867;4296.228932338624;4301.720388174758;4330.718503297276;4818.927716084261;4944.431390390115;4958.281049247839;4986.326845875797;5024.422191447994;3578.3022310649435;3581.230035542371;3583.605803361628;3592.5868525119686;3602.279544091166;5224.059669259532;5277.261183434322;5288.762005709791;5296.364436267672;5311.73441327936;3701.9074523136596;3706.369917114097;3712.368897287414;3718.9070273243387;3726.5155529780955;3536.5932917714276;3713.9257214856093;3718.888433347004;3733.3466643337306;3750.081230098643;4215.882791060371;4226.725262857966;4227.32362821947;4240.745555266694;4256.233877902007;4936.136176169156;4978.751062446863;4996.300517927493;5000.299958005882;5008.824691135793;1159.6694941941507;1206.6862615719976;1217.21489639184;1247.5695884919687;1248.925064496115;777.366446346226;837.9078301386843;838.8154605986673;842.1704620948361;847.6990668312784;3708.2212735325884;3725.3480640887738;3730.8880733577494;3754.5682246541996;3755.1926335837925;4465.37484752135;4474.530174331713;4488.685791994529;4515.2549829277805;4560.931586026212;3599.280143971216;3648.7810731356203;3675.6000699353526;3690.612485689018;3800.7149463790324;2621.4101827088753;2634.617980392871;2647.483740670589;2654.7876169906363;2656.8671566421604;4794.856154315376;4801.231802911588;4811.422629284508;4812.807487700523;4824.276358546246;5074.831418271341;5243.868903277448;5259.579233661298;5265.104932161542;5279.234510995884;4786.425628924481;4789.61683065347;4789.976050119727;4803.183458811941;4808.182608956416;4954.479779623088;4955.578775804097;4959.925601115914;4962.702237865739;4973.179425394914;4782.521747825329;4970.589264206785;5009.198528235464;5010.123228435083;5021.8449756555465;4736.905261894812;4750.5249475052215;4784.210605250234;4798.328234047166;4813.590844778233;3455.9654403455643;3647.562292524914;3661.992951938238;3698.3342998259495;3700.093477098128;4831.855044348676;4906.8773280668265;4910.140725372974;4935.136351138608;4946.3817022872145;4365.081302202131;4908.4355299139625;4921.360223170965;4924.818043669422;4931.284963680175;4861.878453038702;4881.609471242221;4897.9020419592125;4932.408111026556;4932.580730637936;4663.930041049455;4767.856964291077;4788.4621150790135;4807.399075115611;4822.035592881368;4871.853844384674;4879.243717223836;4881;4894.853154405374;4896.583790377716;4767;4796.160671882337;4832.864276894857;4844.903101938012;4862.4651288357545 09:04:34 INFO - PROCESS | 4620 | |5;yui.html;669.9899501507476;716.8991142731247;736.403513154345;750.0474397515156;786.1941509952302;11153.219274650777;11615.593454229103;12011.879881201185;12203.450844711988;12223.572174973877;11973.401329933513;12004.459799309052;12117.33354665493;12145.757084858298;12150.33173175475;630.7098734582098;774.2257742257742;775.2480094308512;792.374024520628;797.7407342613644;793.3613441179848;802.7230605441114;803.1727320859495;804.0150815251329;804.90341159061;842.4818736477084;845.1886189258289;847.2120927537388;847.6016272351985;847.9491230526188;652.1522021372197;797.174923953711;826.5371392020488;839.4375768235267;841.3689732700444;607.583805093508;607.8601921558022;607.9939200607981;608.1455554945309;608.3581821178655;12127.454264558117;12136.939315303456;12156.696082597917;12165.391730413445;12180.939095304468;12394.56619018339;12895.67760805978;13043.934780326132;13091.607251782461;13241.602751917459;11751.353675547842;11854.170208085437;11945.223560468628;12043.759124817454;12385.938070309681;4240.893977650552;4294.162638285536;4313.892152696177;4322.589354011364;4396.3625274335045;52798.47201527974;54852.72573637146;55132;58417;62483.687581562255;10728.892711072946;11192;11339;11378.487968041458;11714.1800073994;20381.79618203799;20401.285954991505;20407.285744998855;20423.897880510503;20427.693584596243;7085.751998680022;7123.287671232835;7185.640717964186;7190.029346038323;7418.629068546551;3593.4789455528803;3682.834272457746;3739.9439008414897;3742.1580144467275;3831.4827498287373;2735.3845384788265;2810.4660114578164;2815.2680303121338;2816.4367126574766;2821.3369858083333;478.7103802199689;488.0750976898757;488.4236600811006;495.22250067393844;532.2229544864464;626.7936862244964;630.9274433440121;646.7348387161242;646.9385408386196;648.3969907985619;8736.8689469658;8767.561621918878;8822.51476168817;8840.204381605687;8913.910860891438;533.9145736682112;554.2822045451151;637.9617222966637;641.6214433484266;657.086649557116;3899.7855117968215;3899.863504777319;4019.698522610816;4052.675785937118;4089.325261331847;66900;70237.64881175561;70373.64813176004;107160.46419768008;110451;46458.76770616193;59492.75326090785;72017;72214.27785722181;73204.63397683084;44795.776021120335;68511.3148868505;69271;69923;71148;8740.421099620715;8832.91167088321;8909.55452227399;8935.553222338727;8983.550822458721;30715.539266911463;34383;44591;44965.550344496136;45056;61936.38063619306;62257.688711556155;62390.376096238455;63131.684341577995;64222;9464.337496375188;9518.381305215138;9682.27382946296;10908.890911090788;11117.27737697047;10858.45707714627;11289.491972861077;12893.677658058248;13184.538541151014;13471.12437691547;12006.63980080599;12453.813192802296;12543.804834153803;12569.622911312676;13190.208587484782;11133.165012623924;11153.665390038312;11838.408079596158;12013.579524716593;12268.631941041784;12126.878731212575;12499.312537810507;12660;12692.428840702007;13304.86695133075;9717.27120465982;9990.650327238513;10115.443650599287;10327;10544.420056896945;10295.742606434898;10319.329243599143;10345;10346.844797328196;10789.514471848628 09:04:34 INFO - PROCESS | 4620 | __end_tp_report 09:04:34 INFO - PROCESS | 4620 | __start_cc_report 09:04:34 INFO - PROCESS | 4620 | _x_x_mozilla_cycle_collect,1068 09:04:34 INFO - PROCESS | 4620 | __end_cc_report 09:04:34 INFO - PROCESS | 4620 | __startTimestamp1468253074642__endTimestamp 09:04:34 INFO - PROCESS | 4620 | 09:04:34 INFO - PROCESS | 4620 | ------- Summary: start ------- 09:04:34 INFO - PROCESS | 4620 | Number of tests: 6 09:04:34 INFO - PROCESS | 4620 | 09:04:34 INFO - PROCESS | 4620 | [#0] dojo.html Cycles:165 Average:4640.57 Median:4787.78 stddev:514.17 (10.7%) stddev-sans-first:490.05 09:04:34 INFO - PROCESS | 4620 | Values: 2594.5 2606.6 2635.6 2644.8 2651.2 4641.6 4698.8 4762.4 4771.5 4787.8 4697.5 4701.8 4820.7 4864.3 4874.1 4303.2 4319.4 4347.4 4380.5 4482.6 4379.6 4414.3 4430.5 4439.3 4469.0 4095.1 4244.4 4287.3 4293.9 4326.6 4355.1 4356.7 4398.1 4402.3 4405.8 4343.8 4374.4 4383.2 4384.1 4407.7 4579.3 4697.0 4785.4 4798.6 4799.4 5054.8 5110.1 5125.9 5126.2 5130.0 4915.5 5116.4 5151.3 5153.8 5159.3 4709.6 4758.6 4764.1 4767.3 4818.6 5287.4 5297.0 5316.5 5317.9 5322.4 4895.3 4939.0 5013.3 5046.4 5049.3 5051.3 5102.3 5102.5 5110.4 5113.0 5049.6 5058.0 5061.6 5066.7 5111.2 4855.9 4982.6 5044.8 5052.2 5057.0 4317.5 4397.6 4398.3 4436.3 4441.3 3789.5 3796.6 3811.1 3830.9 3843.8 3815.5 3870.7 3957.1 3962.1 3971.9 4880.1 4893.6 4899.7 4901.4 4958.2 3896.8 3904.4 3909.2 3918.5 3944.0 4356.3 4365.9 4394.6 4399.0 4447.0 4705.0 4706.7 4712.0 4750.3 4750.4 4838.2 4893.7 4894.7 4899.5 4944.0 4658.7 4711.5 4716.5 4755.5 4761.1 5017.4 5029.9 5035.1 5038.0 5092.6 5028.0 5038.6 5039.7 5041.7 5091.3 4795.5 4847.2 4903.6 4907.0 4917.1 4862.4 4889.4 4903.6 4908.5 4951.3 4677.6 4748.8 4763.6 4816.2 4817.9 4844.4 4882.3 4888.6 4915.0 4966.1 4783.1 4787.9 4801.0 4801.8 4852.6 09:04:34 INFO - PROCESS | 4620 | 09:04:34 INFO - PROCESS | 4620 | [#1] ext.html Cycles:180 Average:47270.11 Median:36255.73 stddev:85955.96 (237.1%) stddev-sans-first:86125.57 09:04:34 INFO - PROCESS | 4620 | Values: 569.2 579.4 586.8 588.3 591.2 26976.6 29747.4 29755.3 43302.8 44998.3 41269.4 41498.4 41739.6 41753.4 41768.0 7888.4 8030.9 8035.0 8037.5 8082.2 7961.2 8071.2 8071.8 8072.7 8075.6 8083.3 8126.0 8127.5 8128.3 8135.8 8038.4 8065.4 8066.5 8068.5 8070.8 7973.0 8014.0 8033.9 8039.1 8039.8 39510.0 39569.4 39809.0 39859.2 39991.0 3016.4 3112.0 3112.2 3134.2 3419.0 29415.0 29705.7 29814.3 30426.1 31433.2 3155.3 3193.1 3202.2 3214.5 3277.5 275771.0 276784.0 276818.0 277667.0 278702.0 53195.7 53603.0 53621.7 53685.7 53758.2 33440.8 34536.5 34582.7 36305.8 36336.5 14186.4 14318.1 14332.4 14339.1 14358.7 10598.3 10659.6 10672.1 10679.4 10682.1 18389.4 18402.0 18424.5 18555.5 18582.6 6508.7 6715.7 6723.0 6739.4 6934.4 720.0 782.3 786.4 822.4 832.2 26960.3 28104.4 28686.6 28734.0 28825.9 916.4 942.1 992.4 1017.6 1025.5 14348.9 14734.3 15073.4 15100.2 15499.5 390400.0 391499.0 395333.0 396133.0 397886.0 49327.5 49643.5 49699.0 49719.3 50113.0 1072.9 1140.3 1204.9 1207.8 1208.3 28480.6 29146.9 29307.3 29641.0 29827.6 42119.0 42466.8 42644.0 42720.4 42740.6 293195.0 296697.0 296776.0 297072.0 298017.0 22220.7 24549.8 24944.8 25598.7 25700.2 41208.4 41546.4 41672.6 42474.4 42632.4 36148.3 36241.0 36270.5 36689.0 36932.3 35037.1 35797.0 35805.3 35940.6 38088.0 34882.3 34997.1 36790.8 36985.1 37351.3 31766.5 33203.5 33273.2 33405.2 33446.0 24889.8 25455.0 25495.7 25878.4 25918.9 09:04:34 INFO - PROCESS | 4620 | 09:04:34 INFO - PROCESS | 4620 | [#2] jquery.html Cycles:180 Average:24308.32 Median:4817.22 stddev:64281.57 (1334.4%) stddev-sans-first:64436.71 09:04:34 INFO - PROCESS | 4620 | Values: 342.9 361.6 366.6 368.7 374.0 13310.8 16722.4 17059.6 17883.3 18808.3 18058.9 18174.8 18326.2 18419.4 18490.9 4503.7 4787.0 4788.8 4845.6 4851.3 3509.4 4706.2 5249.8 5522.5 5545.1 5499.3 5538.1 5560.8 5568.1 5570.8 5465.9 5991.2 6025.2 6027.2 6030.8 3388.4 4991.4 5300.4 5305.2 5340.4 12748.6 12763.7 12892.3 13014.9 13197.7 1855.1 1885.1 1939.1 1944.9 1979.0 9820.6 10211.4 10940.0 10979.0 13948.6 1738.5 1756.5 1773.8 1775.0 1780.3 70604.9 72929.3 73507.6 73885.3 73984.6 8694.6 9322.4 9685.4 9738.9 9951.6 11979.6 12673.6 12696.1 12914.7 12941.5 7025.0 7053.4 7255.5 7289.3 7304.1 6701.4 6704.9 6800.1 6817.7 6823.6 4166.7 4171.4 4195.2 4295.0 4451.9 1786.2 1823.3 1832.7 1834.4 1869.4 863.7 868.8 912.2 990.4 995.4 16779.8 17177.0 17491.0 17988.8 18383.6 856.8 871.7 876.1 903.8 912.4 6872.5 10127.3 10181.4 10191.0 10292.7 386203.0 386661.0 387701.0 388131.0 388899.0 78841.6 81002.6 82384.0 82748.0 82922.6 781.6 788.8 803.0 812.3 813.2 15353.5 15726.4 15862.7 16177.9 16357.7 38571.3 38596.6 39378.6 39546.0 39698.6 46699.5 54539.0 54556.0 54585.2 55225.7 7189.9 7442.2 7452.3 7473.9 7608.9 10301.8 11114.7 11352.5 11588.5 11614.0 5976.5 7997.0 9846.8 10042.7 10181.8 9387.2 9689.2 9758.3 9789.6 9825.2 9710.5 10068.6 10075.2 10097.1 10145.8 7360.9 7433.6 7452.0 7614.5 7641.8 7527.4 8890.6 9724.1 9733.5 9848.5 09:04:34 INFO - PROCESS | 4620 | 09:04:34 INFO - PROCESS | 4620 | [#3] mootools.html Cycles:180 Average:4881.14 Median:5002.92 stddev:2691.75 (53.8%) stddev-sans-first:2685.29 09:04:34 INFO - PROCESS | 4620 | Values: 1226.4 1375.7 1409.3 1480.7 1674.4 6368.6 7155.5 7377.2 7394.2 7557.1 7269.3 7389.2 7391.2 7394.0 7420.2 1880.0 2089.7 2124.5 2145.7 2186.4 2248.1 2259.0 2269.9 2273.4 2274.3 2145.0 2145.7 2228.7 2233.3 2237.1 1850.6 1912.3 1920.8 2052.4 2148.9 2153.3 2188.1 2192.4 2194.5 2194.9 7522.9 7566.7 7577.3 7580.2 7583.1 4442.6 4571.2 4575.2 4579.6 4581.6 2774.8 2833.5 2834.2 2836.1 2847.7 862.7 876.5 892.8 916.1 918.7 10082.1 10087.7 10108.7 10143.4 10147.9 4019.2 4089.0 4225.6 4251.3 4257.6 8555.5 8561.1 8564.3 8567.0 8579.6 4511.2 4532.4 4539.8 4541.2 4555.0 3592.1 3999.8 4125.9 4135.8 4175.7 3415.1 3455.4 3502.5 3518.5 3538.6 999.1 1112.0 1158.2 1179.9 1182.6 735.8 746.4 780.5 815.4 818.5 4712.4 4742.1 4849.2 4961.4 4987.4 840.1 840.8 844.4 849.3 852.2 3181.2 3326.4 3330.4 3335.1 3374.8 8649.6 8943.8 9046.1 9068.1 9092.5 8981.1 8998.7 8999.2 9002.0 9014.5 6796.3 6855.4 6866.9 6873.5 6878.9 4848.9 4888.8 5018.5 5094.1 5113.6 8307.8 8328.8 8332.4 8378.7 8549.1 8584.2 8600.4 8700.0 8738.8 8760.2 6177.7 6377.0 6402.3 6442.1 6456.5 6930.6 7143.6 7149.2 7157.2 7162.2 6235.1 6275.2 6306.3 6561.0 6629.8 6093.7 6107.5 6134.2 6137.4 6275.7 5772.0 5784.5 5801.3 5810.3 5816.9 4173.1 4285.2 4341.3 4345.8 4404.4 4217.4 4407.5 4415.9 4497.3 4527.3 09:04:34 INFO - PROCESS | 4620 | 09:04:34 INFO - PROCESS | 4620 | [#4] prototype.html Cycles:180 Average:4069.01 Median:4659.71 stddev:1175.62 (25.2%) stddev-sans-first:1144.19 09:04:34 INFO - PROCESS | 4620 | Values: 290.4 297.9 302.7 308.0 311.4 4596.2 4768.2 4798.1 4814.2 4832.5 4583.3 4722.4 4727.1 4732.2 4741.3 3795.9 3797.2 3799.8 3803.7 3809.1 3637.5 3666.0 3805.8 3806.1 3806.7 3775.1 3776.6 3783.5 3783.8 3786.5 3768.6 3773.5 3779.8 3781.1 3781.2 3361.7 3368.7 3370.6 3373.2 3403.9 4567.7 4643.6 4655.5 4682.3 4693.7 4274.9 4289.8 4296.2 4301.7 4330.7 4818.9 4944.4 4958.3 4986.3 5024.4 3578.3 3581.2 3583.6 3592.6 3602.3 5224.1 5277.3 5288.8 5296.4 5311.7 3701.9 3706.4 3712.4 3718.9 3726.5 3536.6 3713.9 3718.9 3733.3 3750.1 4215.9 4226.7 4227.3 4240.7 4256.2 4936.1 4978.8 4996.3 5000.3 5008.8 1159.7 1206.7 1217.2 1247.6 1248.9 777.4 837.9 838.8 842.2 847.7 3708.2 3725.3 3730.9 3754.6 3755.2 4465.4 4474.5 4488.7 4515.3 4560.9 3599.3 3648.8 3675.6 3690.6 3800.7 2621.4 2634.6 2647.5 2654.8 2656.9 4794.9 4801.2 4811.4 4812.8 4824.3 5074.8 5243.9 5259.6 5265.1 5279.2 4786.4 4789.6 4790.0 4803.2 4808.2 4954.5 4955.6 4959.9 4962.7 4973.2 4782.5 4970.6 5009.2 5010.1 5021.8 4736.9 4750.5 4784.2 4798.3 4813.6 3456.0 3647.6 3662.0 3698.3 3700.1 4831.9 4906.9 4910.1 4935.1 4946.4 4365.1 4908.4 4921.4 4924.8 4931.3 4861.9 4881.6 4897.9 4932.4 4932.6 4663.9 4767.9 4788.5 4807.4 4822.0 4871.9 4879.2 4881.0 4894.9 4896.6 4767.0 4796.2 4832.9 4844.9 4862.5 09:04:34 INFO - PROCESS | 4620 | 09:04:34 INFO - PROCESS | 4620 | [#5] yui.html Cycles:180 Average:16458.40 Median:44880.66 stddev:22252.07 (49.6%) stddev-sans-first:22282.91 09:04:34 INFO - PROCESS | 4620 | Values: 670.0 716.9 736.4 750.0 786.2 11153.2 11615.6 12011.9 12203.5 12223.6 11973.4 12004.5 12117.3 12145.8 12150.3 630.7 774.2 775.2 792.4 797.7 793.4 802.7 803.2 804.0 804.9 842.5 845.2 847.2 847.6 847.9 652.2 797.2 826.5 839.4 841.4 607.6 607.9 608.0 608.1 608.4 12127.5 12136.9 12156.7 12165.4 12180.9 12394.6 12895.7 13043.9 13091.6 13241.6 11751.4 11854.2 11945.2 12043.8 12385.9 4240.9 4294.2 4313.9 4322.6 4396.4 52798.5 54852.7 55132.0 58417.0 62483.7 10728.9 11192.0 11339.0 11378.5 11714.2 20381.8 20401.3 20407.3 20423.9 20427.7 7085.8 7123.3 7185.6 7190.0 7418.6 3593.5 3682.8 3739.9 3742.2 3831.5 2735.4 2810.5 2815.3 2816.4 2821.3 478.7 488.1 488.4 495.2 532.2 626.8 630.9 646.7 646.9 648.4 8736.9 8767.6 8822.5 8840.2 8913.9 533.9 554.3 638.0 641.6 657.1 3899.8 3899.9 4019.7 4052.7 4089.3 66900.0 70237.6 70373.6 107160.5 110451.0 46458.8 59492.8 72017.0 72214.3 73204.6 44795.8 68511.3 69271.0 69923.0 71148.0 8740.4 8832.9 8909.6 8935.6 8983.6 30715.5 34383.0 44591.0 44965.6 45056.0 61936.4 62257.7 62390.4 63131.7 64222.0 9464.3 9518.4 9682.3 10908.9 11117.3 10858.5 11289.5 12893.7 13184.5 13471.1 12006.6 12453.8 12543.8 12569.6 13190.2 11133.2 11153.7 11838.4 12013.6 12268.6 12126.9 12499.3 12660.0 12692.4 13304.9 9717.3 9990.7 10115.4 10327.0 10544.4 10295.7 10319.3 10345.0 10346.8 10789.5 09:04:34 INFO - PROCESS | 4620 | -------- Summary: end -------- 09:04:34 INFO - PROCESS | 4620 | 09:04:35 INFO - TEST-INFO | 4620: exit 0 09:04:35 INFO - TEST-OK | dromaeo_css | took 1119173ms 09:04:35 INFO - TEST-START | kraken 09:04:35 INFO - operating with platform_type : linux_ 09:04:35 INFO - Initialising browser for kraken test... 09:04:35 INFO - TEST-INFO | started process 4805 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplCkzL1/profile http://localhost:43740/getInfo.html) 09:04:39 INFO - PROCESS | 4805 | __metrics Screen width/height:1600/1200 09:04:39 INFO - PROCESS | 4805 | colorDepth:24 09:04:39 INFO - PROCESS | 4805 | Browser inner width/height: 1024/697 09:04:39 INFO - PROCESS | 4805 | __metrics 09:04:40 INFO - PROCESS | 4805 | 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" 09:04:40 INFO - PROCESS | 4805 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:04:41 INFO - TEST-INFO | 4805: exit 0 09:04:41 INFO - Browser initialized. 09:04:41 INFO - Running cycle 1/1 for kraken test... 09:04:41 INFO - TEST-INFO | started process 4883 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplCkzL1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:04:53 INFO - PROCESS | 4883 | RSS: Main: 158904320 09:04:53 INFO - PROCESS | 4883 | 09:04:55 INFO - PROCESS | 4883 | Cycle 1(1): loaded http://localhost:43740/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43740/tests/kraken/driver.html?testName=audio-beat-detection) 09:04:56 INFO - PROCESS | 4883 | RSS: Main: 216969216 09:04:56 INFO - PROCESS | 4883 | 09:04:59 INFO - PROCESS | 4883 | Cycle 1(1): loaded http://localhost:43740/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43740/tests/kraken/driver.html?testName=audio-dft) 09:05:00 INFO - PROCESS | 4883 | RSS: Main: 203235328 09:05:00 INFO - PROCESS | 4883 | 09:05:03 INFO - PROCESS | 4883 | Cycle 1(1): loaded http://localhost:43740/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43740/tests/kraken/driver.html?testName=audio-fft) 09:05:04 INFO - PROCESS | 4883 | RSS: Main: 271548416 09:05:04 INFO - PROCESS | 4883 | 09:05:06 INFO - PROCESS | 4883 | Cycle 1(1): loaded http://localhost:43740/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43740/tests/kraken/driver.html?testName=audio-oscillator) 09:05:06 INFO - PROCESS | 4883 | RSS: Main: 182398976 09:05:06 INFO - PROCESS | 4883 | 09:05:09 INFO - PROCESS | 4883 | Cycle 1(1): loaded http://localhost:43740/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43740/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:05:09 INFO - PROCESS | 4883 | RSS: Main: 186179584 09:05:09 INFO - PROCESS | 4883 | 09:05:12 INFO - PROCESS | 4883 | Cycle 1(1): loaded http://localhost:43740/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43740/tests/kraken/driver.html?testName=imaging-darkroom) 09:05:13 INFO - PROCESS | 4883 | RSS: Main: 222298112 09:05:13 INFO - PROCESS | 4883 | 09:05:16 INFO - PROCESS | 4883 | Cycle 1(1): loaded http://localhost:43740/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43740/tests/kraken/driver.html?testName=imaging-desaturate) 09:05:17 INFO - PROCESS | 4883 | RSS: Main: 217899008 09:05:17 INFO - PROCESS | 4883 | 09:05:20 INFO - PROCESS | 4883 | Cycle 1(1): loaded http://localhost:43740/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43740/tests/kraken/driver.html?testName=json-parse-financial) 09:05:21 INFO - PROCESS | 4883 | RSS: Main: 220450816 09:05:21 INFO - PROCESS | 4883 | 09:05:22 INFO - PROCESS | 4883 | Cycle 1(1): loaded http://localhost:43740/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43740/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:05:23 INFO - PROCESS | 4883 | RSS: Main: 205504512 09:05:23 INFO - PROCESS | 4883 | 09:05:25 INFO - PROCESS | 4883 | Cycle 1(1): loaded http://localhost:43740/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43740/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:05:25 INFO - PROCESS | 4883 | RSS: Main: 212213760 09:05:25 INFO - PROCESS | 4883 | 09:05:27 INFO - PROCESS | 4883 | Cycle 1(1): loaded http://localhost:43740/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43740/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:05:28 INFO - PROCESS | 4883 | RSS: Main: 212365312 09:05:28 INFO - PROCESS | 4883 | 09:05:31 INFO - PROCESS | 4883 | Cycle 1(1): loaded http://localhost:43740/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43740/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:05:32 INFO - PROCESS | 4883 | RSS: Main: 225521664 09:05:32 INFO - PROCESS | 4883 | 09:05:34 INFO - PROCESS | 4883 | Cycle 1(1): loaded http://localhost:43740/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43740/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:05:35 INFO - PROCESS | 4883 | RSS: Main: 224669696 09:05:35 INFO - PROCESS | 4883 | 09:05:37 INFO - PROCESS | 4883 | Cycle 1(1): loaded http://localhost:43740/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43740/tests/kraken/driver.html?testName=ai-astar) 09:05:37 INFO - PROCESS | 4883 | RSS: Main: 267350016 09:05:37 INFO - PROCESS | 4883 | 09:05:37 INFO - PROCESS | 4883 | __start_tp_report 09:05:37 INFO - PROCESS | 4883 | _x_x_mozilla_page_load 09:05:37 INFO - PROCESS | 4883 | _x_x_mozilla_page_load_details 09:05:37 INFO - PROCESS | 4883 | |i|pagename|runs| 09:05:37 INFO - PROCESS | 4883 | |0;ai-astar;105;119;113;115;113;114;114;113;115;113 09:05:37 INFO - PROCESS | 4883 | |1;audio-beat-detection;155;122;124;177;123;131;148;124;186;126 09:05:37 INFO - PROCESS | 4883 | |2;audio-dft;161;160;161;161;162;162;165;163;162;161 09:05:37 INFO - PROCESS | 4883 | |3;audio-fft;77;85;76;125;76;75;74;74;98;76 09:05:37 INFO - PROCESS | 4883 | |4;audio-oscillator;85;84;117;85;85;86;124;85;85;131 09:05:37 INFO - PROCESS | 4883 | |5;imaging-gaussian-blur;117;116;117;118;118;117;117;117;117;117 09:05:37 INFO - PROCESS | 4883 | |6;imaging-darkroom;147;147;147;146;146;147;146;146;146;146 09:05:37 INFO - PROCESS | 4883 | |7;imaging-desaturate;95;94;95;94;95;95;95;95;95;95 09:05:37 INFO - PROCESS | 4883 | |8;json-parse-financial;65;62;63;62;63;62;64;63;64;61 09:05:37 INFO - PROCESS | 4883 | |9;json-stringify-tinderbox;65;66;66;65;65;65;65;65;67;65 09:05:37 INFO - PROCESS | 4883 | |10;stanford-crypto-aes;80;79;79;79;78;79;84;79;79;79 09:05:37 INFO - PROCESS | 4883 | |11;stanford-crypto-ccm;131;137;128;133;127;128;138;133;168;131 09:05:37 INFO - PROCESS | 4883 | |12;stanford-crypto-pbkdf2;171;167;165;176;169;167;167;168;163;166 09:05:37 INFO - PROCESS | 4883 | |13;stanford-crypto-sha256-iterative;66;66;72;68;66;67;67;66;65;69 09:05:37 INFO - PROCESS | 4883 | __end_tp_report 09:05:37 INFO - PROCESS | 4883 | __start_cc_report 09:05:37 INFO - PROCESS | 4883 | _x_x_mozilla_cycle_collect,1866 09:05:37 INFO - PROCESS | 4883 | __end_cc_report 09:05:37 INFO - PROCESS | 4883 | __startTimestamp1468253137507__endTimestamp 09:05:37 INFO - PROCESS | 4883 | 09:05:37 INFO - PROCESS | 4883 | ------- Summary: start ------- 09:05:37 INFO - PROCESS | 4883 | Number of tests: 14 09:05:37 INFO - PROCESS | 4883 | 09:05:37 INFO - PROCESS | 4883 | [#0] ai-astar Cycles:10 Average:113.40 Median:114.00 stddev:3.47 (3.0%) stddev-sans-first:1.94 09:05:37 INFO - PROCESS | 4883 | Values: 105.0 119.0 113.0 115.0 113.0 114.0 114.0 113.0 115.0 113.0 09:05:37 INFO - PROCESS | 4883 | 09:05:37 INFO - PROCESS | 4883 | [#1] audio-beat-detection Cycles:10 Average:141.60 Median:139.50 stddev:23.92 (17.1%) stddev-sans-first:24.88 09:05:37 INFO - PROCESS | 4883 | Values: 155.0 122.0 124.0 177.0 123.0 131.0 148.0 124.0 186.0 126.0 09:05:37 INFO - PROCESS | 4883 | 09:05:37 INFO - PROCESS | 4883 | [#2] audio-dft Cycles:10 Average:161.80 Median:162.00 stddev:1.40 (0.9%) stddev-sans-first:1.45 09:05:37 INFO - PROCESS | 4883 | Values: 161.0 160.0 161.0 161.0 162.0 162.0 165.0 163.0 162.0 161.0 09:05:37 INFO - PROCESS | 4883 | 09:05:37 INFO - PROCESS | 4883 | [#3] audio-fft Cycles:10 Average:83.60 Median:76.00 stddev:16.32 (21.5%) stddev-sans-first:17.14 09:05:37 INFO - PROCESS | 4883 | Values: 77.0 85.0 76.0 125.0 76.0 75.0 74.0 74.0 98.0 76.0 09:05:37 INFO - PROCESS | 4883 | 09:05:37 INFO - PROCESS | 4883 | [#4] audio-oscillator Cycles:10 Average:96.70 Median:85.00 stddev:19.13 (22.5%) stddev-sans-first:19.82 09:05:37 INFO - PROCESS | 4883 | Values: 85.0 84.0 117.0 85.0 85.0 86.0 124.0 85.0 85.0 131.0 09:05:37 INFO - PROCESS | 4883 | 09:05:37 INFO - PROCESS | 4883 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 09:05:37 INFO - PROCESS | 4883 | Values: 117.0 116.0 117.0 118.0 118.0 117.0 117.0 117.0 117.0 117.0 09:05:37 INFO - PROCESS | 4883 | 09:05:37 INFO - PROCESS | 4883 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 09:05:37 INFO - PROCESS | 4883 | Values: 147.0 147.0 147.0 146.0 146.0 147.0 146.0 146.0 146.0 146.0 09:05:37 INFO - PROCESS | 4883 | 09:05:37 INFO - PROCESS | 4883 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 09:05:37 INFO - PROCESS | 4883 | Values: 95.0 94.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 09:05:37 INFO - PROCESS | 4883 | 09:05:37 INFO - PROCESS | 4883 | [#8] json-parse-financial Cycles:10 Average:62.90 Median:63.00 stddev:1.20 (1.9%) stddev-sans-first:1.00 09:05:37 INFO - PROCESS | 4883 | Values: 65.0 62.0 63.0 62.0 63.0 62.0 64.0 63.0 64.0 61.0 09:05:37 INFO - PROCESS | 4883 | 09:05:37 INFO - PROCESS | 4883 | [#9] json-stringify-tinderbox Cycles:10 Average:65.40 Median:65.00 stddev:0.70 (1.1%) stddev-sans-first:0.73 09:05:37 INFO - PROCESS | 4883 | Values: 65.0 66.0 66.0 65.0 65.0 65.0 65.0 65.0 67.0 65.0 09:05:37 INFO - PROCESS | 4883 | 09:05:37 INFO - PROCESS | 4883 | [#10] stanford-crypto-aes Cycles:10 Average:79.50 Median:79.00 stddev:1.65 (2.1%) stddev-sans-first:1.74 09:05:37 INFO - PROCESS | 4883 | Values: 80.0 79.0 79.0 79.0 78.0 79.0 84.0 79.0 79.0 79.0 09:05:37 INFO - PROCESS | 4883 | 09:05:37 INFO - PROCESS | 4883 | [#11] stanford-crypto-ccm Cycles:10 Average:135.40 Median:133.00 stddev:12.03 (9.0%) stddev-sans-first:12.65 09:05:37 INFO - PROCESS | 4883 | Values: 131.0 137.0 128.0 133.0 127.0 128.0 138.0 133.0 168.0 131.0 09:05:37 INFO - PROCESS | 4883 | 09:05:37 INFO - PROCESS | 4883 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.90 Median:167.50 stddev:3.57 (2.1%) stddev-sans-first:3.61 09:05:37 INFO - PROCESS | 4883 | Values: 171.0 167.0 165.0 176.0 169.0 167.0 167.0 168.0 163.0 166.0 09:05:37 INFO - PROCESS | 4883 | 09:05:37 INFO - PROCESS | 4883 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:67.00 stddev:2.04 (3.1%) stddev-sans-first:2.12 09:05:37 INFO - PROCESS | 4883 | Values: 66.0 66.0 72.0 68.0 66.0 67.0 67.0 66.0 65.0 69.0 09:05:37 INFO - PROCESS | 4883 | -------- Summary: end -------- 09:05:37 INFO - PROCESS | 4883 | 09:05:38 INFO - TEST-INFO | 4883: exit 0 09:05:38 INFO - TEST-OK | kraken | took 63187ms 09:05:38 INFO - SUITE-END | took 1182s 09:05:38 INFO - Completed test suite (00:19:42) 09:05:38 INFO - javascript benchmark 09:05:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2594.494073655637, 2606.648102506161, 2635.56513175326, 2644.8280861743983, 2651.178134778219, 4641.605463535595, 4698.801805539591, 4762.357081793957, 4771.546703063208, 4787.784549695263, 4697.4597921239065, 4701.764911754407, 4820.710757354561, 4864.318995340655, 4874.073925954066, 4303.160883627694, 4319.395284660158, 4347.369631403445, 4380.540043295456, 4482.618977386926, 4379.627731642814, 4414.271645178542, 4430.534793846648, 4439.2675208590545, 4468.994476242852, 4095.1195492969155, 4244.448221731186, 4287.292596721569, 4293.935590966138, 4326.610605045561, 4355.107203023373, 4356.6514678825615, 4398.054418300081, 4402.339649052636, 4405.7797110144365, 4343.847965321199, 4374.365716971021, 4383.232934236496, 4384.101259241879, 4407.735535867826, 4579.267317229227, 4696.976515117437, 4785.377900872864, 4798.64010199233, 4799.400074990626, 5054.772535235923, 5110.054639891632, 5125.923111153335, 5126.231065340192, 5130.025295193901, 4915.508449155056, 5116.411612664554, 5151.253068305112, 5153.845384638467, 5159.303494028333, 4709.599684026827, 4758.595519380822, 4764.14245435818, 4767.261074533453, 4818.566329030404, 5287.444818294024, 5296.973515132399, 5316.468353164652, 5317.9202311965355, 5322.4411436799355, 4895.265710143436, 4938.975305123451, 5013.323201367842, 5046.394432668103, 5049.267856160836, 5051.292819005343, 5102.260172275073, 5102.464241254689, 5110.412302585176, 5113.0, 5049.596032317406, 5058.038972595195, 5061.5950723942, 5066.695998240118, 5111.156659151198, 4855.878603034952, 4982.551570358685, 5044.798208071709, 5052.216906379517, 5056.974715126401, 4317.503487098961, 4397.582229688174, 4398.296272596369, 4436.3123715824095, 4441.267190913528, 3789.5452545694693, 3796.6203379662365, 3811.1424929390664, 3830.9233815324096, 3843.7501562398916, 3815.465834783133, 3870.748401353903, 3957.109650328653, 3962.0689138052535, 3971.940420893689, 4880.072786170616, 4893.584045356113, 4899.706017638881, 4901.36282283308, 4958.231474121517, 3896.8441262349756, 3904.39481880309, 3909.237698648736, 3918.4710064141545, 3944.033711740642, 4356.324769660708, 4365.9126817463475, 4394.648428125743, 4399.010222699931, 4446.9555304447185, 4704.976475117603, 4706.717596944194, 4711.952880471152, 4750.334953106637, 4750.406199225097, 4838.153323168502, 4893.681910675795, 4894.706317620954, 4899.461059283547, 4944.0, 4658.743769092733, 4711.528847115261, 4716.457607375196, 4755.524447555217, 4761.071591039714, 5017.448080711192, 5029.874253143555, 5035.0685123252315, 5038.0, 5092.592592592509, 5028.0, 5038.622103342337, 5039.672421292605, 5041.7227052511, 5091.287219789158, 4795.496472870438, 4847.151748444078, 4903.583195428429, 4907.043126590281, 4917.065757506062, 4862.41651001882, 4889.437714662859, 4903.583195428429, 4908.509149085063, 4951.306817045544, 4677.625789936729, 4748.833790817304, 4763.642726795573, 4816.20532612115, 4817.855464336076, 4844.394450693663, 4882.316475693335, 4888.584470320063, 4914.975425122851, 4966.056449274626, 4783.1390349737385, 4787.904241915073, 4800.951990480051, 4801.759912004456, 4852.587530059844], "value": 4606.500149486495, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [569.2400645138737, 579.4408395897959, 586.7623612436964, 588.3263663105743, 591.2432086928733, 26976.59535106975, 29747.40505189895, 29755.256118597074, 43302.783486082604, 44998.32502512465, 41269.380959285634, 41498.377524337084, 41739.58260417395, 41753.373699394535, 41768.0, 7888.447808653382, 8030.919690803075, 8035.0, 8037.5177489350535, 8082.1917808219005, 7961.164077771838, 8071.23323284287, 8071.838563228732, 8072.71745488908, 8075.636596353178, 8083.312918401943, 8126.024877014766, 8127.512349259034, 8128.30909372704, 8135.796605084861, 8038.437309388345, 8065.354771618257, 8066.516009039447, 8068.515889046676, 8070.757877263692, 7973.043234811859, 8014.0, 8033.879491807569, 8039.07550631679, 8039.758807235792, 39510.0, 39569.40645890314, 39809.0, 39859.20281594352, 39991.0, 3016.3967206558777, 3112.035269066597, 3112.1597168764306, 3134.153778479798, 3419.0, 29415.0, 29705.70294297051, 29814.254643633867, 30426.087217383512, 31433.214169645715, 3155.3410149497618, 3193.1059303395086, 3202.2154572129743, 3214.453542897713, 3277.475603903364, 275770.999999998, 276784.0, 276818.0, 277667.0, 278702.0, 53195.73402132965, 53603.0, 53621.73189134029, 53685.73157134267, 53758.19362709563, 33440.83279583635, 34536.48195277073, 34582.654173458446, 36305.818470908, 36336.45495317572, 14186.432542698176, 14318.069325493809, 14332.426702931974, 14339.139651620728, 14358.712825743636, 10598.31110977784, 10659.626913058006, 10672.146228301717, 10679.359238445562, 10682.092022178202, 18389.448316550526, 18402.0, 18424.539386515444, 18555.536111597317, 18582.628347432976, 6508.707108180143, 6715.731370745116, 6723.0, 6739.393454589111, 6934.375906168469, 719.9668475737334, 782.2529484342439, 786.3709032773758, 822.3955392786297, 832.1595188859295, 26960.325991849968, 28104.43791124166, 28686.569701454497, 28734.0, 28825.85587072093, 916.3768637326682, 942.0673533202081, 992.4343124419012, 1017.5827910556784, 1025.466757286207, 14348.856511434751, 14734.26328683583, 15073.397064117313, 15100.169490678118, 15499.457518987007, 390400.0, 391499.0, 395333.0, 396133.0, 397886.0, 49327.50672493229, 49643.50356496389, 49699.0, 49719.25421118686, 50113.0, 1072.9248952573246, 1140.270227054669, 1204.8915597596258, 1207.8127890177036, 1208.2689972566823, 28480.572791407732, 29146.854265728536, 29307.267318317212, 29641.0, 29827.552586711652, 42119.0, 42466.78766606147, 42644.0, 42720.35919461273, 42740.57259427366, 293195.0, 296697.0, 296776.0, 297072.0, 298017.0, 22220.66668999934, 24549.754502454747, 24944.75055249497, 25598.744012559637, 25700.228993130237, 41208.38187427131, 41546.376804347354, 41672.58327416687, 42474.36288455614, 42632.360514592925, 36148.27703445864, 36241.0, 36270.4559431614, 36689.0, 36932.261354772214, 35037.124071898405, 35797.0, 35805.283894322485, 35940.64059359373, 38088.0, 34882.30235395329, 34997.12507187239, 36790.8160459196, 36985.075373115884, 37351.25297493981, 31766.523502147025, 33203.50194747032, 33273.16817079592, 33405.16487087842, 33446.0, 24889.751102489467, 25455.0, 25495.745042549337, 25878.353041173366, 25918.870405647853], "value": 17328.874611539264, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [342.94745945516064, 361.6239111324223, 366.59308167933597, 368.73635350724237, 373.99582122002425, 13310.800337994939, 16722.41471548496, 17059.573510662223, 17883.28466861324, 18808.34170804022, 18058.909705451453, 18174.818251817476, 18326.175322110503, 18419.447416577492, 18490.907545462287, 4503.662225333105, 4786.952130478703, 4788.832390866321, 4845.612351011928, 4851.272309153637, 3509.4209455439823, 4706.22347312693, 5249.816256431026, 5522.475364840334, 5545.140503221987, 5499.285092937913, 5538.086215774392, 5560.77756889724, 5568.081266591008, 5570.805021824237, 5465.863353416156, 5991.221141251609, 6025.246844144482, 6027.186329845458, 6030.758769649209, 3388.3562123196516, 4991.3511243538105, 5300.390455097675, 5305.177697456862, 5340.385855626575, 12748.61754147377, 12763.744725105538, 12892.290923999177, 13014.934925325313, 13197.736045279136, 1855.0910054073543, 1885.1139964216795, 1939.0983192815409, 1944.922203111888, 1979.0, 9820.607175712963, 10211.438370889598, 10939.960703733212, 10979.0, 13948.581542553638, 1738.5045262100368, 1756.5432987423362, 1773.8314860088271, 1774.9911250443795, 1780.2522940365077, 70604.94092588616, 72929.27070729277, 73507.63246183789, 73885.26114738837, 73984.6300768498, 8694.608742606599, 9322.440653560672, 9685.37045092081, 9738.853917191247, 9951.575058659195, 11979.640610781691, 12673.556425525063, 12696.111272211041, 12914.741705165845, 12941.54704585335, 7025.0, 7053.400460960773, 7255.52839065459, 7289.307515785992, 7304.123505179306, 6701.430378417792, 6704.865902681919, 6800.081988931431, 6817.727290908408, 6823.55646882951, 4166.749995000309, 4171.395147703627, 4195.160967806451, 4294.9785251073545, 4451.888702782457, 1786.20513871326, 1823.2798044772242, 1832.7250912363252, 1834.4496651004913, 1869.3550724999852, 863.7495126413395, 868.7567481105301, 912.2291663544295, 990.4107056301489, 995.4326034160459, 16779.83220167807, 17177.0, 17491.0, 17988.820111798977, 18383.632327353647, 856.7986523167051, 871.6992637540038, 876.1326286975848, 903.796645754713, 912.370464379576, 6872.450203983669, 10127.265638277771, 10181.389116652876, 10191.0, 10292.742681433025, 386203.0, 386661.0, 387701.0, 388131.0, 388899.0, 78841.60579197182, 81002.59498702468, 82384.0, 82748.0, 82922.58538707267, 781.6287263549882, 788.8264581791997, 802.9959850200712, 812.2811311988814, 813.1665043330515, 15353.539393818204, 15726.370945162065, 15862.68274634524, 16177.919110404373, 16357.67284654324, 38571.300008999104, 38596.6140338593, 39378.60621393749, 39546.0, 39698.60301397065, 46699.53300467088, 54539.0, 54556.0, 54585.1812222809, 55225.72387138039, 7189.856202876018, 7442.244306459425, 7452.329290363677, 7473.9177359396135, 7608.885866712115, 10301.845472318071, 11114.666560003212, 11352.489137988645, 11588.536458541901, 11614.012808911337, 5976.462118409364, 7996.960015199887, 9846.753831154278, 10042.69871903844, 10181.847272290774, 9387.249020078514, 9689.22486201088, 9758.316917815684, 9789.608415663293, 9825.231458337568, 9710.465924374228, 10068.597256109673, 10075.244356673426, 10097.141742951932, 10145.79708405813, 7360.889586656312, 7433.591152486449, 7451.962740186264, 7614.466987310835, 7641.847163056819, 7527.3601743850195, 8890.64437422496, 9724.124828765445, 9733.464659443798, 9848.507574621384], "value": 8033.880001377673, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1226.4358395138236, 1375.7111006688592, 1409.3446547355477, 1480.6890552983873, 1674.4055860169647, 6368.586041907272, 7155.463340249483, 7377.225391333913, 7394.186639469654, 7557.05536807899, 7269.273072692728, 7389.150247721514, 7391.223921488247, 7394.038774959261, 7420.183779784219, 1879.9906000469978, 2089.6552068908686, 2124.4901223706274, 2145.7210562626838, 2186.365953873375, 2248.05581655705, 2259.017327462551, 2269.909203631853, 2273.4089136824464, 2274.3404412720374, 2145.034734369532, 2145.7210562626838, 2228.721409823772, 2233.2741858895924, 2237.0827960536185, 1850.6021205440761, 1912.3498010676299, 1920.817522335376, 2052.415061707421, 2148.924787632433, 2153.332466935255, 2188.1356864038776, 2192.397090800027, 2194.473326401668, 2194.8792816395253, 7522.924770752277, 7566.697332106709, 7577.280158385, 7580.241975802431, 7583.127940286882, 4442.600165985044, 4571.22289210835, 4575.22221222393, 4579.610733087658, 4581.5647513486165, 2774.7780177585946, 2833.4616422879585, 2834.2489240351324, 2836.106626412694, 2847.658281006272, 862.7498025572577, 876.5441970175473, 892.7678803511069, 916.0564618443015, 918.7289749523907, 10082.143017843493, 10087.69736907894, 10108.696739097766, 10143.39139651616, 10147.949260253652, 4019.21625283067, 4088.979555102265, 4225.619694227535, 4251.277282861921, 4257.595528424795, 8555.529445880537, 8561.0582835888, 8564.3148548116, 8567.0, 8579.571021449028, 4511.187986162457, 4532.4334458192725, 4539.750313732777, 4541.205289074399, 4555.043440877386, 3592.0660628236847, 3999.7800120993625, 4125.855595054219, 4135.7518548887165, 4175.68682348825, 3415.0949998250485, 3455.3953058215216, 3502.4571191465366, 3518.5074089627474, 3538.6461353864406, 999.1457304005116, 1111.972200694973, 1158.223989926751, 1179.9469023893773, 1182.5742732616252, 735.764555342296, 746.4476287547176, 780.5004796929969, 815.3640160674684, 818.5048045932125, 4712.434507859079, 4742.1227072991605, 4849.224124140192, 4961.42943561495, 4987.376577927759, 840.0717207485762, 840.82342708032, 844.4342290665269, 849.3417601358997, 852.1606217875387, 3181.236503239206, 3326.4012477753754, 3330.400527904952, 3335.0661814691925, 3374.848131834024, 8649.61076751535, 8943.821123577622, 9046.095390461032, 9068.138526839939, 9092.499912504743, 8981.14679105484, 8998.68504602349, 8999.19007289347, 9002.009778924314, 9014.459132451942, 6796.320367963164, 6855.4172895304455, 6866.862662746817, 6873.450123990069, 6878.8624227516175, 4848.903021939612, 4888.755562221946, 5018.473060328759, 5094.108531007133, 5113.565346945403, 8307.750767476986, 8328.791780205544, 8332.375071869756, 8378.706745263886, 8549.102344254012, 8584.227419532272, 8600.354973376896, 8700.0, 8738.825223495622, 8760.21158095749, 6177.6911154443, 6376.968115159394, 6402.327755585597, 6442.065900444503, 6456.451201647913, 6930.584164950119, 7143.607101609254, 7149.249328820607, 7157.24848890859, 7162.247963963917, 6235.064740288812, 6275.152854364785, 6306.337834527309, 6561.015847622894, 6629.801105966829, 6093.725782339717, 6107.450329470369, 6134.202553667995, 6137.355577664281, 6275.6862156892885, 5771.971140144273, 5784.479396854304, 5801.274840644919, 5810.331811841692, 5816.883662326814, 4173.144505376451, 4285.164392943346, 4341.348797680247, 4345.826166953287, 4404.427424434803, 4217.367394890791, 4407.49313828901, 4415.867523974286, 4497.257952437942, 4527.253003254558], "value": 3956.3892486604204, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [290.44524957331487, 297.8763813017598, 302.695790730316, 307.9615048118985, 311.41298652040894, 4596.218642830719, 4768.1894078006735, 4798.136335459616, 4814.229723244282, 4832.540908613681, 4583.335416364634, 4722.433308003045, 4727.149113159629, 4732.2428411454175, 4741.265103908891, 3795.867144649938, 3797.164623782777, 3799.8290076946464, 3803.6576708096336, 3809.104860357814, 3637.5271214742047, 3665.999999999987, 3805.752626079296, 3806.0675134591925, 3806.686693090879, 3775.093977445407, 3776.564905335982, 3783.5270591176104, 3783.81080945953, 3786.5266841644793, 3768.6231376862092, 3773.471713960048, 3779.7732136071786, 3781.149241420686, 3781.243751249761, 3361.6974472297366, 3368.6799754023327, 3370.6292307846115, 3373.190434295776, 3403.9319213615836, 4567.725936443824, 4643.582077613031, 4655.4878963314, 4682.27424749161, 4693.741844198567, 4274.893127671802, 4289.806958686867, 4296.228932338624, 4301.720388174758, 4330.718503297276, 4818.927716084261, 4944.431390390115, 4958.281049247839, 4986.326845875797, 5024.422191447994, 3578.3022310649435, 3581.230035542371, 3583.605803361628, 3592.5868525119686, 3602.279544091166, 5224.059669259532, 5277.261183434322, 5288.762005709791, 5296.364436267672, 5311.73441327936, 3701.9074523136596, 3706.369917114097, 3712.368897287414, 3718.9070273243387, 3726.5155529780955, 3536.5932917714276, 3713.9257214856093, 3718.888433347004, 3733.3466643337306, 3750.081230098643, 4215.882791060371, 4226.725262857966, 4227.32362821947, 4240.745555266694, 4256.233877902007, 4936.136176169156, 4978.751062446863, 4996.300517927493, 5000.299958005882, 5008.824691135793, 1159.6694941941507, 1206.6862615719976, 1217.21489639184, 1247.5695884919687, 1248.925064496115, 777.366446346226, 837.9078301386843, 838.8154605986673, 842.1704620948361, 847.6990668312784, 3708.2212735325884, 3725.3480640887738, 3730.8880733577494, 3754.5682246541996, 3755.1926335837925, 4465.37484752135, 4474.530174331713, 4488.685791994529, 4515.2549829277805, 4560.931586026212, 3599.280143971216, 3648.7810731356203, 3675.6000699353526, 3690.612485689018, 3800.7149463790324, 2621.4101827088753, 2634.617980392871, 2647.483740670589, 2654.7876169906363, 2656.8671566421604, 4794.856154315376, 4801.231802911588, 4811.422629284508, 4812.807487700523, 4824.276358546246, 5074.831418271341, 5243.868903277448, 5259.579233661298, 5265.104932161542, 5279.234510995884, 4786.425628924481, 4789.61683065347, 4789.976050119727, 4803.183458811941, 4808.182608956416, 4954.479779623088, 4955.578775804097, 4959.925601115914, 4962.702237865739, 4973.179425394914, 4782.521747825329, 4970.589264206785, 5009.198528235464, 5010.123228435083, 5021.8449756555465, 4736.905261894812, 4750.5249475052215, 4784.210605250234, 4798.328234047166, 4813.590844778233, 3455.9654403455643, 3647.562292524914, 3661.992951938238, 3698.3342998259495, 3700.093477098128, 4831.855044348676, 4906.8773280668265, 4910.140725372974, 4935.136351138608, 4946.3817022872145, 4365.081302202131, 4908.4355299139625, 4921.360223170965, 4924.818043669422, 4931.284963680175, 4861.878453038702, 4881.609471242221, 4897.9020419592125, 4932.408111026556, 4932.580730637936, 4663.930041049455, 4767.856964291077, 4788.4621150790135, 4807.399075115611, 4822.035592881368, 4871.853844384674, 4879.243717223836, 4881.0, 4894.853154405374, 4896.583790377716, 4767.0, 4796.160671882337, 4832.864276894857, 4844.903101938012, 4862.4651288357545], "value": 3697.2473303930524, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [669.9899501507476, 716.8991142731247, 736.403513154345, 750.0474397515156, 786.1941509952302, 11153.219274650777, 11615.593454229103, 12011.879881201185, 12203.450844711988, 12223.572174973877, 11973.401329933513, 12004.459799309052, 12117.33354665493, 12145.757084858298, 12150.33173175475, 630.7098734582098, 774.2257742257742, 775.2480094308512, 792.374024520628, 797.7407342613644, 793.3613441179848, 802.7230605441114, 803.1727320859495, 804.0150815251329, 804.90341159061, 842.4818736477084, 845.1886189258289, 847.2120927537388, 847.6016272351985, 847.9491230526188, 652.1522021372197, 797.174923953711, 826.5371392020488, 839.4375768235267, 841.3689732700444, 607.583805093508, 607.8601921558022, 607.9939200607981, 608.1455554945309, 608.3581821178655, 12127.454264558117, 12136.939315303456, 12156.696082597917, 12165.391730413445, 12180.939095304468, 12394.56619018339, 12895.67760805978, 13043.934780326132, 13091.607251782461, 13241.602751917459, 11751.353675547842, 11854.170208085437, 11945.223560468628, 12043.759124817454, 12385.938070309681, 4240.893977650552, 4294.162638285536, 4313.892152696177, 4322.589354011364, 4396.3625274335045, 52798.47201527974, 54852.72573637146, 55132.0, 58417.0, 62483.687581562255, 10728.892711072946, 11192.0, 11339.0, 11378.487968041458, 11714.1800073994, 20381.79618203799, 20401.285954991505, 20407.285744998855, 20423.897880510503, 20427.693584596243, 7085.751998680022, 7123.287671232835, 7185.640717964186, 7190.029346038323, 7418.629068546551, 3593.4789455528803, 3682.834272457746, 3739.9439008414897, 3742.1580144467275, 3831.4827498287373, 2735.3845384788265, 2810.4660114578164, 2815.2680303121338, 2816.4367126574766, 2821.3369858083333, 478.7103802199689, 488.0750976898757, 488.4236600811006, 495.22250067393844, 532.2229544864464, 626.7936862244964, 630.9274433440121, 646.7348387161242, 646.9385408386196, 648.3969907985619, 8736.8689469658, 8767.561621918878, 8822.51476168817, 8840.204381605687, 8913.910860891438, 533.9145736682112, 554.2822045451151, 637.9617222966637, 641.6214433484266, 657.086649557116, 3899.7855117968215, 3899.863504777319, 4019.698522610816, 4052.675785937118, 4089.325261331847, 66900.0, 70237.64881175561, 70373.64813176004, 107160.46419768008, 110451.0, 46458.76770616193, 59492.75326090785, 72017.0, 72214.27785722181, 73204.63397683084, 44795.776021120335, 68511.3148868505, 69271.0, 69923.0, 71148.0, 8740.421099620715, 8832.91167088321, 8909.55452227399, 8935.553222338727, 8983.550822458721, 30715.539266911463, 34383.0, 44591.0, 44965.550344496136, 45056.0, 61936.38063619306, 62257.688711556155, 62390.376096238455, 63131.684341577995, 64222.0, 9464.337496375188, 9518.381305215138, 9682.27382946296, 10908.890911090788, 11117.27737697047, 10858.45707714627, 11289.491972861077, 12893.677658058248, 13184.538541151014, 13471.12437691547, 12006.63980080599, 12453.813192802296, 12543.804834153803, 12569.622911312676, 13190.208587484782, 11133.165012623924, 11153.665390038312, 11838.408079596158, 12013.579524716593, 12268.631941041784, 12126.878731212575, 12499.312537810507, 12660.0, 12692.428840702007, 13304.86695133075, 9717.27120465982, 9990.650327238513, 10115.443650599287, 10327.0, 10544.420056896945, 10295.742606434898, 10319.329243599143, 10345.0, 10346.844797328196, 10789.514471848628], "value": 6571.249605692066, "unit": "score"}], "name": "dromaeo_css", "value": 6285.27183919736, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 119.0, 113.0, 115.0, 113.0, 114.0, 114.0, 113.0, 115.0, 113.0], "value": 113.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 122.0, 124.0, 177.0, 123.0, 131.0, 148.0, 124.0, 186.0, 126.0], "value": 141.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 161.0, 161.0, 162.0, 162.0, 165.0, 163.0, 162.0, 161.0], "value": 161.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 85.0, 76.0, 125.0, 76.0, 75.0, 74.0, 74.0, 98.0, 76.0], "value": 83.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 117.0, 85.0, 85.0, 86.0, 124.0, 85.0, 85.0, 131.0], "value": 96.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 118.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 62.0, 63.0, 62.0, 63.0, 62.0, 64.0, 63.0, 64.0, 61.0], "value": 62.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 66.0, 65.0, 65.0, 65.0, 65.0, 65.0, 67.0, 65.0], "value": 65.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 79.0, 79.0, 78.0, 79.0, 84.0, 79.0, 79.0, 79.0], "value": 79.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 137.0, 128.0, 133.0, 127.0, 128.0, 138.0, 133.0, 168.0, 131.0], "value": 135.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 167.0, 165.0, 176.0, 169.0, 167.0, 167.0, 168.0, 163.0, 166.0], "value": 167.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 72.0, 68.0, 66.0, 67.0, 67.0, 66.0, 65.0, 69.0], "value": 67.2, "unit": "score"}], "name": "kraken", "value": 1533.7000000000003, "alertThreshold": 2.0}]} 09:05:38 INFO - Return code: 0 09:05:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:05:38 INFO - # TBPL SUCCESS # 09:05:38 INFO - Running post-action listener: _resource_record_post_action 09:05:38 INFO - ##### 09:05:38 INFO - ##### Finished run-tests step (success) 09:05:38 INFO - ##### 09:05:38 INFO - Running post-run listener: _resource_record_post_run 09:05:38 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 0; Write bytes: 545009664; Read time: 0; Write time: 421536 09:05:38 INFO - TinderboxPrint: CPU usage
13.0% 09:05:38 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 09:05:38 INFO - TinderboxPrint: I/O write bytes / time
545,009,664 / 421,536 09:05:38 INFO - TinderboxPrint: CPU idle
8,327.0 (87.0%) 09:05:38 INFO - TinderboxPrint: CPU user
1,202.7 (12.6%) 09:05:38 INFO - TinderboxPrint: Swap in / out
0 / 0 09:05:38 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 253517824; Read time: 0; Write time: 220292 09:05:38 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 0; Write bytes: 286937088; Read time: 0; Write time: 200544 09:05:39 INFO - Running post-run listener: _upload_blobber_files 09:05:39 INFO - Blob upload gear active. 09:05:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:05:39 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 09:05:39 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:05:39 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:05:39 INFO - (blobuploader) - INFO - Open directory for files ... 09:05:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:05:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:05:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:05:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:05:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:05:40 INFO - (blobuploader) - INFO - Done attempting. 09:05:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:05:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:05:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:05:45 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:05:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:05:45 INFO - (blobuploader) - INFO - Done attempting. 09:05:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:05:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:05:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:05:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:05:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:05:46 INFO - (blobuploader) - INFO - Done attempting. 09:05:46 INFO - (blobuploader) - INFO - Iteration through files over. 09:05:46 INFO - Return code: 0 09:05:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:05:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:05:46 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7091f54e247c49054987ae136f01591a659310a984b81512de34ef57246e7d95d565875a3ece6350ad640f2ca3b2bf3c1319317f09229ab9960455d1e1bb3381", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bbf8b2662b75ac633de2e306bd78fd5c0b9daf2a7725020f63a59dbf7da4ad4e3393c51801e325bc1dcc00ec7d649de733d4097b7c7db5bda0329ae19990b489", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/59c3d00dd1ae16ba75baee86198a50735162dd4e9852855f6378db8fcb49c572e4e56bc84d29ef491aaa61f6a807900d027f2d979915d4fdeab9432fb19d7871"} 09:05:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:05:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:05:46 INFO - Contents: 09:05:46 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7091f54e247c49054987ae136f01591a659310a984b81512de34ef57246e7d95d565875a3ece6350ad640f2ca3b2bf3c1319317f09229ab9960455d1e1bb3381", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bbf8b2662b75ac633de2e306bd78fd5c0b9daf2a7725020f63a59dbf7da4ad4e3393c51801e325bc1dcc00ec7d649de733d4097b7c7db5bda0329ae19990b489", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/59c3d00dd1ae16ba75baee86198a50735162dd4e9852855f6378db8fcb49c572e4e56bc84d29ef491aaa61f6a807900d027f2d979915d4fdeab9432fb19d7871"} 09:05:46 INFO - Running post-run listener: copy_logs_to_upload_dir 09:05:46 INFO - Copying logs to upload dir... 09:05:46 INFO - mkdir: /builds/slave/test/build/upload/logs 09:05:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.783701 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-07-11 09:05:45.461471) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-11 09:05:45.465017) ========= 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=ed14279e38b05397cf4aa391000001a4-1468251734.370168-765231984 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7091f54e247c49054987ae136f01591a659310a984b81512de34ef57246e7d95d565875a3ece6350ad640f2ca3b2bf3c1319317f09229ab9960455d1e1bb3381", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bbf8b2662b75ac633de2e306bd78fd5c0b9daf2a7725020f63a59dbf7da4ad4e3393c51801e325bc1dcc00ec7d649de733d4097b7c7db5bda0329ae19990b489", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/59c3d00dd1ae16ba75baee86198a50735162dd4e9852855f6378db8fcb49c572e4e56bc84d29ef491aaa61f6a807900d027f2d979915d4fdeab9432fb19d7871"} build_url:https://queue.taskcluster.net/v1/task/dF1r_xBQS6GuOywinxjs7Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011208 build_url: 'https://queue.taskcluster.net/v1/task/dF1r_xBQS6GuOywinxjs7Q/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/Firefox-Non-PGO/sha512/7091f54e247c49054987ae136f01591a659310a984b81512de34ef57246e7d95d565875a3ece6350ad640f2ca3b2bf3c1319317f09229ab9960455d1e1bb3381", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bbf8b2662b75ac633de2e306bd78fd5c0b9daf2a7725020f63a59dbf7da4ad4e3393c51801e325bc1dcc00ec7d649de733d4097b7c7db5bda0329ae19990b489", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/59c3d00dd1ae16ba75baee86198a50735162dd4e9852855f6378db8fcb49c572e4e56bc84d29ef491aaa61f6a807900d027f2d979915d4fdeab9432fb19d7871"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-11 09:05:45.490538) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 09:05:45.490872) ========= 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=ed14279e38b05397cf4aa391000001a4-1468251734.370168-765231984 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004485 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 09:05:45.576622) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-11 09:05:45.577021) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-11 09:05:45.577343) ========= ========= Total master_lag: 0.45 =========