builder: autoland_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-027 starttime: 1467781269.3 results: success (0) buildid: 20160705204822 builduid: 16b7515c85494fe9a3d214ce641a1fd2 revision: 28441ef38d799c44a4a671b39137da5544e807af ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-05 22:01:09.303987) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-05 22:01:09.304870) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-05 22:01:09.305360) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-05 22:01:09.365759) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 22:01:09.366085) ========= 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=1f5564757af27664ca02d71f000001b0-1467779463.259547-1588527049 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-05 22:01:09-- 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% 46.5M=0s 2016-07-05 22:01:09 (46.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.124197 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 22:01:09.505575) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 22:01:09.505897) ========= 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=1f5564757af27664ca02d71f000001b0-1467779463.259547-1588527049 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019743 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 22:01:09.556994) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 22:01:09.557357) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 28441ef38d799c44a4a671b39137da5544e807af --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 28441ef38d799c44a4a671b39137da5544e807af --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=1f5564757af27664ca02d71f000001b0-1467779463.259547-1588527049 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-05 22:01:09,632 truncating revision to first 12 chars 2016-07-05 22:01:09,632 Setting DEBUG logging. 2016-07-05 22:01:09,632 attempt 1/10 2016-07-05 22:01:09,632 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/28441ef38d79?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-05 22:01:09,938 unpacking tar archive at: autoland-28441ef38d79/testing/mozharness/ program finished with exit code 0 elapsedTime=0.651261 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 22:01:10.223022) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-05 22:01:10.223416) ========= script_repo_revision: 28441ef38d799c44a4a671b39137da5544e807af ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-05 22:01:10.223889) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-05 22:01:10.224217) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-05 22:01:10.237803) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-07-05 22:01:10.238229) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland-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=1f5564757af27664ca02d71f000001b0-1467779463.259547-1588527049 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:01:10 INFO - MultiFileLogger online at 20160705 22:01:10 in /builds/slave/test 22:01:10 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 22:01:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:01:10 INFO - {'append_to_log': False, 22:01:10 INFO - 'base_work_dir': '/builds/slave/test', 22:01:10 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 22:01:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:01:10 INFO - 'branch': 'Autoland-Non-PGO', 22:01:10 INFO - 'buildbot_json_path': 'buildprops.json', 22:01:10 INFO - 'config_files': ('talos/linux_config.py',), 22:01:10 INFO - 'default_actions': ('clobber', 22:01:10 INFO - 'read-buildbot-config', 22:01:10 INFO - 'download-and-extract', 22:01:10 INFO - 'populate-webroot', 22:01:10 INFO - 'create-virtualenv', 22:01:10 INFO - 'install', 22:01:10 INFO - 'run-tests'), 22:01:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:01:10 INFO - 'download_minidump_stackwalk': True, 22:01:10 INFO - 'download_symbols': 'ondemand', 22:01:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:01:10 INFO - 'tooltool.py': '/tools/tooltool.py', 22:01:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:01:10 INFO - '/tools/misc-python/virtualenv.py')}, 22:01:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:01:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:01:10 INFO - 'installer_path': 'installer.exe', 22:01:10 INFO - 'log_level': 'info', 22:01:10 INFO - 'log_name': 'talos', 22:01:10 INFO - 'log_to_console': True, 22:01:10 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:01:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:01:10 INFO - 'opt_config_files': (), 22:01:10 INFO - 'pip_index': False, 22:01:10 INFO - 'sps_profile': False, 22:01:10 INFO - 'sps_profile_interval': 0, 22:01:10 INFO - 'suite': 'dromaeojs-e10s', 22:01:10 INFO - 'system_bits': '32', 22:01:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:01:10 INFO - 'title': 'talos-linux64-ix-027', 22:01:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:01:10 INFO - 'use_talos_json': True, 22:01:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:01:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:01:10 INFO - 'work_dir': 'build'} 22:01:10 INFO - ##### 22:01:10 INFO - ##### Running clobber step. 22:01:10 INFO - ##### 22:01:10 INFO - Running pre-action listener: _resource_record_pre_action 22:01:10 INFO - Running main action method: clobber 22:01:10 INFO - rmtree: /builds/slave/test/build 22:01:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:01:10 INFO - Running post-action listener: _resource_record_post_action 22:01:10 INFO - ##### 22:01:10 INFO - ##### Finished clobber step (success) 22:01:10 INFO - ##### 22:01:10 INFO - ##### 22:01:10 INFO - ##### Running read-buildbot-config step. 22:01:10 INFO - ##### 22:01:10 INFO - Running pre-action listener: _resource_record_pre_action 22:01:10 INFO - Running main action method: read_buildbot_config 22:01:10 INFO - Using buildbot properties: 22:01:10 INFO - { 22:01:10 INFO - "project": "", 22:01:10 INFO - "product": "firefox", 22:01:10 INFO - "script_repo_revision": "production", 22:01:10 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs-e10s", 22:01:10 INFO - "repository": "", 22:01:10 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs-e10s", 22:01:10 INFO - "buildid": "20160705204822", 22:01:10 INFO - "pgo_build": "False", 22:01:10 INFO - "basedir": "/builds/slave/test", 22:01:10 INFO - "buildnumber": 49, 22:01:10 INFO - "slavename": "talos-linux64-ix-027", 22:01:10 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 22:01:10 INFO - "platform": "ubuntu64_hw", 22:01:10 INFO - "scheduler": "tests-autoland-linux64-talos", 22:01:10 INFO - "branch": "autoland", 22:01:10 INFO - "repo_path": "integration/autoland", 22:01:10 INFO - "revision": "28441ef38d799c44a4a671b39137da5544e807af", 22:01:10 INFO - "stage_platform": "linux64", 22:01:10 INFO - "builduid": "16b7515c85494fe9a3d214ce641a1fd2", 22:01:10 INFO - "slavebuilddir": "test" 22:01:10 INFO - } 22:01:10 INFO - Found installer url https://queue.taskcluster.net/v1/task/NnD_MmAqRASm9rZ45wORMw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 22:01:10 INFO - Running post-action listener: _resource_record_post_action 22:01:10 INFO - ##### 22:01:10 INFO - ##### Finished read-buildbot-config step (success) 22:01:10 INFO - ##### 22:01:10 INFO - ##### 22:01:10 INFO - ##### Running download-and-extract step. 22:01:10 INFO - ##### 22:01:10 INFO - Running pre-action listener: _resource_record_pre_action 22:01:10 INFO - Running main action method: download_and_extract 22:01:10 INFO - mkdir: /builds/slave/test/build/tests 22:01: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')]} 22:01:10 INFO - https://queue.taskcluster.net/v1/task/NnD_MmAqRASm9rZ45wORMw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 22:01:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NnD_MmAqRASm9rZ45wORMw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 22:01:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NnD_MmAqRASm9rZ45wORMw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 22:01:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NnD_MmAqRASm9rZ45wORMw/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 22:01:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NnD_MmAqRASm9rZ45wORMw/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 22:01:13 INFO - Downloaded 1361 bytes. 22:01:13 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 22:01:13 INFO - Using the following test package requirements: 22:01:13 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 22:01:13 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:01:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:01:13 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:01:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:01:13 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:01:13 INFO - u'jsshell-linux-x86_64.zip'], 22:01:13 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:01:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:01:13 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 22:01:13 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:01:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:01:13 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:01:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:01:13 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:01:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:01:13 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:01:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:01:13 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:01:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:01:13 INFO - https://queue.taskcluster.net/v1/task/NnD_MmAqRASm9rZ45wORMw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:01:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NnD_MmAqRASm9rZ45wORMw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 22:01:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NnD_MmAqRASm9rZ45wORMw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 22:01:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NnD_MmAqRASm9rZ45wORMw/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 22:01:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NnD_MmAqRASm9rZ45wORMw/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 22:01:17 INFO - Downloaded 22732508 bytes. 22:01:17 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'] 22:01:17 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 22:01:18 INFO - Return code: 0 22:01:18 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 22:01:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:01:18 INFO - https://queue.taskcluster.net/v1/task/NnD_MmAqRASm9rZ45wORMw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:01:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NnD_MmAqRASm9rZ45wORMw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 22:01:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NnD_MmAqRASm9rZ45wORMw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 22:01:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NnD_MmAqRASm9rZ45wORMw/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 22:01:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NnD_MmAqRASm9rZ45wORMw/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 22:01:20 INFO - Downloaded 22732508 bytes. 22:01:20 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'] 22:01:20 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 22:01:21 INFO - Return code: 0 22:01:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:01:21 INFO - https://queue.taskcluster.net/v1/task/NnD_MmAqRASm9rZ45wORMw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:01:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NnD_MmAqRASm9rZ45wORMw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 22:01:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NnD_MmAqRASm9rZ45wORMw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 22:01:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NnD_MmAqRASm9rZ45wORMw/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 22:01:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NnD_MmAqRASm9rZ45wORMw/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 22:01:22 INFO - Downloaded 14403333 bytes. 22:01:22 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'] 22:01:22 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 22:01:23 INFO - Return code: 0 22:01: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')]} 22:01:23 INFO - https://queue.taskcluster.net/v1/task/NnD_MmAqRASm9rZ45wORMw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:01:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NnD_MmAqRASm9rZ45wORMw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 22:01:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NnD_MmAqRASm9rZ45wORMw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 22:01:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NnD_MmAqRASm9rZ45wORMw/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 22:01:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NnD_MmAqRASm9rZ45wORMw/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 22:01:24 INFO - Downloaded 56502367 bytes. 22:01:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NnD_MmAqRASm9rZ45wORMw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 22:01:24 INFO - mkdir: /builds/slave/test/properties 22:01:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:01:24 INFO - Writing to file /builds/slave/test/properties/build_url 22:01:24 INFO - Contents: 22:01:24 INFO - build_url:https://queue.taskcluster.net/v1/task/NnD_MmAqRASm9rZ45wORMw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 22:01:24 INFO - Running post-action listener: _resource_record_post_action 22:01:24 INFO - Running post-action listener: set_extra_try_arguments 22:01:24 INFO - ##### 22:01:24 INFO - ##### Finished download-and-extract step (success) 22:01:24 INFO - ##### 22:01:24 INFO - ##### 22:01:24 INFO - ##### Running populate-webroot step. 22:01:24 INFO - ##### 22:01:24 INFO - Running pre-action listener: _resource_record_pre_action 22:01:24 INFO - Running main action method: populate_webroot 22:01:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:01:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:01:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:01:25 INFO - '--tppagecycles', 22:01:25 INFO - '7'], 22:01:25 INFO - 'tests': ['tsvgm']}}, 22:01:25 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:01:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:01:25 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:01:25 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:01:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:01:25 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:01:25 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:01:25 INFO - 'talos_options': ['--disable-e10s'], 22:01:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:01:25 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:01:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:01:25 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:01:25 INFO - 'talos_options': ['--disable-e10s'], 22:01:25 INFO - 'tests': ['damp', 'tps']}, 22:01:25 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:01:25 INFO - 'tests': ['damp', 'tps']}, 22:01:25 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:01:25 INFO - 'tests': ['dromaeo_dom']}, 22:01:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:01:25 INFO - 'g4': {'talos_options': ['--disable-e10s'], 22:01:25 INFO - 'tests': ['basic_compositor_video']}, 22:01:25 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 22:01:25 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:01:25 INFO - 'tests': ['a11yr', 22:01:25 INFO - 'ts_paint', 22:01:25 INFO - 'tpaint', 22:01:25 INFO - 'sessionrestore', 22:01:25 INFO - 'sessionrestore_no_auto_restore', 22:01:25 INFO - 'tabpaint']}, 22:01:25 INFO - 'other-e10s': {'tests': ['a11yr', 22:01:25 INFO - 'ts_paint', 22:01:25 INFO - 'tpaint', 22:01:25 INFO - 'sessionrestore', 22:01:25 INFO - 'sessionrestore_no_auto_restore', 22:01:25 INFO - 'tabpaint']}, 22:01:25 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:01:25 INFO - 'ts_paint', 22:01:25 INFO - 'tpaint', 22:01:25 INFO - 'sessionrestore', 22:01:25 INFO - 'sessionrestore_no_auto_restore', 22:01:25 INFO - 'tabpaint']}, 22:01:25 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:01:25 INFO - 'ts_paint', 22:01:25 INFO - 'tpaint', 22:01:25 INFO - 'sessionrestore', 22:01:25 INFO - 'sessionrestore_no_auto_restore', 22:01:25 INFO - 'tabpaint']}, 22:01:25 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:01:25 INFO - 'tests': ['a11yr', 22:01:25 INFO - 'ts_paint', 22:01:25 INFO - 'tpaint', 22:01:25 INFO - 'sessionrestore', 22:01:25 INFO - 'sessionrestore_no_auto_restore', 22:01:25 INFO - 'tabpaint']}, 22:01:25 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:01:25 INFO - 'tests': ['a11yr', 22:01:25 INFO - 'ts_paint', 22:01:25 INFO - 'tpaint', 22:01:25 INFO - 'sessionrestore', 22:01:25 INFO - 'sessionrestore_no_auto_restore', 22:01:25 INFO - 'tabpaint']}, 22:01:25 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:01:25 INFO - 'tests': ['tsvgx', 22:01:25 INFO - 'tsvgr_opacity', 22:01:25 INFO - 'tart', 22:01:25 INFO - 'tscrollx', 22:01:25 INFO - 'cart']}, 22:01:25 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:01:25 INFO - 'tsvgr_opacity', 22:01:25 INFO - 'tart', 22:01:25 INFO - 'tscrollx', 22:01:25 INFO - 'cart']}, 22:01:25 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:01:25 INFO - 'talos_options': ['--disable-e10s'], 22:01:25 INFO - 'tests': ['tp5o']}, 22:01:25 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:01:25 INFO - 'tests': ['tp5o']}, 22:01:25 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:01:25 INFO - 'talos_options': ['--disable-e10s', 22:01:25 INFO - '--xperf_path', 22:01:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:01:25 INFO - 'tests': ['tp5n']}, 22:01:25 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:01:25 INFO - 'talos_options': ['--xperf_path', 22:01:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:01:25 INFO - 'tests': ['tp5n']}}, 22:01:25 INFO - 'talos.zip': {'path': '', 22:01:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:01:25 INFO - Running post-action listener: _resource_record_post_action 22:01:25 INFO - ##### 22:01:25 INFO - ##### Finished populate-webroot step (success) 22:01:25 INFO - ##### 22:01:25 INFO - ##### 22:01:25 INFO - ##### Running create-virtualenv step. 22:01:25 INFO - ##### 22:01:25 INFO - Running pre-action listener: _resource_record_pre_action 22:01:25 INFO - Running main action method: create_virtualenv 22:01:25 INFO - Creating virtualenv /builds/slave/test/build/venv 22:01:25 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 22:01:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:01:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:01:25 INFO - Using real prefix '/usr' 22:01:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:01:25 INFO - Installing distribute.............................................................................................................................................................................................done. 22:01:27 INFO - Installing pip.................done. 22:01:27 INFO - Return code: 0 22:01:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:01:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:01:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:01:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:01:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:01:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d50030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f7f400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x200e570>, '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 0x200f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x200f900>, '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': '1f5564757af27664ca02d71f000001b0-1467779463.259547-1588527049', '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 22:01:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 22:01:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 22:01:27 INFO - Using env: {'DISPLAY': ':0', 22:01:27 INFO - 'HOME': '/home/cltbld', 22:01:27 INFO - 'LANG': 'en_US.UTF-8', 22:01:27 INFO - 'LANGUAGE': 'en_US:en', 22:01:27 INFO - 'LOGNAME': 'cltbld', 22:01:27 INFO - 'MAIL': '/var/mail/cltbld', 22:01:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:01:27 INFO - 'MOZ_NO_REMOTE': '1', 22:01:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:01:27 INFO - 'NO_EM_RESTART': '1', 22:01:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:01:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:01:27 INFO - 'PWD': '/builds/slave/test', 22:01:27 INFO - 'SHELL': '/bin/bash', 22:01:27 INFO - 'SHLVL': '1', 22:01:27 INFO - 'TERM': 'linux', 22:01:27 INFO - 'TMOUT': '86400', 22:01:27 INFO - 'USER': 'cltbld', 22:01:27 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1467779463.259547-1588527049', 22:01:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:01:27 INFO - '_': '/tools/buildbot/bin/python'} 22:01:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:01:27 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 22:01:27 INFO - Cleaning up... 22:01:27 INFO - Return code: 0 22:01:27 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 22:01:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:01:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:01:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:01:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:01:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1d50030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f7f400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x200e570>, '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 0x200f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x200f900>, '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': '1f5564757af27664ca02d71f000001b0-1467779463.259547-1588527049', '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 22:01:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 22:01:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 22:01:27 INFO - Using env: {'DISPLAY': ':0', 22:01:27 INFO - 'HOME': '/home/cltbld', 22:01:27 INFO - 'LANG': 'en_US.UTF-8', 22:01:27 INFO - 'LANGUAGE': 'en_US:en', 22:01:27 INFO - 'LOGNAME': 'cltbld', 22:01:27 INFO - 'MAIL': '/var/mail/cltbld', 22:01:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:01:27 INFO - 'MOZ_NO_REMOTE': '1', 22:01:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:01:27 INFO - 'NO_EM_RESTART': '1', 22:01:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:01:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:01:27 INFO - 'PWD': '/builds/slave/test', 22:01:27 INFO - 'SHELL': '/bin/bash', 22:01:27 INFO - 'SHLVL': '1', 22:01:27 INFO - 'TERM': 'linux', 22:01:27 INFO - 'TMOUT': '86400', 22:01:27 INFO - 'USER': 'cltbld', 22:01:27 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1467779463.259547-1588527049', 22:01:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:01:27 INFO - '_': '/tools/buildbot/bin/python'} 22:01:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:01:28 INFO - Downloading/unpacking psutil>=3.1.1 22:01: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 22:01: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 22:01: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 22:01: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 22:01: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 22:01: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 22:01:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:01:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:01:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:01:30 INFO - Installing collected packages: psutil 22:01:30 INFO - Running setup.py install for psutil 22:01:30 INFO - building 'psutil._psutil_linux' extension 22:01:30 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 22:01:30 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 22:01:30 INFO - building 'psutil._psutil_posix' extension 22:01:30 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 22:01:30 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 22:01:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:01:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:01:30 INFO - Successfully installed psutil 22:01:30 INFO - Cleaning up... 22:01:31 INFO - Return code: 0 22:01:31 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 22:01: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')]} 22:01:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:01:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01: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')]} 22:01:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:01:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d50030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f7f400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x200e570>, '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 0x200f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x200f900>, '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': '1f5564757af27664ca02d71f000001b0-1467779463.259547-1588527049', '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 22:01:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 22:01:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 22:01:31 INFO - Using env: {'DISPLAY': ':0', 22:01:31 INFO - 'HOME': '/home/cltbld', 22:01:31 INFO - 'LANG': 'en_US.UTF-8', 22:01:31 INFO - 'LANGUAGE': 'en_US:en', 22:01:31 INFO - 'LOGNAME': 'cltbld', 22:01:31 INFO - 'MAIL': '/var/mail/cltbld', 22:01:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:01:31 INFO - 'MOZ_NO_REMOTE': '1', 22:01:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:01:31 INFO - 'NO_EM_RESTART': '1', 22:01:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:01:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:01:31 INFO - 'PWD': '/builds/slave/test', 22:01:31 INFO - 'SHELL': '/bin/bash', 22:01:31 INFO - 'SHLVL': '1', 22:01:31 INFO - 'TERM': 'linux', 22:01:31 INFO - 'TMOUT': '86400', 22:01:31 INFO - 'USER': 'cltbld', 22:01:31 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1467779463.259547-1588527049', 22:01:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:01:31 INFO - '_': '/tools/buildbot/bin/python'} 22:01:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:01:31 INFO - Downloading/unpacking mozsystemmonitor==0.3 22:01:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:01:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:01:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:01:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:01:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:01:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:01:33 INFO - Downloading mozsystemmonitor-0.3.tar.gz 22:01:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:01:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 22:01:33 INFO - Installing collected packages: mozsystemmonitor 22:01:33 INFO - Running setup.py install for mozsystemmonitor 22:01:33 INFO - Successfully installed mozsystemmonitor 22:01:33 INFO - Cleaning up... 22:01:33 INFO - Return code: 0 22:01:33 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 22:01:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:01:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:01:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:01:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:01:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1d50030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f7f400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x200e570>, '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 0x200f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x200f900>, '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': '1f5564757af27664ca02d71f000001b0-1467779463.259547-1588527049', '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 22:01:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 22:01:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 22:01:33 INFO - Using env: {'DISPLAY': ':0', 22:01:33 INFO - 'HOME': '/home/cltbld', 22:01:33 INFO - 'LANG': 'en_US.UTF-8', 22:01:33 INFO - 'LANGUAGE': 'en_US:en', 22:01:33 INFO - 'LOGNAME': 'cltbld', 22:01:33 INFO - 'MAIL': '/var/mail/cltbld', 22:01:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:01:33 INFO - 'MOZ_NO_REMOTE': '1', 22:01:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:01:33 INFO - 'NO_EM_RESTART': '1', 22:01:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:01:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:01:33 INFO - 'PWD': '/builds/slave/test', 22:01:33 INFO - 'SHELL': '/bin/bash', 22:01:33 INFO - 'SHLVL': '1', 22:01:33 INFO - 'TERM': 'linux', 22:01:33 INFO - 'TMOUT': '86400', 22:01:33 INFO - 'USER': 'cltbld', 22:01:33 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1467779463.259547-1588527049', 22:01:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:01:33 INFO - '_': '/tools/buildbot/bin/python'} 22:01:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:01:33 INFO - Downloading/unpacking jsonschema==2.5.1 22:01:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:01:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:01:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:01:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:01:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:01:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:01:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:01:35 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 22:01:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:01:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:01:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:01:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:01:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:01:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:01:35 INFO - Downloading functools32-3.2.3-2.tar.gz 22:01:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:01:35 INFO - warning: no files found matching '*.txt' 22:01:35 INFO - no previously-included directories found matching 'build' 22:01:35 INFO - no previously-included directories found matching 'dist' 22:01:35 INFO - no previously-included directories found matching '.git*' 22:01:35 INFO - Installing collected packages: jsonschema, functools32 22:01:35 INFO - Running setup.py install for functools32 22:01:35 INFO - warning: no files found matching '*.txt' 22:01:35 INFO - no previously-included directories found matching 'build' 22:01:35 INFO - no previously-included directories found matching 'dist' 22:01:35 INFO - no previously-included directories found matching '.git*' 22:01:35 INFO - Successfully installed jsonschema functools32 22:01:35 INFO - Cleaning up... 22:01:35 INFO - Return code: 0 22:01:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:01: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')]} 22:01:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:01:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01: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')]} 22:01:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:01:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:35 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 0x1d50030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f7f400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x200e570>, '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 0x200f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x200f900>, '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': '1f5564757af27664ca02d71f000001b0-1467779463.259547-1588527049', '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 22:01:35 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 22:01:35 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 22:01:35 INFO - Using env: {'DISPLAY': ':0', 22:01:35 INFO - 'HOME': '/home/cltbld', 22:01:35 INFO - 'LANG': 'en_US.UTF-8', 22:01:35 INFO - 'LANGUAGE': 'en_US:en', 22:01:35 INFO - 'LOGNAME': 'cltbld', 22:01:35 INFO - 'MAIL': '/var/mail/cltbld', 22:01:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:01:35 INFO - 'MOZ_NO_REMOTE': '1', 22:01:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:01:35 INFO - 'NO_EM_RESTART': '1', 22:01:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:01:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:01:35 INFO - 'PWD': '/builds/slave/test', 22:01:35 INFO - 'SHELL': '/bin/bash', 22:01:35 INFO - 'SHLVL': '1', 22:01:35 INFO - 'TERM': 'linux', 22:01:35 INFO - 'TMOUT': '86400', 22:01:35 INFO - 'USER': 'cltbld', 22:01:35 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1467779463.259547-1588527049', 22:01:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:01:35 INFO - '_': '/tools/buildbot/bin/python'} 22:01:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:01:36 INFO - Downloading/unpacking blobuploader==1.2.4 22:01: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 22:01: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 22:01: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 22:01: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 22:01: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 22:01: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 22:01:37 INFO - Downloading blobuploader-1.2.4.tar.gz 22:01:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:01:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:01:38 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 22:01:38 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 22:01:38 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 22:01:38 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 22:01:38 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 22:01:38 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 22:01:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:01:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:01:38 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 22:01:38 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 22:01:38 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 22:01:38 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 22:01:38 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 22:01:38 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 22:01:38 INFO - Downloading docopt-0.6.1.tar.gz 22:01:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:01:38 INFO - Installing collected packages: blobuploader, requests, docopt 22:01:38 INFO - Running setup.py install for blobuploader 22:01:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:01:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:01:38 INFO - Running setup.py install for requests 22:01:39 INFO - Running setup.py install for docopt 22:01:39 INFO - Successfully installed blobuploader requests docopt 22:01:39 INFO - Cleaning up... 22:01:39 INFO - Return code: 0 22:01:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:01: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')]} 22:01:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:01:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01: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')]} 22:01:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:01:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:39 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 0x1d50030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f7f400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x200e570>, '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 0x200f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x200f900>, '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': '1f5564757af27664ca02d71f000001b0-1467779463.259547-1588527049', '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 22:01:39 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 22:01:39 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 22:01:39 INFO - Using env: {'DISPLAY': ':0', 22:01:39 INFO - 'HOME': '/home/cltbld', 22:01:39 INFO - 'LANG': 'en_US.UTF-8', 22:01:39 INFO - 'LANGUAGE': 'en_US:en', 22:01:39 INFO - 'LOGNAME': 'cltbld', 22:01:39 INFO - 'MAIL': '/var/mail/cltbld', 22:01:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:01:39 INFO - 'MOZ_NO_REMOTE': '1', 22:01:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:01:39 INFO - 'NO_EM_RESTART': '1', 22:01:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:01:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:01:39 INFO - 'PWD': '/builds/slave/test', 22:01:39 INFO - 'SHELL': '/bin/bash', 22:01:39 INFO - 'SHLVL': '1', 22:01:39 INFO - 'TERM': 'linux', 22:01:39 INFO - 'TMOUT': '86400', 22:01:39 INFO - 'USER': 'cltbld', 22:01:39 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1467779463.259547-1588527049', 22:01:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:01:39 INFO - '_': '/tools/buildbot/bin/python'} 22:01:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:01:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:01:39 INFO - Running setup.py (path:/tmp/pip-ItWRIr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:01:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:01:39 INFO - Running setup.py (path:/tmp/pip-T0vf4C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:01:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:01:39 INFO - Running setup.py (path:/tmp/pip-l0G505-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:01:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:01:39 INFO - Running setup.py (path:/tmp/pip-kVHg0Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:01:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:01:39 INFO - Running setup.py (path:/tmp/pip-GuRp04-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:01:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:01:39 INFO - Running setup.py (path:/tmp/pip-B81pOj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:01:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:01:40 INFO - Running setup.py (path:/tmp/pip-p2z13J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:01:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:01:40 INFO - Running setup.py (path:/tmp/pip-gnmcqE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:01:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:01:40 INFO - Running setup.py (path:/tmp/pip-pWumfh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:01:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:01:40 INFO - Running setup.py (path:/tmp/pip-DPLUvA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:01:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:01:40 INFO - Running setup.py (path:/tmp/pip-QpSu8j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:01:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:01:40 INFO - Running setup.py (path:/tmp/pip-6YPkqb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:01:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:01:40 INFO - Running setup.py (path:/tmp/pip-88yV4C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:01:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:01:40 INFO - Running setup.py (path:/tmp/pip-MeRu4b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:01:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:01:40 INFO - Running setup.py (path:/tmp/pip-rbTtKW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:01:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:01:40 INFO - Running setup.py (path:/tmp/pip-g95dQg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:01:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:01:40 INFO - Running setup.py (path:/tmp/pip-brjzI1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:01:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:01:40 INFO - Running setup.py install for manifestparser 22:01:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:01:40 INFO - Running setup.py install for mozcrash 22:01:40 INFO - Running setup.py install for mozdebug 22:01:41 INFO - Running setup.py install for mozdevice 22:01:41 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:01:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:01:41 INFO - Running setup.py install for mozfile 22:01:41 INFO - Running setup.py install for mozhttpd 22:01:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:01:41 INFO - Running setup.py install for mozinfo 22:01:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:01:41 INFO - Running setup.py install for mozInstall 22:01:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:01:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:01:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:01:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:01:41 INFO - Running setup.py install for mozleak 22:01:41 INFO - Running setup.py install for mozlog 22:01:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:01:41 INFO - Running setup.py install for moznetwork 22:01:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:01:41 INFO - Running setup.py install for mozprocess 22:01:42 INFO - Running setup.py install for mozprofile 22:01:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:01:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:01:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:01:42 INFO - Running setup.py install for mozrunner 22:01:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:01:42 INFO - Running setup.py install for mozscreenshot 22:01:42 INFO - Running setup.py install for moztest 22:01:42 INFO - Running setup.py install for mozversion 22:01:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:01:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:01:42 INFO - Cleaning up... 22:01:42 INFO - Return code: 0 22:01:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:01:42 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')]} 22:01:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:01:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:42 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')]} 22:01:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:01:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:42 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 0x1d50030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f7f400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x200e570>, '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 0x200f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x200f900>, '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': '1f5564757af27664ca02d71f000001b0-1467779463.259547-1588527049', '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 22:01:42 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 22:01:42 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 22:01:42 INFO - Using env: {'DISPLAY': ':0', 22:01:42 INFO - 'HOME': '/home/cltbld', 22:01:42 INFO - 'LANG': 'en_US.UTF-8', 22:01:42 INFO - 'LANGUAGE': 'en_US:en', 22:01:42 INFO - 'LOGNAME': 'cltbld', 22:01:42 INFO - 'MAIL': '/var/mail/cltbld', 22:01:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:01:42 INFO - 'MOZ_NO_REMOTE': '1', 22:01:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:01:42 INFO - 'NO_EM_RESTART': '1', 22:01:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:01:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:01:42 INFO - 'PWD': '/builds/slave/test', 22:01:42 INFO - 'SHELL': '/bin/bash', 22:01:42 INFO - 'SHLVL': '1', 22:01:42 INFO - 'TERM': 'linux', 22:01:42 INFO - 'TMOUT': '86400', 22:01:42 INFO - 'USER': 'cltbld', 22:01:42 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1467779463.259547-1588527049', 22:01:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:01:42 INFO - '_': '/tools/buildbot/bin/python'} 22:01:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:01:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:01:42 INFO - Running setup.py (path:/tmp/pip-1ss_yJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:01:42 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)) 22:01:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:01:42 INFO - Running setup.py (path:/tmp/pip-bwqGn8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:01:42 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)) 22:01:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:01:42 INFO - Running setup.py (path:/tmp/pip-llYJ23-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:01:43 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)) 22:01:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:01:43 INFO - Running setup.py (path:/tmp/pip-CL321_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:01:43 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)) 22:01:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:01:43 INFO - Running setup.py (path:/tmp/pip-0CZ1wD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:01:43 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)) 22:01:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:01:43 INFO - Running setup.py (path:/tmp/pip-XLFgDw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:01:43 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)) 22:01:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:01:43 INFO - Running setup.py (path:/tmp/pip-Ylck61-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:01:43 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)) 22:01:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:01:43 INFO - Running setup.py (path:/tmp/pip-5OmqNh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:01:43 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)) 22:01:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:01:43 INFO - Running setup.py (path:/tmp/pip-q31Fz0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:01:43 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)) 22:01:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:01:43 INFO - Running setup.py (path:/tmp/pip-rrOgg4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:01:43 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)) 22:01:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:01:43 INFO - Running setup.py (path:/tmp/pip-PhcuP0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:01:43 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)) 22:01:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:01:43 INFO - Running setup.py (path:/tmp/pip-twc_ZG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:01:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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)) 22:01:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:01:43 INFO - Running setup.py (path:/tmp/pip-gDgXRB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:01:43 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)) 22:01:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:01:43 INFO - Running setup.py (path:/tmp/pip-Gi2avn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:01:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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)) 22:01:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:01:43 INFO - Running setup.py (path:/tmp/pip-zPRlsp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:01:43 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)) 22:01:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:01:43 INFO - Running setup.py (path:/tmp/pip-FMmJ3q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:01:43 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)) 22:01:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:01:43 INFO - Running setup.py (path:/tmp/pip-6U0z9k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:01:44 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)) 22:01:44 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)) 22:01:44 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)) 22:01:44 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)) 22:01:44 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)) 22:01:44 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)) 22:01:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:01:44 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 22:01:44 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 22:01:44 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 22:01:44 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 22:01:44 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 22:01:44 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 22:01:45 INFO - Downloading blessings-1.6.tar.gz 22:01:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:01:46 INFO - Installing collected packages: blessings 22:01:46 INFO - Running setup.py install for blessings 22:01:46 INFO - Successfully installed blessings 22:01:46 INFO - Cleaning up... 22:01:46 INFO - Return code: 0 22:01:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:01:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:01:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:01:46 INFO - Reading from file tmpfile_stdout 22:01:46 INFO - Current package versions: 22:01:46 INFO - argparse == 1.2.1 22:01:46 INFO - blessings == 1.6 22:01:46 INFO - blobuploader == 1.2.4 22:01:46 INFO - docopt == 0.6.1 22:01:46 INFO - functools32 == 3.2.3-2 22:01:46 INFO - jsonschema == 2.5.1 22:01:46 INFO - manifestparser == 1.1 22:01:46 INFO - mozInstall == 1.12 22:01:46 INFO - mozcrash == 0.17 22:01:46 INFO - mozdebug == 0.1 22:01:46 INFO - mozdevice == 0.48 22:01:46 INFO - mozfile == 1.2 22:01:46 INFO - mozhttpd == 0.7 22:01:46 INFO - mozinfo == 0.9 22:01:46 INFO - mozleak == 0.1 22:01:46 INFO - mozlog == 3.2 22:01:46 INFO - moznetwork == 0.27 22:01:46 INFO - mozprocess == 0.22 22:01:46 INFO - mozprofile == 0.28 22:01:46 INFO - mozrunner == 6.11 22:01:46 INFO - mozscreenshot == 0.1 22:01:46 INFO - mozsystemmonitor == 0.3 22:01:46 INFO - moztest == 0.7 22:01:46 INFO - mozversion == 1.4 22:01:46 INFO - psutil == 3.1.1 22:01:46 INFO - requests == 1.2.3 22:01:46 INFO - wsgiref == 0.1.2 22:01:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:01:46 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')]} 22:01:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:01:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:46 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')]} 22:01:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:01:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:46 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 0x1d50030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f7f400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x200e570>, '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 0x200f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x200f900>, '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': '1f5564757af27664ca02d71f000001b0-1467779463.259547-1588527049', '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 22:01:46 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 22:01:46 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 22:01:46 INFO - Using env: {'DISPLAY': ':0', 22:01:46 INFO - 'HOME': '/home/cltbld', 22:01:46 INFO - 'LANG': 'en_US.UTF-8', 22:01:46 INFO - 'LANGUAGE': 'en_US:en', 22:01:46 INFO - 'LOGNAME': 'cltbld', 22:01:46 INFO - 'MAIL': '/var/mail/cltbld', 22:01:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:01:46 INFO - 'MOZ_NO_REMOTE': '1', 22:01:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:01:46 INFO - 'NO_EM_RESTART': '1', 22:01:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:01:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:01:46 INFO - 'PWD': '/builds/slave/test', 22:01:46 INFO - 'SHELL': '/bin/bash', 22:01:46 INFO - 'SHLVL': '1', 22:01:46 INFO - 'TERM': 'linux', 22:01:46 INFO - 'TMOUT': '86400', 22:01:46 INFO - 'USER': 'cltbld', 22:01:46 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1467779463.259547-1588527049', 22:01:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:01:46 INFO - '_': '/tools/buildbot/bin/python'} 22:01:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:01:46 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)) 22:01:46 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)) 22:01:46 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)) 22:01:46 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)) 22:01:46 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)) 22:01:46 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)) 22:01:46 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)) 22:01:46 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)) 22:01:46 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)) 22:01:46 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)) 22:01:46 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)) 22:01:46 INFO - Cleaning up... 22:01:46 INFO - Return code: 0 22:01:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:01:46 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')]} 22:01:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:01:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:46 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')]} 22:01:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:01:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:46 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 0x1d50030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f7f400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x200e570>, '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 0x200f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x200f900>, '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': '1f5564757af27664ca02d71f000001b0-1467779463.259547-1588527049', '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 22:01:46 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 22:01:46 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 22:01:46 INFO - Using env: {'DISPLAY': ':0', 22:01:46 INFO - 'HOME': '/home/cltbld', 22:01:46 INFO - 'LANG': 'en_US.UTF-8', 22:01:46 INFO - 'LANGUAGE': 'en_US:en', 22:01:46 INFO - 'LOGNAME': 'cltbld', 22:01:46 INFO - 'MAIL': '/var/mail/cltbld', 22:01:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:01:46 INFO - 'MOZ_NO_REMOTE': '1', 22:01:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:01:46 INFO - 'NO_EM_RESTART': '1', 22:01:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:01:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:01:46 INFO - 'PWD': '/builds/slave/test', 22:01:46 INFO - 'SHELL': '/bin/bash', 22:01:46 INFO - 'SHLVL': '1', 22:01:46 INFO - 'TERM': 'linux', 22:01:46 INFO - 'TMOUT': '86400', 22:01:46 INFO - 'USER': 'cltbld', 22:01:46 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1467779463.259547-1588527049', 22:01:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:01:46 INFO - '_': '/tools/buildbot/bin/python'} 22:01:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:01:46 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 22:01:46 INFO - Cleaning up... 22:01:46 INFO - Return code: 0 22:01:46 INFO - Running post-action listener: _resource_record_post_action 22:01:46 INFO - Running post-action listener: _start_resource_monitoring 22:01:46 INFO - Starting resource monitoring. 22:01:46 INFO - ##### 22:01:46 INFO - ##### Finished create-virtualenv step (success) 22:01:46 INFO - ##### 22:01:46 INFO - ##### 22:01:46 INFO - ##### Running install step. 22:01:46 INFO - ##### 22:01:46 INFO - Running pre-action listener: _resource_record_pre_action 22:01:46 INFO - Running main action method: install 22:01:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:01:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:01:47 INFO - Reading from file tmpfile_stdout 22:01:47 INFO - Detecting whether we're running mozinstall >=1.0... 22:01:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:01:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:01:47 INFO - Reading from file tmpfile_stdout 22:01:47 INFO - Output received: 22:01:47 INFO - Usage: mozinstall [options] installer 22:01:47 INFO - Options: 22:01:47 INFO - -h, --help show this help message and exit 22:01:47 INFO - -d DEST, --destination=DEST 22:01:47 INFO - Directory to install application into. [default: 22:01:47 INFO - "/builds/slave/test"] 22:01:47 INFO - --app=APP Application being installed. [default: firefox] 22:01:47 INFO - mkdir: /builds/slave/test/build/application 22:01:47 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'] 22:01:47 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 22:02:03 INFO - Reading from file tmpfile_stdout 22:02:03 INFO - Output received: 22:02:03 INFO - /builds/slave/test/build/application/firefox/firefox 22:02:03 INFO - Running post-action listener: _resource_record_post_action 22:02:03 INFO - ##### 22:02:03 INFO - ##### Finished install step (success) 22:02:03 INFO - ##### 22:02:03 INFO - ##### 22:02:03 INFO - ##### Running run-tests step. 22:02:03 INFO - ##### 22:02:03 INFO - Running pre-action listener: _resource_record_pre_action 22:02:03 INFO - Running main action method: run_tests 22:02:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:02:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:02:03 INFO - Python 2.7.3 22:02:03 INFO - Return code: 0 22:02:03 INFO - grabbing minidump binary from tooltool 22:02:03 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')]} 22:02:03 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 0x200e570>, '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 0x200f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x200f900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:02:03 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 22:02:03 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 22:02:03 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 22:02:03 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:02:03 INFO - Return code: 0 22:02:03 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:02:03 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:02:03 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:02:03 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:02:03 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:02:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NnD_MmAqRASm9rZ45wORMw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 22:02:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NnD_MmAqRASm9rZ45wORMw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-027 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 22:02:03 INFO - Using env: {'DISPLAY': ':0', 22:02:03 INFO - 'HOME': '/home/cltbld', 22:02:03 INFO - 'LANG': 'en_US.UTF-8', 22:02:03 INFO - 'LANGUAGE': 'en_US:en', 22:02:03 INFO - 'LOGNAME': 'cltbld', 22:02:03 INFO - 'MAIL': '/var/mail/cltbld', 22:02:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:02:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:02:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:02:03 INFO - 'MOZ_NO_REMOTE': '1', 22:02:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:02:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:02:03 INFO - 'NO_EM_RESTART': '1', 22:02:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:02:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:02:03 INFO - 'PWD': '/builds/slave/test', 22:02:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:02:03 INFO - 'SHELL': '/bin/bash', 22:02:03 INFO - 'SHLVL': '1', 22:02:03 INFO - 'TERM': 'linux', 22:02:03 INFO - 'TMOUT': '86400', 22:02:03 INFO - 'USER': 'cltbld', 22:02:03 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1467779463.259547-1588527049', 22:02:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:02:03 INFO - '_': '/tools/buildbot/bin/python'} 22:02:03 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NnD_MmAqRASm9rZ45wORMw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 22:02:03 INFO - mozversion application_buildid: 20160705204822 22:02:03 INFO - mozversion application_changeset: 28441ef38d799c44a4a671b39137da5544e807af 22:02:03 INFO - mozversion application_display_name: Nightly 22:02:03 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:02:03 INFO - mozversion application_name: Firefox 22:02:03 INFO - mozversion application_remotingname: firefox 22:02:03 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 22:02:03 INFO - mozversion application_vendor: Mozilla 22:02:03 INFO - mozversion application_version: 50.0a1 22:02:03 INFO - mozversion platform_buildid: 20160705204822 22:02:03 INFO - mozversion platform_changeset: 28441ef38d799c44a4a671b39137da5544e807af 22:02:03 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 22:02:03 INFO - mozversion platform_version: 50.0a1 22:02:03 INFO - using testdate: 1467781323 22:02:03 INFO - actual date: 1467781323 22:02:03 INFO - starting webserver on 'localhost:47064' 22:02:03 INFO - SUITE-START | Running 2 tests 22:02:03 INFO - TEST-START | dromaeo_css 22:02:03 INFO - operating with platform_type : linux_ 22:02:03 INFO - Initialising browser for dromaeo_css test... 22:02:03 INFO - TEST-INFO | started process 5336 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpopn3sp/profile http://localhost:47064/getInfo.html) 22:02:09 INFO - PROCESS | 5336 | __metrics Screen width/height:1600/1200 22:02:09 INFO - PROCESS | 5336 | colorDepth:24 22:02:09 INFO - PROCESS | 5336 | Browser inner width/height: 1024/697 22:02:09 INFO - PROCESS | 5336 | __metrics 22:02:09 ERROR - PROCESS | 5336 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2952: TypeError: this.tabs is undefined 22:02:10 INFO - TEST-INFO | 5336: exit 0 22:02:10 INFO - Browser initialized. 22:02:10 INFO - Running cycle 1/1 for dromaeo_css test... 22:02:10 INFO - TEST-INFO | started process 5456 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpopn3sp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:02:23 INFO - PROCESS | 5456 | RSS: Main: 170033152 22:02:23 INFO - PROCESS | 5456 | 22:03:13 INFO - PROCESS | 5456 | 1467781393021 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] 22:05:25 INFO - PROCESS | 5456 | Cycle 1(1): loaded http://localhost:47064/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47064/tests/dromaeo/cssquery-ext.html) 22:05:26 INFO - PROCESS | 5456 | RSS: Main: 173142016 22:05:26 INFO - PROCESS | 5456 | 22:08:28 INFO - PROCESS | 5456 | Cycle 1(1): loaded http://localhost:47064/tests/dromaeo/cssquery-ext.html (next: http://localhost:47064/tests/dromaeo/cssquery-jquery.html) 22:08:29 INFO - PROCESS | 5456 | RSS: Main: 169152512 22:08:29 INFO - PROCESS | 5456 | 22:11:31 INFO - PROCESS | 5456 | Cycle 1(1): loaded http://localhost:47064/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47064/tests/dromaeo/cssquery-mootools.html) 22:11:31 INFO - PROCESS | 5456 | RSS: Main: 172924928 22:11:31 INFO - PROCESS | 5456 | 22:14:33 INFO - PROCESS | 5456 | Cycle 1(1): loaded http://localhost:47064/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47064/tests/dromaeo/cssquery-prototype.html) 22:14:34 INFO - PROCESS | 5456 | RSS: Main: 167735296 22:14:34 INFO - PROCESS | 5456 | 22:17:36 INFO - PROCESS | 5456 | Cycle 1(1): loaded http://localhost:47064/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47064/tests/dromaeo/cssquery-yui.html) 22:17:37 INFO - PROCESS | 5456 | RSS: Main: 169951232 22:17:37 INFO - PROCESS | 5456 | 22:20:40 INFO - PROCESS | 5456 | Cycle 1(1): loaded http://localhost:47064/tests/dromaeo/cssquery-yui.html (next: http://localhost:47064/tests/dromaeo/cssquery-dojo.html) 22:20:40 INFO - PROCESS | 5456 | RSS: Main: 170668032 22:20:40 INFO - PROCESS | 5456 | 22:20:40 INFO - PROCESS | 5456 | __start_tp_report 22:20:40 INFO - PROCESS | 5456 | _x_x_mozilla_page_load 22:20:40 INFO - PROCESS | 5456 | _x_x_mozilla_page_load_details 22:20:40 INFO - PROCESS | 5456 | |i|pagename|runs| 22:20:40 INFO - PROCESS | 5456 | |0;dojo.html;2643.2598872315752;2693.5959606059087;2694.030149146307;2697.0425498947884;2714.7556719895206;4713.622910167182;4779.307000484928;4780.091782561315;4858.472526435516;4884.87787805305;4734.076855013273;4790.185668436366;4797.352357431746;4806.9038619227595;4820.638452116088;4406.493253275874;4437.245668236392;4498.145352383053;4527.7736113194205;4563.338315944186;460.97327321784854;4366.1922544329245;4373.409589705397;4453.51011388747;4505.279155335147;4447.466304043503;4448.888777780549;4480.932786008212;4482.753448560328;4560.543945605446;4475.932861007088;4477.77611119446;4498.3927169832305;4509.549045095464;4510.233260345749;4269.082147338306;4317.568243175689;4350.564943505656;4417.293233082692;4421.9115617687785;4751.097291514636;4765.547273009059;4794.712317260975;4796.544328288807;4799.928001079987;5029.899402011976;5125.078095714107;5126.5898728101665;5146.073706732786;5187.896242075175;5123.026624941286;5139.640225184238;5142.51146141116;5156.381234251914;5188.221766734982;4778.737169455679;4809.398825146856;4812.037592481518;4822.807087716522;4858.7570621468785;5142.768575414116;5225.9738701307015;5333;5358.169483730028;5368.624196306299;5014.724190169576;5045.369328833895;5057.165567681365;5066.518680725325;5115.437301896788;5152.124138896396;5155.304033955443;5163.612729045337;5165.9483405165465;5166.018456493254;5015.623828212899;5040.193569028937;5065.088284108896;5066.164082926276;5093.592512598983;5105.310783044316;5115.181570948705;5123.410807757081;5147.7683504242395;5167.044096842021;4402.603765661106;4414.050979039522;4414.580614841585;4462.040661257845;4478.48497422794;3775.716821238418;3777.8111094445167;3792.241551689673;3802.9429558556644;3839.1745774658584;4272.957270427318;4316.892077698083;4327.1345730853955;4334.501532323823;4385.101054283864;5196.506331898464;5226.477352264743;5235.39792923811;5250.212468129811;5252.343457067866;4209.431726716854;4274.187904298174;4329.653627709776;4348.934765978513;4404.339349097597;4647.6281897448125;4649.651276154302;4650.209464391061;4674.182018146811;4702.576768090888;4768.713877167381;4832.782524786323;4834.613230941586;4835.99999999993;4870.0746858096845;5122.871928201825;5130.461301563431;5169.53474187325;5171.172612382001;5191.558717509054;4789.209780386197;4819.831305904277;4831.251156070814;4832.057748738962;4839.370881785346;4949.802007919643;5095.26118712792;5097.668651537787;5099.872503187302;5146.716930568855;5170.121079416433;5177.068127736893;5216.452272511332;5220.556252718561;5252.763625636932;5081.060003899291;5082.872928176677;5086.618503612318;5103.132467480463;5149.407818100816;4867.853964381075;4970.627202959865;5069.467705890828;5080.034793389244;5085.542301192911;4824.710517368969;4832.033593281288;4888.902221955612;4904.2643603459765;4955.0089982004465;4995.775190116381;5058.620603454682;5075.264086707481;5076.568491678248;5117.74411279442;4847.903041939212;4961.3798275215595;4974.726390048582;5001.349824522788;5015.5736762374145 22:20:40 INFO - PROCESS | 5456 | |1;ext.html;547.7456341172684;588.4115884115885;591.2491136256951;599.7541008186643;643.5559463969863;37164;41213.58786412135;41450;41479.37780933281;41696.16607667845;40888.38667419991;41421.585784142226;41458;41482;41485.58514414855;7646.732364367248;7834.412419068564;7837.725679601215;7844.882326765103;7865.370770338388;7770.4172187085915;7858.449908506407;7878.4485086044;7890.526568405885;7919.208079192063;7851.097123830776;7917.366610671133;7963.9203607963755;7972;7978.521288722666;7799.88300175495;7869.409794265453;7897.802554936144;7916.604169791487;7946.483478573903;6049.4253045961;6051.818445446644;6107.572469927107;6116.755329786848;6122.663253521055;31488.370232595447;39321.80339098286;39627.20745585101;39716.20567588632;39737.40393894094;2975.509041008231;2993.8652760625605;3015;3088.320569474712;3492.8253587320787;29307;29385.265368365748;29674.55488167679;29903.850480747456;29970.700292997008;2891.320539673175;2963.4517614241217;2983.761299096067;3020.4865172920654;3096.2568983444035;226530;227233;229395;229650;230196.84901575552;33513;33723;33746.325073498396;33819.15452113717;33836.154096147795;35711.10722231965;36804;36815.26369472595;36901;36983.26033479315;14149.363278652485;14299.78550321746;14309.713805723828;14333.6416589584;14367.13797172173;10824.567017319376;10913.072388847037;10964.451777411097;10972.23194376386;10981.945090274497;18830.3409380671;19015.809841901682;19023.61952760937;19033.61932761337;19137.425877223704;6841.219169801509;7023.733963706799;7024.402925751267;7050.661342650362;7124.358807707331;817.2889586060165;907.7685190276569;913.3195769151891;929.8744669469535;972.1105188752213;29040;29437.705622943497;29671.703282967326;30191;30385.24036899095;961.0341606685377;985.8324084905584;1011.7217765114506;1019.2101121630648;1025.2003437318904;15623.062616243062;15634.687306254038;15854.286557104959;15932.522024339056;16136.112513811619;389990;392436;392589;393557;395652;51049.74475127675;51408.485915141115;51510.74244628828;51519;51654;1184.514349116858;1204.5964601858475;1217.9634610961684;1219.3720234079456;1234.8703386144505;27690.307742306602;29022.854885725435;29178.270543236587;29199.416011679223;29295.121146365644;43520.34719479274;43766.78116609396;43777.781111095515;43974.12051759011;44152.11695766131;335080;338797;339097;340011;340189;26040.218793436226;26296;26404.603930941437;26409;26452.20643380625;43341.566584333756;44081.77959110184;44529.77735111433;44728.77635611801;44815.55184448114;38053.23893522169;38153.236935261695;38199.04502387463;38624.42063368995;38858.639947601696;37856.810715946245;37970;38061.238775223785;38296.808515957244;38387.80806095952;36495.45256821203;37624;38403.615963840006;38722.2255554893;39954.400683990345;31425;34184.658153418146;34589.48115778215;34805.65194348024;34958;26287.60568591511;26620.600690989264;26847.597286041117;26906.32734181661;27032 22:20:40 INFO - PROCESS | 5456 | |2;jquery.html;373.7888093227328;376.9491118698976;377.2266852951449;378.57788565749166;383.8311143097037;16354.754678679828;16656.000639961596;17911.28354865807;17918.73121903171;17983.550411239725;15852.3659053638;16838.494845154666;17066.402675906345;17088;18014.369497067604;4557.589816916477;4897.510248975092;4900.730459824708;4905.141600219948;4927.901441971158;4828.106800241949;4859.052484765472;4891.364122664048;4901.950980490185;4907.8773030674165;4780.569748722614;4819.1325561398935;4834.709917404967;4840.443349014856;4853.660243782919;4832.299316599091;4845.224764037773;4868.294097355882;4879.048585525824;5224.52979231871;4834.661573689843;4843.636727245435;4856.465788763233;4868.9756551217015;4869.853904382874;21179.47051323714;21289.36131916045;21460.678089828663;21933.670994935088;22071.44821379462;1786.857051435882;1967.6261510313138;2068.555260618974;2233.352327824929;2265.8753768542724;8992.955035224848;9616.326857120004;9643.324967252294;9671.806563868684;9797.804043919154;1759.6656635239265;1762.4624489530688;1809.972850407245;1813.3653221372547;1850.3523766681687;74319;76523.6173819133;76527.23472765312;77093;77441;9894;10035.397876127456;10415.739606509745;10539.57841686324;10642.148628109733;14327.78508322376;14339.713205735827;14417.495387661382;14432.567022989328;14466.20435876037;7260.745873894389;7552.282533159341;7636.198199189116;7700.614969251627;7728.381729461629;7314.780556583205;7351.375133113638;7436.66535005926;7534.962325188449;7565.43259255547;4343.5656434356315;4430.446194225722;4499.505054444008;4540.318952157137;4567.885802854888;1799.3072667023291;1897.1273214321566;1898;1911.550785565391;1912.4645099372199;796.303234669664;839.1692224697506;905.9411138276123;911.7674992876906;941.5857022910035;17978.460646180374;18455.07724613764;18480.353187638368;18506.537336566424;18703.34538291153;875.7066382761847;887.1704955866286;900.1853322742928;913.8537833946536;942.5381563034201;10041.799164016678;10068.144207742278;10148.289619726549;10164;10268.58925642966;302196;396125;400239;400899;403749;86821;91287;91706.20497257808;92176;92373.53813230891;890.4167770110458;915.1214833759532;938.3572253006712;941.7268991992382;954.4368822394821;16412.67174656524;16498.58753531171;16780.58048548796;16963.915180424017;17268.740968885224;29315.706842931297;39599;39881.2023759529;40639.39040914448;42224.57775422207;50511;51075.23387149121;52182.47817521776;58157.41842581689;60187.69906150441;11320.26418282809;11386.202965792316;11937.582184623496;12209.877901220874;12366.62900112998;12549.874501255235;12860.871391285968;13289.601311960656;13343.866561334262;13468.259245741578;11442.141839361915;11581.652550423501;11768.70578235551;11784.41077946082;11850.822237666614;7511.586862722603;8119.228673276029;11590.246633968765;11856.17006809515;11904.583339583072;7832.255935686101;7853.09689385728;7935.365170786208;7957.323627491496;8150.103488616129;11988.580399685969;12323.630291091282;12338;12434.689132771391;12436.564720234748;11100.833487497532;11409.25839820409;11447.771044579229;11514.654560363202;11746.412679366169 22:20:40 INFO - PROCESS | 5456 | |3;mootools.html;1389.076264284251;1420.863309352518;1506.3146268447858;1671.632240907;1714.9914250428747;7147.928520714791;7705.229477052306;7767.22327767223;8223.013238411391;8235.87646185307;8031.718889838857;8033.718819841307;8084.9595752021305;8117.107118216992;8122.228388303117;2229.6544035674456;2239.294622194012;2241.8991145398495;2246.9662955055687;2247.7302723673183;2197.099189332374;2215.058600094961;2247.213475283654;2251.122062395667;2253.526759380532;2218.0351547077075;2236.944076398087;2238.418011317053;2239.2386588559884;2263.1400067974146;2183.552371763785;2188.0919418441326;2198.835087368446;2201.1415547936317;2207.9668804967937;2158.4280165756086;2194.9451263718533;2195.7804219578074;2198.8900554972347;2202.6365649667787;8100.959495202545;8158.265756081981;8159.428839981204;8170.67317307307;8181.79545511361;4676.205045142334;4723.692959957626;4744.952550474485;4770.928436073462;4778.641601879873;2921.7224363685414;3070.6622271550114;3102.689731026902;3103.1311232854837;3111.5488254203015;948.9051094890525;952.7141857442808;968.3270127261557;994.1649014827507;1023.1916785739257;11017.944910275477;11023.61417350389;11039.282446640942;11049.060829829474;11061.668149955514;4070.898227544335;4121.793910304473;4322;4438.245498265303;4447.310666846644;9485.241180705527;9528.190103841112;9533.380330278509;9559.283053770994;9591.232701383873;4833.275008748646;4861.222204447272;4874.488178741252;4891.730954797449;4892.535209155196;3837.9424308635394;4249.2563801334645;4407.405000324915;4417.2269852775635;4426.468823741107;3671.2657468506404;3674.5590529136675;3781.6029316921326;3786.413105968579;3879.592642772468;1128.041165009735;1173.2432580985387;1180.5100883133575;1181.285322379965;1192.1773975956562;726.201178703422;811.5739236900674;820.0569345252887;828.825946551231;841.4614646626164;5237.423883372826;5477;5552.444755524496;5736.856578585485;5790.478856902899;856.5246288310047;878.4641368765048;883.7127933421535;892.4020905993;946.6781294359951;3734.94397584031;3786.1670432505357;3793.1275806564645;3815.08437974884;3853.4412510185866;9860.161886239606;10065.547050382604;10189.847152292721;10207.795844083077;10218.284720069523;9737.318387712792;10051;10098;10134.797304053878;10160.644377446753;7618.200088990687;7670.041244844395;7723.806904827312;7751.147373788879;7817.296443320015;5355.598330125178;5489.725513724377;5495.945040549544;5576.191452239484;5588.133839254922;9016.323775716979;9318.207952324128;9349.626014959325;9448.527573621153;9551.283653725859;9271.814563708824;9594.568244428878;9630.903690963001;9650.903490965;9662.661806836726;6803.863922721419;6868.416184624163;7017.2631873652535;7058.188308344606;7102.467314951503;7908.4068694846965;7910.5649189295145;7933.8413231736195;7958.482698624571;8003.4797738146835;6947.096877405905;6999.09011828459;7148.892766608401;7194.244604316471;7225.169105552718;7096.183938847099;7116.252793456612;7155.42756579462;7215.60314182725;7226.783196504113;6420.775272865614;6573.474122070127;6574.178227721535;6607.07500949877;6609.372109649576;4759.309900064541;4764.547368000034;4766.1659209638865;4808.2547205183255;4816.518348165156;4811.711297322172;4822.348982887265;4827.2035114207165;4828.5412885775795;4929.13740095489 22:20:40 INFO - PROCESS | 5456 | |4;prototype.html;295.35170301188873;300.0638009410639;303.2056013245297;306.5233561811383;312.49064025638233;4947.911459478909;5044.890124172676;5096.41391240007;5162.225666150075;5184.507471790183;5089.389273287211;5102.5407713305885;5123.257127716479;5127.102757017526;5138.691678499293;4030.637242648161;4040.1111755413763;4049.521924497552;4050.534188568323;4069.532003819569;3976.443297938291;4034.0519977805193;4059.5940405959464;4069.287874621944;4088.2232375848494;3979.6418322350983;3994.940075898864;4004.5194576650842;4009.8396064157546;4014.919701605966;4005;4007.979960100181;4016.5180178378637;4020.2964481215963;4033.878983630496;3541.5750109986966;3561.287742451494;3563.6080031196548;3567.928641427157;3578.946315805265;4843.564079232886;4938.345654205846;4978.153713868651;4979.651424400294;5084.669496482754;4530.546945305443;4580.748058856761;4607.364385643082;4621.768911554409;4634.86095417138;5336.199570064483;5339.466053394668;5344.331958505187;5354.43778403266;5420.756065977001;3517.331706975692;3723.515942927402;3733.738638295293;3735.8505659773577;3857.9807100964317;5507.339119305669;5548.528375088163;5555.250041244421;5583;5600.599850037491;3814.5422549294262;3833.1375440525658;3837.328467518173;3842.9624001519433;3850.5186851643543;3730.65696349314;3868.6905047596124;3892.9805350973065;3894.2211557688574;3916.4516967624554;4457.3091170868565;4474.664400170001;4476.306172543261;4487.775611219426;4497.437820272466;5367.275417818622;5372.785088596491;5408.161734931092;5421.972890135524;5421.972890135524;1267.5943698016547;1316.6642506160867;1330.1487048289102;1333.513267657298;1335.3657012918786;878.3193025405362;885.3359980014989;896.6906417286026;896.7085697148323;907.020417948614;4464.888377790517;4489.842855500107;4496.123255965055;4496.145732310851;4563.155816174019;5517.062099443105;5523.392426833045;5533.861653458695;5537;5539.584531160099;4414.646828253732;4526.95473045272;4538.659600529973;4552.226121559343;4552.658550608718;2571.3314538220197;2579.8968041278513;2594.896204151813;2595.7923366130663;2612.6995395529757;4537.886552836139;4548.681592288508;4591.357209990604;4667.95332046682;4678.532146785295;4600.7929643166135;4863.586595139382;4937.753112344369;5030.471800460972;5043.697378157322;4536.4102666653125;4554.225781617133;4566.337881007302;4597.471290801601;4606.286025666027;4840.370751802243;4866.343043689199;4870.00164966174;4894.388201474816;4902.779374928065;4575.885602859955;4771.451283102488;4821.180399332052;4849.4908034655855;4866.80532778699;4547.8635640930825;4584.19776539111;4608.585227329557;4608.677392582621;4618.353430519797;3473.68999615253;3488.2151515908718;3494.545709057806;3531.8940431787087;3533.5583052118486;4882.218844984785;4928.778204980713;4957.752112394438;4963.602911767122;5325.9467405327005;4965.258878967536;5337.546308563816;5348.732563371894;5372.656835791052;5416.539594134542;5354.982553314858;5364.892702145858;5375.3012108425655;5397.9730101350815;5403.351597808288;5049.495050494921;5244.610178302676;5252.2646829444675;5257.631965762513;5262.079136151082;5372.489613486712;5388.6828663675;5399.9460005401015;5419.50963485029;5422.343051904617;5267.446918073547;5279.155335146358;5280.551153152025;5290.497402746733;5295.152775555893 22:20:40 INFO - PROCESS | 5456 | |5;yui.html;624.2758400255701;634.7841733810503;677.5494296292966;684.1448189762797;703.2967032967033;10931.125509959204;11145.21983461158;13905.513307034256;14706.338214780333;14740.33668484918;14910;15224.69550608987;15276.312565934531;15339.539813805575;15342.309596068177;621.4500167351904;752.1388010727713;757.613617055303;776.6000509737489;776.8951191589119;759.661950432058;762.0588573112202;762.6644276518314;764.4419573711194;766.6779952419969;811.4401063266357;813.1218284253022;817.7056259746487;818.0510607695074;818.6807145213371;806.7055524733489;807.5356669914793;808.4462143431768;808.8301456694102;809.5385630190764;594.9672767997758;595.6307089604429;595.693217992734;595.9582829201958;595.9970200149015;13087.149335293176;13178.472861085545;13218.07473476857;13219.206847589176;13223.933880330536;13307.733845323137;13655.522056728067;13688.452461901512;13753.449862005507;13864.930675346559;10128.696139115838;10274.38353698773;10552.366857988469;10860.945695271552;10894.455277236106;3121.5941927549275;3168.318811455525;3170.8097514149226;3173.508106243536;3215.581974343344;67404.3259567403;68752.65623671899;69132.654336728;69262.65368673175;69694;10652.467376631137;10661.307015043998;10696.946515267375;10697.679069627924;10966.06788422993;19539.609207815764;19635.31276405319;19655.213791448467;19752.30866919651;20014.29949951745;6941.236463988957;7018;7140.214576396592;7169.5698258104685;7212.927870721225;3790.469334293201;3892.5523564789846;3896.0454688601476;3902.1220225449047;3911.491506104245;3083.1367217179227;3193.712565869083;3212.14878057315;3212.4699424595146;3229.06357156422;506.02842542318103;510.9335786347751;513.6045245161205;516.2076213013007;522.7386306846577;560.7252446301283;566.9194057807855;591.1664552980277;591.2934043817596;594.8483136800088;7716.4212684048925;8243.917560824435;8329.750107496784;8575.271101956403;8639.870401943976;509.72220140023774;552.2186106659112;554.783634382583;571.4000299685314;585.8271809816115;3887.1642596841816;4081.428599996003;4091.161311931047;4213.97893010533;4276.893077673083;107402.46298768613;107720.4613976925;109181;109588.4520577392;114101;92801.53599231961;93296;93587.53206234062;93746.53126734322;94298.69954551558;50229.497705022484;72990.27009729834;83449.58275208584;84368;85229;7714.5756983366455;7791.766247012372;8020.278174964048;8094.231048050426;8290.295324897452;44669.55330446784;48074.519254807004;48523.75738121287;49329.50670493393;49440.752796235785;63591.364086360394;71965;72607;73299.63350183216;74696.62651686707;9686.612535498783;9769.31614786958;10090.445025523666;10328.225383096147;11233.887661123284;12248.693782655504;12415.317157556421;12778.744425111632;12810.167339122927;13267.137636053625;11168.553257869595;11718.648440546796;12125.27248365101;12403.317817520123;12404.81392779091;12200.816987745013;12226.816597751218;12303.323317217639;12476.313802740937;12796.744065118832;11211.55153793839;11668.358240296866;11798.290189514015;12163.540375155038;12568.434420450918;10188.643397481053;10252.128569071712;10279.94860025695;10324.793504129726;10861.78276434451;9951.651692190739;10452.738681533023;10721.892781072402;10899.836502452628;11081.224314297922 22:20:40 INFO - PROCESS | 5456 | __end_tp_report 22:20:40 INFO - PROCESS | 5456 | __start_cc_report 22:20:40 INFO - PROCESS | 5456 | _x_x_mozilla_cycle_collect,388 22:20:40 INFO - PROCESS | 5456 | __end_cc_report 22:20:40 INFO - PROCESS | 5456 | __startTimestamp1467782440354__endTimestamp 22:20:40 INFO - PROCESS | 5456 | 22:20:40 INFO - PROCESS | 5456 | ------- Summary: start ------- 22:20:40 INFO - PROCESS | 5456 | Number of tests: 6 22:20:40 INFO - PROCESS | 5456 | 22:20:40 INFO - PROCESS | 5456 | [#0] dojo.html Cycles:165 Average:4732.82 Median:4839.37 stddev:604.60 (12.5%) stddev-sans-first:583.81 22:20:40 INFO - PROCESS | 5456 | Values: 2643.3 2693.6 2694.0 2697.0 2714.8 4713.6 4779.3 4780.1 4858.5 4884.9 4734.1 4790.2 4797.4 4806.9 4820.6 4406.5 4437.2 4498.1 4527.8 4563.3 461.0 4366.2 4373.4 4453.5 4505.3 4447.5 4448.9 4480.9 4482.8 4560.5 4475.9 4477.8 4498.4 4509.5 4510.2 4269.1 4317.6 4350.6 4417.3 4421.9 4751.1 4765.5 4794.7 4796.5 4799.9 5029.9 5125.1 5126.6 5146.1 5187.9 5123.0 5139.6 5142.5 5156.4 5188.2 4778.7 4809.4 4812.0 4822.8 4858.8 5142.8 5226.0 5333.0 5358.2 5368.6 5014.7 5045.4 5057.2 5066.5 5115.4 5152.1 5155.3 5163.6 5165.9 5166.0 5015.6 5040.2 5065.1 5066.2 5093.6 5105.3 5115.2 5123.4 5147.8 5167.0 4402.6 4414.1 4414.6 4462.0 4478.5 3775.7 3777.8 3792.2 3802.9 3839.2 4273.0 4316.9 4327.1 4334.5 4385.1 5196.5 5226.5 5235.4 5250.2 5252.3 4209.4 4274.2 4329.7 4348.9 4404.3 4647.6 4649.7 4650.2 4674.2 4702.6 4768.7 4832.8 4834.6 4836.0 4870.1 5122.9 5130.5 5169.5 5171.2 5191.6 4789.2 4819.8 4831.3 4832.1 4839.4 4949.8 5095.3 5097.7 5099.9 5146.7 5170.1 5177.1 5216.5 5220.6 5252.8 5081.1 5082.9 5086.6 5103.1 5149.4 4867.9 4970.6 5069.5 5080.0 5085.5 4824.7 4832.0 4888.9 4904.3 4955.0 4995.8 5058.6 5075.3 5076.6 5117.7 4847.9 4961.4 4974.7 5001.3 5015.6 22:20:40 INFO - PROCESS | 5456 | 22:20:40 INFO - PROCESS | 5456 | [#1] ext.html Cycles:180 Average:47068.85 Median:37394.00 stddev:86227.54 (230.6%) stddev-sans-first:86398.68 22:20:40 INFO - PROCESS | 5456 | Values: 547.7 588.4 591.2 599.8 643.6 37164.0 41213.6 41450.0 41479.4 41696.2 40888.4 41421.6 41458.0 41482.0 41485.6 7646.7 7834.4 7837.7 7844.9 7865.4 7770.4 7858.4 7878.4 7890.5 7919.2 7851.1 7917.4 7963.9 7972.0 7978.5 7799.9 7869.4 7897.8 7916.6 7946.5 6049.4 6051.8 6107.6 6116.8 6122.7 31488.4 39321.8 39627.2 39716.2 39737.4 2975.5 2993.9 3015.0 3088.3 3492.8 29307.0 29385.3 29674.6 29903.9 29970.7 2891.3 2963.5 2983.8 3020.5 3096.3 226530.0 227233.0 229395.0 229650.0 230196.8 33513.0 33723.0 33746.3 33819.2 33836.2 35711.1 36804.0 36815.3 36901.0 36983.3 14149.4 14299.8 14309.7 14333.6 14367.1 10824.6 10913.1 10964.5 10972.2 10981.9 18830.3 19015.8 19023.6 19033.6 19137.4 6841.2 7023.7 7024.4 7050.7 7124.4 817.3 907.8 913.3 929.9 972.1 29040.0 29437.7 29671.7 30191.0 30385.2 961.0 985.8 1011.7 1019.2 1025.2 15623.1 15634.7 15854.3 15932.5 16136.1 389990.0 392436.0 392589.0 393557.0 395652.0 51049.7 51408.5 51510.7 51519.0 51654.0 1184.5 1204.6 1218.0 1219.4 1234.9 27690.3 29022.9 29178.3 29199.4 29295.1 43520.3 43766.8 43777.8 43974.1 44152.1 335080.0 338797.0 339097.0 340011.0 340189.0 26040.2 26296.0 26404.6 26409.0 26452.2 43341.6 44081.8 44529.8 44728.8 44815.6 38053.2 38153.2 38199.0 38624.4 38858.6 37856.8 37970.0 38061.2 38296.8 38387.8 36495.5 37624.0 38403.6 38722.2 39954.4 31425.0 34184.7 34589.5 34805.7 34958.0 26287.6 26620.6 26847.6 26906.3 27032.0 22:20:40 INFO - PROCESS | 5456 | 22:20:40 INFO - PROCESS | 5456 | [#2] jquery.html Cycles:180 Average:25204.02 Median:218003.10 stddev:63747.43 (29.2%) stddev-sans-first:63899.00 22:20:40 INFO - PROCESS | 5456 | Values: 373.8 376.9 377.2 378.6 383.8 16354.8 16656.0 17911.3 17918.7 17983.6 15852.4 16838.5 17066.4 17088.0 18014.4 4557.6 4897.5 4900.7 4905.1 4927.9 4828.1 4859.1 4891.4 4902.0 4907.9 4780.6 4819.1 4834.7 4840.4 4853.7 4832.3 4845.2 4868.3 4879.0 5224.5 4834.7 4843.6 4856.5 4869.0 4869.9 21179.5 21289.4 21460.7 21933.7 22071.4 1786.9 1967.6 2068.6 2233.4 2265.9 8993.0 9616.3 9643.3 9671.8 9797.8 1759.7 1762.5 1810.0 1813.4 1850.4 74319.0 76523.6 76527.2 77093.0 77441.0 9894.0 10035.4 10415.7 10539.6 10642.1 14327.8 14339.7 14417.5 14432.6 14466.2 7260.7 7552.3 7636.2 7700.6 7728.4 7314.8 7351.4 7436.7 7535.0 7565.4 4343.6 4430.4 4499.5 4540.3 4567.9 1799.3 1897.1 1898.0 1911.6 1912.5 796.3 839.2 905.9 911.8 941.6 17978.5 18455.1 18480.4 18506.5 18703.3 875.7 887.2 900.2 913.9 942.5 10041.8 10068.1 10148.3 10164.0 10268.6 302196.0 396125.0 400239.0 400899.0 403749.0 86821.0 91287.0 91706.2 92176.0 92373.5 890.4 915.1 938.4 941.7 954.4 16412.7 16498.6 16780.6 16963.9 17268.7 29315.7 39599.0 39881.2 40639.4 42224.6 50511.0 51075.2 52182.5 58157.4 60187.7 11320.3 11386.2 11937.6 12209.9 12366.6 12549.9 12860.9 13289.6 13343.9 13468.3 11442.1 11581.7 11768.7 11784.4 11850.8 7511.6 8119.2 11590.2 11856.2 11904.6 7832.3 7853.1 7935.4 7957.3 8150.1 11988.6 12323.6 12338.0 12434.7 12436.6 11100.8 11409.3 11447.8 11514.7 11746.4 22:20:40 INFO - PROCESS | 5456 | 22:20:40 INFO - PROCESS | 5456 | [#3] mootools.html Cycles:180 Average:5362.97 Median:4883.11 stddev:3022.76 (61.9%) stddev-sans-first:3016.49 22:20:40 INFO - PROCESS | 5456 | Values: 1389.1 1420.9 1506.3 1671.6 1715.0 7147.9 7705.2 7767.2 8223.0 8235.9 8031.7 8033.7 8085.0 8117.1 8122.2 2229.7 2239.3 2241.9 2247.0 2247.7 2197.1 2215.1 2247.2 2251.1 2253.5 2218.0 2236.9 2238.4 2239.2 2263.1 2183.6 2188.1 2198.8 2201.1 2208.0 2158.4 2194.9 2195.8 2198.9 2202.6 8101.0 8158.3 8159.4 8170.7 8181.8 4676.2 4723.7 4745.0 4770.9 4778.6 2921.7 3070.7 3102.7 3103.1 3111.5 948.9 952.7 968.3 994.2 1023.2 11017.9 11023.6 11039.3 11049.1 11061.7 4070.9 4121.8 4322.0 4438.2 4447.3 9485.2 9528.2 9533.4 9559.3 9591.2 4833.3 4861.2 4874.5 4891.7 4892.5 3837.9 4249.3 4407.4 4417.2 4426.5 3671.3 3674.6 3781.6 3786.4 3879.6 1128.0 1173.2 1180.5 1181.3 1192.2 726.2 811.6 820.1 828.8 841.5 5237.4 5477.0 5552.4 5736.9 5790.5 856.5 878.5 883.7 892.4 946.7 3734.9 3786.2 3793.1 3815.1 3853.4 9860.2 10065.5 10189.8 10207.8 10218.3 9737.3 10051.0 10098.0 10134.8 10160.6 7618.2 7670.0 7723.8 7751.1 7817.3 5355.6 5489.7 5495.9 5576.2 5588.1 9016.3 9318.2 9349.6 9448.5 9551.3 9271.8 9594.6 9630.9 9650.9 9662.7 6803.9 6868.4 7017.3 7058.2 7102.5 7908.4 7910.6 7933.8 7958.5 8003.5 6947.1 6999.1 7148.9 7194.2 7225.2 7096.2 7116.3 7155.4 7215.6 7226.8 6420.8 6573.5 6574.2 6607.1 6609.4 4759.3 4764.5 4766.2 4808.3 4816.5 4811.7 4822.3 4827.2 4828.5 4929.1 22:20:40 INFO - PROCESS | 5456 | 22:20:40 INFO - PROCESS | 5456 | [#4] prototype.html Cycles:180 Average:4297.02 Median:4608.63 stddev:1250.23 (27.1%) stddev-sans-first:1217.12 22:20:40 INFO - PROCESS | 5456 | Values: 295.4 300.1 303.2 306.5 312.5 4947.9 5044.9 5096.4 5162.2 5184.5 5089.4 5102.5 5123.3 5127.1 5138.7 4030.6 4040.1 4049.5 4050.5 4069.5 3976.4 4034.1 4059.6 4069.3 4088.2 3979.6 3994.9 4004.5 4009.8 4014.9 4005.0 4008.0 4016.5 4020.3 4033.9 3541.6 3561.3 3563.6 3567.9 3578.9 4843.6 4938.3 4978.2 4979.7 5084.7 4530.5 4580.7 4607.4 4621.8 4634.9 5336.2 5339.5 5344.3 5354.4 5420.8 3517.3 3723.5 3733.7 3735.9 3858.0 5507.3 5548.5 5555.3 5583.0 5600.6 3814.5 3833.1 3837.3 3843.0 3850.5 3730.7 3868.7 3893.0 3894.2 3916.5 4457.3 4474.7 4476.3 4487.8 4497.4 5367.3 5372.8 5408.2 5422.0 5422.0 1267.6 1316.7 1330.1 1333.5 1335.4 878.3 885.3 896.7 896.7 907.0 4464.9 4489.8 4496.1 4496.1 4563.2 5517.1 5523.4 5533.9 5537.0 5539.6 4414.6 4527.0 4538.7 4552.2 4552.7 2571.3 2579.9 2594.9 2595.8 2612.7 4537.9 4548.7 4591.4 4668.0 4678.5 4600.8 4863.6 4937.8 5030.5 5043.7 4536.4 4554.2 4566.3 4597.5 4606.3 4840.4 4866.3 4870.0 4894.4 4902.8 4575.9 4771.5 4821.2 4849.5 4866.8 4547.9 4584.2 4608.6 4608.7 4618.4 3473.7 3488.2 3494.5 3531.9 3533.6 4882.2 4928.8 4957.8 4963.6 5325.9 4965.3 5337.5 5348.7 5372.7 5416.5 5355.0 5364.9 5375.3 5398.0 5403.4 5049.5 5244.6 5252.3 5257.6 5262.1 5372.5 5388.7 5399.9 5419.5 5422.3 5267.4 5279.2 5280.6 5290.5 5295.2 22:20:40 INFO - PROCESS | 5456 | 22:20:40 INFO - PROCESS | 5456 | [#5] yui.html Cycles:180 Average:19071.14 Median:4245.44 stddev:28065.72 (661.1%) stddev-sans-first:28110.28 22:20:40 INFO - PROCESS | 5456 | Values: 624.3 634.8 677.5 684.1 703.3 10931.1 11145.2 13905.5 14706.3 14740.3 14910.0 15224.7 15276.3 15339.5 15342.3 621.5 752.1 757.6 776.6 776.9 759.7 762.1 762.7 764.4 766.7 811.4 813.1 817.7 818.1 818.7 806.7 807.5 808.4 808.8 809.5 595.0 595.6 595.7 596.0 596.0 13087.1 13178.5 13218.1 13219.2 13223.9 13307.7 13655.5 13688.5 13753.4 13864.9 10128.7 10274.4 10552.4 10860.9 10894.5 3121.6 3168.3 3170.8 3173.5 3215.6 67404.3 68752.7 69132.7 69262.7 69694.0 10652.5 10661.3 10696.9 10697.7 10966.1 19539.6 19635.3 19655.2 19752.3 20014.3 6941.2 7018.0 7140.2 7169.6 7212.9 3790.5 3892.6 3896.0 3902.1 3911.5 3083.1 3193.7 3212.1 3212.5 3229.1 506.0 510.9 513.6 516.2 522.7 560.7 566.9 591.2 591.3 594.8 7716.4 8243.9 8329.8 8575.3 8639.9 509.7 552.2 554.8 571.4 585.8 3887.2 4081.4 4091.2 4214.0 4276.9 107402.5 107720.5 109181.0 109588.5 114101.0 92801.5 93296.0 93587.5 93746.5 94298.7 50229.5 72990.3 83449.6 84368.0 85229.0 7714.6 7791.8 8020.3 8094.2 8290.3 44669.6 48074.5 48523.8 49329.5 49440.8 63591.4 71965.0 72607.0 73299.6 74696.6 9686.6 9769.3 10090.4 10328.2 11233.9 12248.7 12415.3 12778.7 12810.2 13267.1 11168.6 11718.6 12125.3 12403.3 12404.8 12200.8 12226.8 12303.3 12476.3 12796.7 11211.6 11668.4 11798.3 12163.5 12568.4 10188.6 10252.1 10279.9 10324.8 10861.8 9951.7 10452.7 10721.9 10899.8 11081.2 22:20:40 INFO - PROCESS | 5456 | -------- Summary: end -------- 22:20:40 INFO - PROCESS | 5456 | 22:20:41 INFO - TEST-INFO | 5456: exit 0 22:20:41 INFO - TEST-OK | dromaeo_css | took 1117468ms 22:20:41 INFO - TEST-START | kraken 22:20:41 INFO - operating with platform_type : linux_ 22:20:41 INFO - Initialising browser for kraken test... 22:20:41 INFO - TEST-INFO | started process 5704 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKeNuLz/profile http://localhost:47064/getInfo.html) 22:20:45 INFO - PROCESS | 5704 | __metrics Screen width/height:1600/1200 22:20:45 INFO - PROCESS | 5704 | colorDepth:24 22:20:45 INFO - PROCESS | 5704 | Browser inner width/height: 1024/697 22:20:45 INFO - PROCESS | 5704 | __metrics 22:20:46 ERROR - PROCESS | 5704 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2952: TypeError: this.tabs is undefined 22:20:47 INFO - TEST-INFO | 5704: exit 0 22:20:47 INFO - Browser initialized. 22:20:47 INFO - Running cycle 1/1 for kraken test... 22:20:47 INFO - TEST-INFO | started process 5825 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKeNuLz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:20:59 INFO - PROCESS | 5825 | RSS: Main: 170029056 22:20:59 INFO - PROCESS | 5825 | 22:21:01 INFO - PROCESS | 5825 | Cycle 1(1): loaded http://localhost:47064/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47064/tests/kraken/driver.html?testName=audio-beat-detection) 22:21:02 INFO - PROCESS | 5825 | RSS: Main: 175063040 22:21:02 INFO - PROCESS | 5825 | 22:21:05 INFO - PROCESS | 5825 | Cycle 1(1): loaded http://localhost:47064/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47064/tests/kraken/driver.html?testName=audio-dft) 22:21:05 INFO - PROCESS | 5825 | RSS: Main: 174759936 22:21:05 INFO - PROCESS | 5825 | 22:21:08 INFO - PROCESS | 5825 | Cycle 1(1): loaded http://localhost:47064/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47064/tests/kraken/driver.html?testName=audio-fft) 22:21:09 INFO - PROCESS | 5825 | RSS: Main: 169803776 22:21:09 INFO - PROCESS | 5825 | 22:21:11 INFO - PROCESS | 5825 | Cycle 1(1): loaded http://localhost:47064/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47064/tests/kraken/driver.html?testName=audio-oscillator) 22:21:12 INFO - PROCESS | 5825 | RSS: Main: 170602496 22:21:12 INFO - PROCESS | 5825 | 22:21:14 INFO - PROCESS | 5825 | Cycle 1(1): loaded http://localhost:47064/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47064/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:21:15 INFO - PROCESS | 5825 | RSS: Main: 170762240 22:21:15 INFO - PROCESS | 5825 | 22:21:18 INFO - PROCESS | 5825 | Cycle 1(1): loaded http://localhost:47064/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47064/tests/kraken/driver.html?testName=imaging-darkroom) 22:21:19 INFO - PROCESS | 5825 | RSS: Main: 171102208 22:21:19 INFO - PROCESS | 5825 | 22:21:22 INFO - PROCESS | 5825 | Cycle 1(1): loaded http://localhost:47064/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47064/tests/kraken/driver.html?testName=imaging-desaturate) 22:21:23 INFO - PROCESS | 5825 | RSS: Main: 168411136 22:21:23 INFO - PROCESS | 5825 | 22:21:26 INFO - PROCESS | 5825 | Cycle 1(1): loaded http://localhost:47064/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47064/tests/kraken/driver.html?testName=json-parse-financial) 22:21:26 INFO - PROCESS | 5825 | RSS: Main: 169537536 22:21:26 INFO - PROCESS | 5825 | 22:21:28 INFO - PROCESS | 5825 | Cycle 1(1): loaded http://localhost:47064/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47064/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:21:29 INFO - PROCESS | 5825 | RSS: Main: 169771008 22:21:29 INFO - PROCESS | 5825 | 22:21:30 INFO - PROCESS | 5825 | Cycle 1(1): loaded http://localhost:47064/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47064/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:21:31 INFO - PROCESS | 5825 | RSS: Main: 170610688 22:21:31 INFO - PROCESS | 5825 | 22:21:33 INFO - PROCESS | 5825 | Cycle 1(1): loaded http://localhost:47064/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47064/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:21:34 INFO - PROCESS | 5825 | RSS: Main: 170975232 22:21:34 INFO - PROCESS | 5825 | 22:21:37 INFO - PROCESS | 5825 | Cycle 1(1): loaded http://localhost:47064/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47064/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:21:37 INFO - PROCESS | 5825 | RSS: Main: 171081728 22:21:37 INFO - PROCESS | 5825 | 22:21:40 INFO - PROCESS | 5825 | Cycle 1(1): loaded http://localhost:47064/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47064/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:21:41 INFO - PROCESS | 5825 | RSS: Main: 170590208 22:21:41 INFO - PROCESS | 5825 | 22:21:43 INFO - PROCESS | 5825 | Cycle 1(1): loaded http://localhost:47064/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47064/tests/kraken/driver.html?testName=ai-astar) 22:21:43 INFO - PROCESS | 5825 | RSS: Main: 171397120 22:21:43 INFO - PROCESS | 5825 | 22:21:43 INFO - PROCESS | 5825 | __start_tp_report 22:21:43 INFO - PROCESS | 5825 | _x_x_mozilla_page_load 22:21:43 INFO - PROCESS | 5825 | _x_x_mozilla_page_load_details 22:21:43 INFO - PROCESS | 5825 | |i|pagename|runs| 22:21:43 INFO - PROCESS | 5825 | |0;ai-astar;105;114;107;113;114;120;115;114;114;113 22:21:43 INFO - PROCESS | 5825 | |1;audio-beat-detection;146;122;143;185;127;148;145;123;178;122 22:21:43 INFO - PROCESS | 5825 | |2;audio-dft;164;162;161;164;176;165;161;162;162;161 22:21:43 INFO - PROCESS | 5825 | |3;audio-fft;75;77;75;151;77;76;76;76;161;76 22:21:43 INFO - PROCESS | 5825 | |4;audio-oscillator;86;85;141;86;85;86;128;86;87;139 22:21:43 INFO - PROCESS | 5825 | |5;imaging-gaussian-blur;122;118;117;118;117;118;117;125;118;119 22:21:43 INFO - PROCESS | 5825 | |6;imaging-darkroom;148;148;148;148;147;147;148;148;147;147 22:21:43 INFO - PROCESS | 5825 | |7;imaging-desaturate;96;96;95;96;97;96;95;97;97;96 22:21:43 INFO - PROCESS | 5825 | |8;json-parse-financial;65;66;64;65;65;65;64;66;65;64 22:21:43 INFO - PROCESS | 5825 | |9;json-stringify-tinderbox;64;64;65;64;64;64;64;65;65;64 22:21:43 INFO - PROCESS | 5825 | |10;stanford-crypto-aes;81;79;82;84;78;79;79;80;84;77 22:21:43 INFO - PROCESS | 5825 | |11;stanford-crypto-ccm;147;130;132;140;129;130;138;142;170;129 22:21:43 INFO - PROCESS | 5825 | |12;stanford-crypto-pbkdf2;171;165;163;166;168;167;166;166;169;165 22:21:43 INFO - PROCESS | 5825 | |13;stanford-crypto-sha256-iterative;68;69;69;71;70;68;68;67;68;65 22:21:43 INFO - PROCESS | 5825 | __end_tp_report 22:21:43 INFO - PROCESS | 5825 | __start_cc_report 22:21:43 INFO - PROCESS | 5825 | _x_x_mozilla_cycle_collect,1003 22:21:43 INFO - PROCESS | 5825 | __end_cc_report 22:21:43 INFO - PROCESS | 5825 | __startTimestamp1467782503395__endTimestamp 22:21:43 INFO - PROCESS | 5825 | 22:21:43 INFO - PROCESS | 5825 | ------- Summary: start ------- 22:21:43 INFO - PROCESS | 5825 | Number of tests: 14 22:21:43 INFO - PROCESS | 5825 | 22:21:43 INFO - PROCESS | 5825 | [#0] ai-astar Cycles:10 Average:112.90 Median:114.00 stddev:4.18 (3.7%) stddev-sans-first:3.31 22:21:43 INFO - PROCESS | 5825 | Values: 105.0 114.0 107.0 113.0 114.0 120.0 115.0 114.0 114.0 113.0 22:21:43 INFO - PROCESS | 5825 | 22:21:43 INFO - PROCESS | 5825 | [#1] audio-beat-detection Cycles:10 Average:143.90 Median:145.50 stddev:22.50 (15.5%) stddev-sans-first:23.85 22:21:43 INFO - PROCESS | 5825 | Values: 146.0 122.0 143.0 185.0 127.0 148.0 145.0 123.0 178.0 122.0 22:21:43 INFO - PROCESS | 5825 | 22:21:43 INFO - PROCESS | 5825 | [#2] audio-dft Cycles:10 Average:163.80 Median:163.00 stddev:4.52 (2.8%) stddev-sans-first:4.79 22:21:43 INFO - PROCESS | 5825 | Values: 164.0 162.0 161.0 164.0 176.0 165.0 161.0 162.0 162.0 161.0 22:21:43 INFO - PROCESS | 5825 | 22:21:43 INFO - PROCESS | 5825 | [#3] audio-fft Cycles:10 Average:92.00 Median:76.00 stddev:33.82 (44.5%) stddev-sans-first:35.31 22:21:43 INFO - PROCESS | 5825 | Values: 75.0 77.0 75.0 151.0 77.0 76.0 76.0 76.0 161.0 76.0 22:21:43 INFO - PROCESS | 5825 | 22:21:43 INFO - PROCESS | 5825 | [#4] audio-oscillator Cycles:10 Average:100.90 Median:86.00 stddev:24.45 (28.4%) stddev-sans-first:25.33 22:21:43 INFO - PROCESS | 5825 | Values: 86.0 85.0 141.0 86.0 85.0 86.0 128.0 86.0 87.0 139.0 22:21:43 INFO - PROCESS | 5825 | 22:21:43 INFO - PROCESS | 5825 | [#5] imaging-gaussian-blur Cycles:10 Average:118.90 Median:118.00 stddev:2.60 (2.2%) stddev-sans-first:2.51 22:21:43 INFO - PROCESS | 5825 | Values: 122.0 118.0 117.0 118.0 117.0 118.0 117.0 125.0 118.0 119.0 22:21:43 INFO - PROCESS | 5825 | 22:21:43 INFO - PROCESS | 5825 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:148.00 stddev:0.52 (0.3%) stddev-sans-first:0.53 22:21:43 INFO - PROCESS | 5825 | Values: 148.0 148.0 148.0 148.0 147.0 147.0 148.0 148.0 147.0 147.0 22:21:43 INFO - PROCESS | 5825 | 22:21:43 INFO - PROCESS | 5825 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.74 (0.8%) stddev-sans-first:0.78 22:21:43 INFO - PROCESS | 5825 | Values: 96.0 96.0 95.0 96.0 97.0 96.0 95.0 97.0 97.0 96.0 22:21:43 INFO - PROCESS | 5825 | 22:21:43 INFO - PROCESS | 5825 | [#8] json-parse-financial Cycles:10 Average:64.90 Median:65.00 stddev:0.74 (1.1%) stddev-sans-first:0.78 22:21:43 INFO - PROCESS | 5825 | Values: 65.0 66.0 64.0 65.0 65.0 65.0 64.0 66.0 65.0 64.0 22:21:43 INFO - PROCESS | 5825 | 22:21:43 INFO - PROCESS | 5825 | [#9] json-stringify-tinderbox Cycles:10 Average:64.30 Median:64.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 22:21:43 INFO - PROCESS | 5825 | Values: 64.0 64.0 65.0 64.0 64.0 64.0 64.0 65.0 65.0 64.0 22:21:43 INFO - PROCESS | 5825 | 22:21:43 INFO - PROCESS | 5825 | [#10] stanford-crypto-aes Cycles:10 Average:80.30 Median:80.50 stddev:2.41 (3.0%) stddev-sans-first:2.54 22:21:43 INFO - PROCESS | 5825 | Values: 81.0 79.0 82.0 84.0 78.0 79.0 79.0 80.0 84.0 77.0 22:21:43 INFO - PROCESS | 5825 | 22:21:43 INFO - PROCESS | 5825 | [#11] stanford-crypto-ccm Cycles:10 Average:138.70 Median:139.00 stddev:12.68 (9.1%) stddev-sans-first:13.08 22:21:43 INFO - PROCESS | 5825 | Values: 147.0 130.0 132.0 140.0 129.0 130.0 138.0 142.0 170.0 129.0 22:21:43 INFO - PROCESS | 5825 | 22:21:43 INFO - PROCESS | 5825 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.60 Median:166.50 stddev:2.27 (1.4%) stddev-sans-first:1.76 22:21:43 INFO - PROCESS | 5825 | Values: 171.0 165.0 163.0 166.0 168.0 167.0 166.0 166.0 169.0 165.0 22:21:43 INFO - PROCESS | 5825 | 22:21:43 INFO - PROCESS | 5825 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.30 Median:68.50 stddev:1.64 (2.4%) stddev-sans-first:1.73 22:21:43 INFO - PROCESS | 5825 | Values: 68.0 69.0 69.0 71.0 70.0 68.0 68.0 67.0 68.0 65.0 22:21:43 INFO - PROCESS | 5825 | -------- Summary: end -------- 22:21:43 INFO - PROCESS | 5825 | 22:21:44 INFO - TEST-INFO | 5825: exit 0 22:21:44 INFO - TEST-OK | kraken | took 63236ms 22:21:44 INFO - SUITE-END | took 1180s 22:21:44 INFO - Completed test suite (00:19:40) 22:21:44 INFO - javascript benchmark 22:21:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6550.409469431231, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2643.2598872315752, 2693.5959606059087, 2694.030149146307, 2697.0425498947884, 2714.7556719895206, 4713.622910167182, 4779.307000484928, 4780.091782561315, 4858.472526435516, 4884.87787805305, 4734.076855013273, 4790.185668436366, 4797.352357431746, 4806.9038619227595, 4820.638452116088, 4406.493253275874, 4437.245668236392, 4498.145352383053, 4527.7736113194205, 4563.338315944186, 460.97327321784854, 4366.1922544329245, 4373.409589705397, 4453.51011388747, 4505.279155335147, 4447.466304043503, 4448.888777780549, 4480.932786008212, 4482.753448560328, 4560.543945605446, 4475.932861007088, 4477.77611119446, 4498.3927169832305, 4509.549045095464, 4510.233260345749, 4269.082147338306, 4317.568243175689, 4350.564943505656, 4417.293233082692, 4421.9115617687785, 4751.097291514636, 4765.547273009059, 4794.712317260975, 4796.544328288807, 4799.928001079987, 5029.899402011976, 5125.078095714107, 5126.5898728101665, 5146.073706732786, 5187.896242075175, 5123.026624941286, 5139.640225184238, 5142.51146141116, 5156.381234251914, 5188.221766734982, 4778.737169455679, 4809.398825146856, 4812.037592481518, 4822.807087716522, 4858.7570621468785, 5142.768575414116, 5225.9738701307015, 5333.0, 5358.169483730028, 5368.624196306299, 5014.724190169576, 5045.369328833895, 5057.165567681365, 5066.518680725325, 5115.437301896788, 5152.124138896396, 5155.304033955443, 5163.612729045337, 5165.9483405165465, 5166.018456493254, 5015.623828212899, 5040.193569028937, 5065.088284108896, 5066.164082926276, 5093.592512598983, 5105.310783044316, 5115.181570948705, 5123.410807757081, 5147.7683504242395, 5167.044096842021, 4402.603765661106, 4414.050979039522, 4414.580614841585, 4462.040661257845, 4478.48497422794, 3775.716821238418, 3777.8111094445167, 3792.241551689673, 3802.9429558556644, 3839.1745774658584, 4272.957270427318, 4316.892077698083, 4327.1345730853955, 4334.501532323823, 4385.101054283864, 5196.506331898464, 5226.477352264743, 5235.39792923811, 5250.212468129811, 5252.343457067866, 4209.431726716854, 4274.187904298174, 4329.653627709776, 4348.934765978513, 4404.339349097597, 4647.6281897448125, 4649.651276154302, 4650.209464391061, 4674.182018146811, 4702.576768090888, 4768.713877167381, 4832.782524786323, 4834.613230941586, 4835.99999999993, 4870.0746858096845, 5122.871928201825, 5130.461301563431, 5169.53474187325, 5171.172612382001, 5191.558717509054, 4789.209780386197, 4819.831305904277, 4831.251156070814, 4832.057748738962, 4839.370881785346, 4949.802007919643, 5095.26118712792, 5097.668651537787, 5099.872503187302, 5146.716930568855, 5170.121079416433, 5177.068127736893, 5216.452272511332, 5220.556252718561, 5252.763625636932, 5081.060003899291, 5082.872928176677, 5086.618503612318, 5103.132467480463, 5149.407818100816, 4867.853964381075, 4970.627202959865, 5069.467705890828, 5080.034793389244, 5085.542301192911, 4824.710517368969, 4832.033593281288, 4888.902221955612, 4904.2643603459765, 4955.0089982004465, 4995.775190116381, 5058.620603454682, 5075.264086707481, 5076.568491678248, 5117.74411279442, 4847.903041939212, 4961.3798275215595, 4974.726390048582, 5001.349824522788, 5015.5736762374145], "value": 4696.174339556596, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [547.7456341172684, 588.4115884115885, 591.2491136256951, 599.7541008186643, 643.5559463969863, 37164.0, 41213.58786412135, 41450.0, 41479.37780933281, 41696.16607667845, 40888.38667419991, 41421.585784142226, 41458.0, 41482.0, 41485.58514414855, 7646.732364367248, 7834.412419068564, 7837.725679601215, 7844.882326765103, 7865.370770338388, 7770.4172187085915, 7858.449908506407, 7878.4485086044, 7890.526568405885, 7919.208079192063, 7851.097123830776, 7917.366610671133, 7963.9203607963755, 7972.0, 7978.521288722666, 7799.88300175495, 7869.409794265453, 7897.802554936144, 7916.604169791487, 7946.483478573903, 6049.4253045961, 6051.818445446644, 6107.572469927107, 6116.755329786848, 6122.663253521055, 31488.370232595447, 39321.80339098286, 39627.20745585101, 39716.20567588632, 39737.40393894094, 2975.509041008231, 2993.8652760625605, 3015.0, 3088.320569474712, 3492.8253587320787, 29307.0, 29385.265368365748, 29674.55488167679, 29903.850480747456, 29970.700292997008, 2891.320539673175, 2963.4517614241217, 2983.761299096067, 3020.4865172920654, 3096.2568983444035, 226530.0, 227233.0, 229395.0, 229650.0, 230196.84901575552, 33513.0, 33723.0, 33746.325073498396, 33819.15452113717, 33836.154096147795, 35711.10722231965, 36804.0, 36815.26369472595, 36901.0, 36983.26033479315, 14149.363278652485, 14299.78550321746, 14309.713805723828, 14333.6416589584, 14367.13797172173, 10824.567017319376, 10913.072388847037, 10964.451777411097, 10972.23194376386, 10981.945090274497, 18830.3409380671, 19015.809841901682, 19023.61952760937, 19033.61932761337, 19137.425877223704, 6841.219169801509, 7023.733963706799, 7024.402925751267, 7050.661342650362, 7124.358807707331, 817.2889586060165, 907.7685190276569, 913.3195769151891, 929.8744669469535, 972.1105188752213, 29040.0, 29437.705622943497, 29671.703282967326, 30191.0, 30385.24036899095, 961.0341606685377, 985.8324084905584, 1011.7217765114506, 1019.2101121630648, 1025.2003437318904, 15623.062616243062, 15634.687306254038, 15854.286557104959, 15932.522024339056, 16136.112513811619, 389990.0, 392436.0, 392589.0, 393557.0, 395652.0, 51049.74475127675, 51408.485915141115, 51510.74244628828, 51519.0, 51654.0, 1184.514349116858, 1204.5964601858475, 1217.9634610961684, 1219.3720234079456, 1234.8703386144505, 27690.307742306602, 29022.854885725435, 29178.270543236587, 29199.416011679223, 29295.121146365644, 43520.34719479274, 43766.78116609396, 43777.781111095515, 43974.12051759011, 44152.11695766131, 335080.0, 338797.0, 339097.0, 340011.0, 340189.0, 26040.218793436226, 26296.0, 26404.603930941437, 26409.0, 26452.20643380625, 43341.566584333756, 44081.77959110184, 44529.77735111433, 44728.77635611801, 44815.55184448114, 38053.23893522169, 38153.236935261695, 38199.04502387463, 38624.42063368995, 38858.639947601696, 37856.810715946245, 37970.0, 38061.238775223785, 38296.808515957244, 38387.80806095952, 36495.45256821203, 37624.0, 38403.615963840006, 38722.2255554893, 39954.400683990345, 31425.0, 34184.658153418146, 34589.48115778215, 34805.65194348024, 34958.0, 26287.60568591511, 26620.600690989264, 26847.597286041117, 26906.32734181661, 27032.0], "value": 17317.830863160147, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [373.7888093227328, 376.9491118698976, 377.2266852951449, 378.57788565749166, 383.8311143097037, 16354.754678679828, 16656.000639961596, 17911.28354865807, 17918.73121903171, 17983.550411239725, 15852.3659053638, 16838.494845154666, 17066.402675906345, 17088.0, 18014.369497067604, 4557.589816916477, 4897.510248975092, 4900.730459824708, 4905.141600219948, 4927.901441971158, 4828.106800241949, 4859.052484765472, 4891.364122664048, 4901.950980490185, 4907.8773030674165, 4780.569748722614, 4819.1325561398935, 4834.709917404967, 4840.443349014856, 4853.660243782919, 4832.299316599091, 4845.224764037773, 4868.294097355882, 4879.048585525824, 5224.52979231871, 4834.661573689843, 4843.636727245435, 4856.465788763233, 4868.9756551217015, 4869.853904382874, 21179.47051323714, 21289.36131916045, 21460.678089828663, 21933.670994935088, 22071.44821379462, 1786.857051435882, 1967.6261510313138, 2068.555260618974, 2233.352327824929, 2265.8753768542724, 8992.955035224848, 9616.326857120004, 9643.324967252294, 9671.806563868684, 9797.804043919154, 1759.6656635239265, 1762.4624489530688, 1809.972850407245, 1813.3653221372547, 1850.3523766681687, 74319.0, 76523.6173819133, 76527.23472765312, 77093.0, 77441.0, 9894.0, 10035.397876127456, 10415.739606509745, 10539.57841686324, 10642.148628109733, 14327.78508322376, 14339.713205735827, 14417.495387661382, 14432.567022989328, 14466.20435876037, 7260.745873894389, 7552.282533159341, 7636.198199189116, 7700.614969251627, 7728.381729461629, 7314.780556583205, 7351.375133113638, 7436.66535005926, 7534.962325188449, 7565.43259255547, 4343.5656434356315, 4430.446194225722, 4499.505054444008, 4540.318952157137, 4567.885802854888, 1799.3072667023291, 1897.1273214321566, 1898.0, 1911.550785565391, 1912.4645099372199, 796.303234669664, 839.1692224697506, 905.9411138276123, 911.7674992876906, 941.5857022910035, 17978.460646180374, 18455.07724613764, 18480.353187638368, 18506.537336566424, 18703.34538291153, 875.7066382761847, 887.1704955866286, 900.1853322742928, 913.8537833946536, 942.5381563034201, 10041.799164016678, 10068.144207742278, 10148.289619726549, 10164.0, 10268.58925642966, 302196.0, 396125.0, 400239.0, 400899.0, 403749.0, 86821.0, 91287.0, 91706.20497257808, 92176.0, 92373.53813230891, 890.4167770110458, 915.1214833759532, 938.3572253006712, 941.7268991992382, 954.4368822394821, 16412.67174656524, 16498.58753531171, 16780.58048548796, 16963.915180424017, 17268.740968885224, 29315.706842931297, 39599.0, 39881.2023759529, 40639.39040914448, 42224.57775422207, 50511.0, 51075.23387149121, 52182.47817521776, 58157.41842581689, 60187.69906150441, 11320.26418282809, 11386.202965792316, 11937.582184623496, 12209.877901220874, 12366.62900112998, 12549.874501255235, 12860.871391285968, 13289.601311960656, 13343.866561334262, 13468.259245741578, 11442.141839361915, 11581.652550423501, 11768.70578235551, 11784.41077946082, 11850.822237666614, 7511.586862722603, 8119.228673276029, 11590.246633968765, 11856.17006809515, 11904.583339583072, 7832.255935686101, 7853.09689385728, 7935.365170786208, 7957.323627491496, 8150.103488616129, 11988.580399685969, 12323.630291091282, 12338.0, 12434.689132771391, 12436.564720234748, 11100.833487497532, 11409.25839820409, 11447.771044579229, 11514.654560363202, 11746.412679366169], "value": 8597.888403885267, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1389.076264284251, 1420.863309352518, 1506.3146268447858, 1671.632240907, 1714.9914250428747, 7147.928520714791, 7705.229477052306, 7767.22327767223, 8223.013238411391, 8235.87646185307, 8031.718889838857, 8033.718819841307, 8084.9595752021305, 8117.107118216992, 8122.228388303117, 2229.6544035674456, 2239.294622194012, 2241.8991145398495, 2246.9662955055687, 2247.7302723673183, 2197.099189332374, 2215.058600094961, 2247.213475283654, 2251.122062395667, 2253.526759380532, 2218.0351547077075, 2236.944076398087, 2238.418011317053, 2239.2386588559884, 2263.1400067974146, 2183.552371763785, 2188.0919418441326, 2198.835087368446, 2201.1415547936317, 2207.9668804967937, 2158.4280165756086, 2194.9451263718533, 2195.7804219578074, 2198.8900554972347, 2202.6365649667787, 8100.959495202545, 8158.265756081981, 8159.428839981204, 8170.67317307307, 8181.79545511361, 4676.205045142334, 4723.692959957626, 4744.952550474485, 4770.928436073462, 4778.641601879873, 2921.7224363685414, 3070.6622271550114, 3102.689731026902, 3103.1311232854837, 3111.5488254203015, 948.9051094890525, 952.7141857442808, 968.3270127261557, 994.1649014827507, 1023.1916785739257, 11017.944910275477, 11023.61417350389, 11039.282446640942, 11049.060829829474, 11061.668149955514, 4070.898227544335, 4121.793910304473, 4322.0, 4438.245498265303, 4447.310666846644, 9485.241180705527, 9528.190103841112, 9533.380330278509, 9559.283053770994, 9591.232701383873, 4833.275008748646, 4861.222204447272, 4874.488178741252, 4891.730954797449, 4892.535209155196, 3837.9424308635394, 4249.2563801334645, 4407.405000324915, 4417.2269852775635, 4426.468823741107, 3671.2657468506404, 3674.5590529136675, 3781.6029316921326, 3786.413105968579, 3879.592642772468, 1128.041165009735, 1173.2432580985387, 1180.5100883133575, 1181.285322379965, 1192.1773975956562, 726.201178703422, 811.5739236900674, 820.0569345252887, 828.825946551231, 841.4614646626164, 5237.423883372826, 5477.0, 5552.444755524496, 5736.856578585485, 5790.478856902899, 856.5246288310047, 878.4641368765048, 883.7127933421535, 892.4020905993, 946.6781294359951, 3734.94397584031, 3786.1670432505357, 3793.1275806564645, 3815.08437974884, 3853.4412510185866, 9860.161886239606, 10065.547050382604, 10189.847152292721, 10207.795844083077, 10218.284720069523, 9737.318387712792, 10051.0, 10098.0, 10134.797304053878, 10160.644377446753, 7618.200088990687, 7670.041244844395, 7723.806904827312, 7751.147373788879, 7817.296443320015, 5355.598330125178, 5489.725513724377, 5495.945040549544, 5576.191452239484, 5588.133839254922, 9016.323775716979, 9318.207952324128, 9349.626014959325, 9448.527573621153, 9551.283653725859, 9271.814563708824, 9594.568244428878, 9630.903690963001, 9650.903490965, 9662.661806836726, 6803.863922721419, 6868.416184624163, 7017.2631873652535, 7058.188308344606, 7102.467314951503, 7908.4068694846965, 7910.5649189295145, 7933.8413231736195, 7958.482698624571, 8003.4797738146835, 6947.096877405905, 6999.09011828459, 7148.892766608401, 7194.244604316471, 7225.169105552718, 7096.183938847099, 7116.252793456612, 7155.42756579462, 7215.60314182725, 7226.783196504113, 6420.775272865614, 6573.474122070127, 6574.178227721535, 6607.07500949877, 6609.372109649576, 4759.309900064541, 4764.547368000034, 4766.1659209638865, 4808.2547205183255, 4816.518348165156, 4811.711297322172, 4822.348982887265, 4827.2035114207165, 4828.5412885775795, 4929.13740095489], "value": 4297.5620259504085, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [295.35170301188873, 300.0638009410639, 303.2056013245297, 306.5233561811383, 312.49064025638233, 4947.911459478909, 5044.890124172676, 5096.41391240007, 5162.225666150075, 5184.507471790183, 5089.389273287211, 5102.5407713305885, 5123.257127716479, 5127.102757017526, 5138.691678499293, 4030.637242648161, 4040.1111755413763, 4049.521924497552, 4050.534188568323, 4069.532003819569, 3976.443297938291, 4034.0519977805193, 4059.5940405959464, 4069.287874621944, 4088.2232375848494, 3979.6418322350983, 3994.940075898864, 4004.5194576650842, 4009.8396064157546, 4014.919701605966, 4005.0, 4007.979960100181, 4016.5180178378637, 4020.2964481215963, 4033.878983630496, 3541.5750109986966, 3561.287742451494, 3563.6080031196548, 3567.928641427157, 3578.946315805265, 4843.564079232886, 4938.345654205846, 4978.153713868651, 4979.651424400294, 5084.669496482754, 4530.546945305443, 4580.748058856761, 4607.364385643082, 4621.768911554409, 4634.86095417138, 5336.199570064483, 5339.466053394668, 5344.331958505187, 5354.43778403266, 5420.756065977001, 3517.331706975692, 3723.515942927402, 3733.738638295293, 3735.8505659773577, 3857.9807100964317, 5507.339119305669, 5548.528375088163, 5555.250041244421, 5583.0, 5600.599850037491, 3814.5422549294262, 3833.1375440525658, 3837.328467518173, 3842.9624001519433, 3850.5186851643543, 3730.65696349314, 3868.6905047596124, 3892.9805350973065, 3894.2211557688574, 3916.4516967624554, 4457.3091170868565, 4474.664400170001, 4476.306172543261, 4487.775611219426, 4497.437820272466, 5367.275417818622, 5372.785088596491, 5408.161734931092, 5421.972890135524, 5421.972890135524, 1267.5943698016547, 1316.6642506160867, 1330.1487048289102, 1333.513267657298, 1335.3657012918786, 878.3193025405362, 885.3359980014989, 896.6906417286026, 896.7085697148323, 907.020417948614, 4464.888377790517, 4489.842855500107, 4496.123255965055, 4496.145732310851, 4563.155816174019, 5517.062099443105, 5523.392426833045, 5533.861653458695, 5537.0, 5539.584531160099, 4414.646828253732, 4526.95473045272, 4538.659600529973, 4552.226121559343, 4552.658550608718, 2571.3314538220197, 2579.8968041278513, 2594.896204151813, 2595.7923366130663, 2612.6995395529757, 4537.886552836139, 4548.681592288508, 4591.357209990604, 4667.95332046682, 4678.532146785295, 4600.7929643166135, 4863.586595139382, 4937.753112344369, 5030.471800460972, 5043.697378157322, 4536.4102666653125, 4554.225781617133, 4566.337881007302, 4597.471290801601, 4606.286025666027, 4840.370751802243, 4866.343043689199, 4870.00164966174, 4894.388201474816, 4902.779374928065, 4575.885602859955, 4771.451283102488, 4821.180399332052, 4849.4908034655855, 4866.80532778699, 4547.8635640930825, 4584.19776539111, 4608.585227329557, 4608.677392582621, 4618.353430519797, 3473.68999615253, 3488.2151515908718, 3494.545709057806, 3531.8940431787087, 3533.5583052118486, 4882.218844984785, 4928.778204980713, 4957.752112394438, 4963.602911767122, 5325.9467405327005, 4965.258878967536, 5337.546308563816, 5348.732563371894, 5372.656835791052, 5416.539594134542, 5354.982553314858, 5364.892702145858, 5375.3012108425655, 5397.9730101350815, 5403.351597808288, 5049.495050494921, 5244.610178302676, 5252.2646829444675, 5257.631965762513, 5262.079136151082, 5372.489613486712, 5388.6828663675, 5399.9460005401015, 5419.50963485029, 5422.343051904617, 5267.446918073547, 5279.155335146358, 5280.551153152025, 5290.497402746733, 5295.152775555893], "value": 3899.205626406713, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [624.2758400255701, 634.7841733810503, 677.5494296292966, 684.1448189762797, 703.2967032967033, 10931.125509959204, 11145.21983461158, 13905.513307034256, 14706.338214780333, 14740.33668484918, 14910.0, 15224.69550608987, 15276.312565934531, 15339.539813805575, 15342.309596068177, 621.4500167351904, 752.1388010727713, 757.613617055303, 776.6000509737489, 776.8951191589119, 759.661950432058, 762.0588573112202, 762.6644276518314, 764.4419573711194, 766.6779952419969, 811.4401063266357, 813.1218284253022, 817.7056259746487, 818.0510607695074, 818.6807145213371, 806.7055524733489, 807.5356669914793, 808.4462143431768, 808.8301456694102, 809.5385630190764, 594.9672767997758, 595.6307089604429, 595.693217992734, 595.9582829201958, 595.9970200149015, 13087.149335293176, 13178.472861085545, 13218.07473476857, 13219.206847589176, 13223.933880330536, 13307.733845323137, 13655.522056728067, 13688.452461901512, 13753.449862005507, 13864.930675346559, 10128.696139115838, 10274.38353698773, 10552.366857988469, 10860.945695271552, 10894.455277236106, 3121.5941927549275, 3168.318811455525, 3170.8097514149226, 3173.508106243536, 3215.581974343344, 67404.3259567403, 68752.65623671899, 69132.654336728, 69262.65368673175, 69694.0, 10652.467376631137, 10661.307015043998, 10696.946515267375, 10697.679069627924, 10966.06788422993, 19539.609207815764, 19635.31276405319, 19655.213791448467, 19752.30866919651, 20014.29949951745, 6941.236463988957, 7018.0, 7140.214576396592, 7169.5698258104685, 7212.927870721225, 3790.469334293201, 3892.5523564789846, 3896.0454688601476, 3902.1220225449047, 3911.491506104245, 3083.1367217179227, 3193.712565869083, 3212.14878057315, 3212.4699424595146, 3229.06357156422, 506.02842542318103, 510.9335786347751, 513.6045245161205, 516.2076213013007, 522.7386306846577, 560.7252446301283, 566.9194057807855, 591.1664552980277, 591.2934043817596, 594.8483136800088, 7716.4212684048925, 8243.917560824435, 8329.750107496784, 8575.271101956403, 8639.870401943976, 509.72220140023774, 552.2186106659112, 554.783634382583, 571.4000299685314, 585.8271809816115, 3887.1642596841816, 4081.428599996003, 4091.161311931047, 4213.97893010533, 4276.893077673083, 107402.46298768613, 107720.4613976925, 109181.0, 109588.4520577392, 114101.0, 92801.53599231961, 93296.0, 93587.53206234062, 93746.53126734322, 94298.69954551558, 50229.497705022484, 72990.27009729834, 83449.58275208584, 84368.0, 85229.0, 7714.5756983366455, 7791.766247012372, 8020.278174964048, 8094.231048050426, 8290.295324897452, 44669.55330446784, 48074.519254807004, 48523.75738121287, 49329.50670493393, 49440.752796235785, 63591.364086360394, 71965.0, 72607.0, 73299.63350183216, 74696.62651686707, 9686.612535498783, 9769.31614786958, 10090.445025523666, 10328.225383096147, 11233.887661123284, 12248.693782655504, 12415.317157556421, 12778.744425111632, 12810.167339122927, 13267.137636053625, 11168.553257869595, 11718.648440546796, 12125.27248365101, 12403.317817520123, 12404.81392779091, 12200.816987745013, 12226.816597751218, 12303.323317217639, 12476.313802740937, 12796.744065118832, 11211.55153793839, 11668.358240296866, 11798.290189514015, 12163.540375155038, 12568.434420450918, 10188.643397481053, 10252.128569071712, 10279.94860025695, 10324.793504129726, 10861.78276434451, 9951.651692190739, 10452.738681533023, 10721.892781072402, 10899.836502452628, 11081.224314297922], "value": 6741.17776665242, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1559.1999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 114.0, 107.0, 113.0, 114.0, 120.0, 115.0, 114.0, 114.0, 113.0], "value": 112.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 122.0, 143.0, 185.0, 127.0, 148.0, 145.0, 123.0, 178.0, 122.0], "value": 143.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 162.0, 161.0, 164.0, 176.0, 165.0, 161.0, 162.0, 162.0, 161.0], "value": 163.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 75.0, 151.0, 77.0, 76.0, 76.0, 76.0, 161.0, 76.0], "value": 92.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 141.0, 86.0, 85.0, 86.0, 128.0, 86.0, 87.0, 139.0], "value": 100.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 118.0, 117.0, 118.0, 117.0, 118.0, 117.0, 125.0, 118.0, 119.0], "value": 118.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 148.0, 148.0, 147.0, 147.0, 148.0, 148.0, 147.0, 147.0], "value": 147.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 96.0, 97.0, 96.0, 95.0, 97.0, 97.0, 96.0], "value": 96.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 64.0, 65.0, 65.0, 65.0, 64.0, 66.0, 65.0, 64.0], "value": 64.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 65.0, 64.0, 64.0, 64.0, 64.0, 65.0, 65.0, 64.0], "value": 64.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 79.0, 82.0, 84.0, 78.0, 79.0, 79.0, 80.0, 84.0, 77.0], "value": 80.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 130.0, 132.0, 140.0, 129.0, 130.0, 138.0, 142.0, 170.0, 129.0], "value": 138.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 165.0, 163.0, 166.0, 168.0, 167.0, 166.0, 166.0, 169.0, 165.0], "value": 166.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 69.0, 71.0, 70.0, 68.0, 68.0, 67.0, 68.0, 65.0], "value": 68.3, "unit": "score"}]}]} 22:21:44 INFO - Return code: 0 22:21:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:21:44 ERROR - # TBPL SUCCESS # 22:21:44 INFO - Running post-action listener: _resource_record_post_action 22:21:44 INFO - ##### 22:21:44 INFO - ##### Finished run-tests step (success) 22:21:44 INFO - ##### 22:21:44 INFO - Running post-run listener: _resource_record_post_run 22:21:44 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 499712; Write bytes: 303525888; Read time: 260; Write time: 240776 22:21:44 INFO - TinderboxPrint: CPU usage
13.3% 22:21:44 INFO - TinderboxPrint: I/O read bytes / time
499,712 / 260 22:21:44 INFO - TinderboxPrint: I/O write bytes / time
303,525,888 / 240,776 22:21:44 INFO - TinderboxPrint: CPU idle
8,276.3 (86.6%) 22:21:44 INFO - TinderboxPrint: CPU user
1,223.4 (12.8%) 22:21:44 INFO - TinderboxPrint: Swap in / out
0 / 0 22:21:44 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 19636224; Read time: 0; Write time: 15292 22:21:44 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 495616; Write bytes: 283889664; Read time: 252; Write time: 225484 22:21:45 INFO - Running post-run listener: _upload_blobber_files 22:21:45 INFO - Blob upload gear active. 22:21:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:21:45 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 22:21:45 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', 'Autoland-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 22:21:45 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 Autoland-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 22:21:45 INFO - (blobuploader) - INFO - Open directory for files ... 22:21:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:21:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:21:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:21:49 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:21:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:21:49 INFO - (blobuploader) - INFO - Done attempting. 22:21:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 22:21:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:21:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:21:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 22:21:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:21:50 INFO - (blobuploader) - INFO - Done attempting. 22:21:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 22:21:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:21:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:21:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 22:21:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:21:51 INFO - (blobuploader) - INFO - Done attempting. 22:21:51 INFO - (blobuploader) - INFO - Iteration through files over. 22:21:51 INFO - Return code: 0 22:21:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:21:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:21:51 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/63218870ad1dbc59ac0b0f04227e15df49ed1f905d22c617be5ebc9680e4f91eaaae815792ba58040a6ca80b9300005ac0e8c8621a8b41b185b84cfb953311cb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/d1bb4dc5f9bd29375ae90703302da0c4be22a16dc07c6d8a7d613ac0b03e92597d2845dfe51223e1fd47e87b2c5a774ca5a1dd6d75eabcb0ea6681d2d341f4a4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/a59e6845b1b0d144a0fb85886ea15415319f94f43efc3e6502b65beef3a75bb5b575fcfc4d43765971010b9f4c73e495e215d66845947c22d5b5cddae14226c6"} 22:21:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:21:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:21:51 INFO - Contents: 22:21:51 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/63218870ad1dbc59ac0b0f04227e15df49ed1f905d22c617be5ebc9680e4f91eaaae815792ba58040a6ca80b9300005ac0e8c8621a8b41b185b84cfb953311cb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/d1bb4dc5f9bd29375ae90703302da0c4be22a16dc07c6d8a7d613ac0b03e92597d2845dfe51223e1fd47e87b2c5a774ca5a1dd6d75eabcb0ea6681d2d341f4a4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/a59e6845b1b0d144a0fb85886ea15415319f94f43efc3e6502b65beef3a75bb5b575fcfc4d43765971010b9f4c73e495e215d66845947c22d5b5cddae14226c6"} 22:21:51 INFO - Running post-run listener: copy_logs_to_upload_dir 22:21:51 INFO - Copying logs to upload dir... 22:21:51 INFO - mkdir: /builds/slave/test/build/upload/logs 22:21:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.781543 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-07-05 22:21:51.040051) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-05 22:21:51.043466) ========= 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=1f5564757af27664ca02d71f000001b0-1467779463.259547-1588527049 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/63218870ad1dbc59ac0b0f04227e15df49ed1f905d22c617be5ebc9680e4f91eaaae815792ba58040a6ca80b9300005ac0e8c8621a8b41b185b84cfb953311cb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/d1bb4dc5f9bd29375ae90703302da0c4be22a16dc07c6d8a7d613ac0b03e92597d2845dfe51223e1fd47e87b2c5a774ca5a1dd6d75eabcb0ea6681d2d341f4a4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/a59e6845b1b0d144a0fb85886ea15415319f94f43efc3e6502b65beef3a75bb5b575fcfc4d43765971010b9f4c73e495e215d66845947c22d5b5cddae14226c6"} build_url:https://queue.taskcluster.net/v1/task/NnD_MmAqRASm9rZ45wORMw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011254 build_url: 'https://queue.taskcluster.net/v1/task/NnD_MmAqRASm9rZ45wORMw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/63218870ad1dbc59ac0b0f04227e15df49ed1f905d22c617be5ebc9680e4f91eaaae815792ba58040a6ca80b9300005ac0e8c8621a8b41b185b84cfb953311cb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/d1bb4dc5f9bd29375ae90703302da0c4be22a16dc07c6d8a7d613ac0b03e92597d2845dfe51223e1fd47e87b2c5a774ca5a1dd6d75eabcb0ea6681d2d341f4a4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/a59e6845b1b0d144a0fb85886ea15415319f94f43efc3e6502b65beef3a75bb5b575fcfc4d43765971010b9f4c73e495e215d66845947c22d5b5cddae14226c6"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-05 22:21:51.072429) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 22:21:51.072951) ========= 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=1f5564757af27664ca02d71f000001b0-1467779463.259547-1588527049 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004336 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 22:21:51.157060) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-05 22:21:51.157399) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-05 22:21:51.157924) ========= ========= Total master_lag: 0.18 =========