builder: autoland_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-001 starttime: 1468902534.03 results: success (0) buildid: 20160718183003 builduid: cedfb4ab810141a3be462076187b24da revision: 9edae2531988223eb282ec0995eb736fd0fb8762 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-18 21:28:54.034753) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-18 21:28:54.035308) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-18 21:28:54.035637) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-18 21:28:54.051543) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 21:28:54.051922) ========= 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=8887e36bb8e381bfd44124ac000001a8-1468902532.252852-13128552 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-18 21:28:54-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.5M=0s 2016-07-18 21:28:54 (42.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.151968 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 21:28:54.223031) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 21:28:54.223860) ========= 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=8887e36bb8e381bfd44124ac000001a8-1468902532.252852-13128552 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014694 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 21:28:54.275892) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-18 21:28:54.276288) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 9edae2531988223eb282ec0995eb736fd0fb8762 --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 9edae2531988223eb282ec0995eb736fd0fb8762 --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=8887e36bb8e381bfd44124ac000001a8-1468902532.252852-13128552 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-18 21:28:54,454 truncating revision to first 12 chars 2016-07-18 21:28:54,454 Setting DEBUG logging. 2016-07-18 21:28:54,455 attempt 1/10 2016-07-18 21:28:54,455 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/9edae2531988?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-18 21:28:55,124 unpacking tar archive at: autoland-9edae2531988/testing/mozharness/ program finished with exit code 0 elapsedTime=0.995071 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-18 21:28:55.288994) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-18 21:28:55.289477) ========= script_repo_revision: 9edae2531988223eb282ec0995eb736fd0fb8762 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-18 21:28:55.289958) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-18 21:28:55.290271) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-18 21:28:55.302331) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-07-18 21:28:55.302796) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] 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=8887e36bb8e381bfd44124ac000001a8-1468902532.252852-13128552 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:28:55 INFO - MultiFileLogger online at 20160718 21:28:55 in /builds/slave/test 21:28:55 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 21:28:55 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:28:55 INFO - {'append_to_log': False, 21:28:55 INFO - 'base_work_dir': '/builds/slave/test', 21:28:55 INFO - 'blob_upload_branch': 'Autoland', 21:28:55 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:28:55 INFO - 'branch': 'Autoland', 21:28:55 INFO - 'buildbot_json_path': 'buildprops.json', 21:28:55 INFO - 'config_files': ('talos/linux_config.py',), 21:28:55 INFO - 'default_actions': ('clobber', 21:28:55 INFO - 'read-buildbot-config', 21:28:55 INFO - 'download-and-extract', 21:28:55 INFO - 'populate-webroot', 21:28:55 INFO - 'create-virtualenv', 21:28:55 INFO - 'install', 21:28:55 INFO - 'run-tests'), 21:28:55 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:28:55 INFO - 'download_minidump_stackwalk': True, 21:28:55 INFO - 'download_symbols': 'ondemand', 21:28:55 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:28:55 INFO - 'tooltool.py': '/tools/tooltool.py', 21:28:55 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:28:55 INFO - '/tools/misc-python/virtualenv.py')}, 21:28:55 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:28:55 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:28:55 INFO - 'installer_path': 'installer.exe', 21:28:55 INFO - 'log_level': 'info', 21:28:55 INFO - 'log_name': 'talos', 21:28:55 INFO - 'log_to_console': True, 21:28:55 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:28:55 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:28:55 INFO - 'opt_config_files': (), 21:28:55 INFO - 'pip_index': False, 21:28:55 INFO - 'sps_profile': False, 21:28:55 INFO - 'sps_profile_interval': 0, 21:28:55 INFO - 'suite': 'dromaeojs-e10s', 21:28:55 INFO - 'system_bits': '32', 21:28:55 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:28:55 INFO - 'title': 'talos-linux64-ix-001', 21:28:55 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:28:55 INFO - 'use_talos_json': True, 21:28:55 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:28:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:28:55 INFO - 'work_dir': 'build'} 21:28:55 INFO - ##### 21:28:55 INFO - ##### Running clobber step. 21:28:55 INFO - ##### 21:28:55 INFO - Running pre-action listener: _resource_record_pre_action 21:28:55 INFO - Running main action method: clobber 21:28:55 INFO - rmtree: /builds/slave/test/build 21:28:55 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:28:56 INFO - Running post-action listener: _resource_record_post_action 21:28:56 INFO - ##### 21:28:56 INFO - ##### Finished clobber step (success) 21:28:56 INFO - ##### 21:28:56 INFO - ##### 21:28:56 INFO - ##### Running read-buildbot-config step. 21:28:56 INFO - ##### 21:28:56 INFO - Running pre-action listener: _resource_record_pre_action 21:28:56 INFO - Running main action method: read_buildbot_config 21:28:56 INFO - Using buildbot properties: 21:28:56 INFO - { 21:28:56 INFO - "project": "", 21:28:56 INFO - "product": "firefox", 21:28:56 INFO - "script_repo_revision": "production", 21:28:56 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs-e10s", 21:28:56 INFO - "repository": "", 21:28:56 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland pgo talos dromaeojs-e10s", 21:28:56 INFO - "buildid": "20160718183003", 21:28:56 INFO - "pgo_build": "True", 21:28:56 INFO - "basedir": "/builds/slave/test", 21:28:56 INFO - "buildnumber": 41, 21:28:56 INFO - "slavename": "talos-linux64-ix-001", 21:28:56 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 21:28:56 INFO - "platform": "ubuntu64_hw", 21:28:56 INFO - "scheduler": "tests-autoland-linux64-pgo-talos", 21:28:56 INFO - "branch": "autoland", 21:28:56 INFO - "repo_path": "integration/autoland", 21:28:56 INFO - "revision": "9edae2531988223eb282ec0995eb736fd0fb8762", 21:28:56 INFO - "stage_platform": "linux64-pgo", 21:28:56 INFO - "builduid": "cedfb4ab810141a3be462076187b24da", 21:28:56 INFO - "slavebuilddir": "test" 21:28:56 INFO - } 21:28:56 INFO - Found installer url https://queue.taskcluster.net/v1/task/TZsXsryWQjaUWglIXBpiAQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 21:28:56 INFO - Running post-action listener: _resource_record_post_action 21:28:56 INFO - ##### 21:28:56 INFO - ##### Finished read-buildbot-config step (success) 21:28:56 INFO - ##### 21:28:56 INFO - ##### 21:28:56 INFO - ##### Running download-and-extract step. 21:28:56 INFO - ##### 21:28:56 INFO - Running pre-action listener: _resource_record_pre_action 21:28:56 INFO - Running main action method: download_and_extract 21:28:56 INFO - mkdir: /builds/slave/test/build/tests 21:28:56 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')]} 21:28:56 INFO - https://queue.taskcluster.net/v1/task/TZsXsryWQjaUWglIXBpiAQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 21:28:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TZsXsryWQjaUWglIXBpiAQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 21:28:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TZsXsryWQjaUWglIXBpiAQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 21:28:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TZsXsryWQjaUWglIXBpiAQ/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 21:28:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TZsXsryWQjaUWglIXBpiAQ/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 21:28:56 INFO - Downloaded 1361 bytes. 21:28:56 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 21:28:56 INFO - Using the following test package requirements: 21:28:56 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 21:28:56 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 21:28:56 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:28:56 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 21:28:56 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 21:28:56 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 21:28:56 INFO - u'jsshell-linux-x86_64.zip'], 21:28:56 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 21:28:56 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:28:56 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 21:28:56 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 21:28:56 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:28:56 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 21:28:56 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:28:56 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 21:28:56 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:28:56 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 21:28:56 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:28:56 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:28:56 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')]} 21:28:56 INFO - https://queue.taskcluster.net/v1/task/TZsXsryWQjaUWglIXBpiAQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:28:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TZsXsryWQjaUWglIXBpiAQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 21:28:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TZsXsryWQjaUWglIXBpiAQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 21:28:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TZsXsryWQjaUWglIXBpiAQ/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 21:28:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TZsXsryWQjaUWglIXBpiAQ/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 21:28:57 INFO - Downloaded 24336217 bytes. 21:28:57 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'] 21:28:57 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 21:28:59 INFO - Return code: 0 21:28:59 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 21:28:59 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')]} 21:28:59 INFO - https://queue.taskcluster.net/v1/task/TZsXsryWQjaUWglIXBpiAQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:28:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TZsXsryWQjaUWglIXBpiAQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 21:28:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TZsXsryWQjaUWglIXBpiAQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 21:28:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TZsXsryWQjaUWglIXBpiAQ/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 21:28:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TZsXsryWQjaUWglIXBpiAQ/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 21:29:00 INFO - Downloaded 24336217 bytes. 21:29:00 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'] 21:29:00 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 21:29:01 INFO - Return code: 0 21:29:01 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')]} 21:29:01 INFO - https://queue.taskcluster.net/v1/task/TZsXsryWQjaUWglIXBpiAQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 21:29:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TZsXsryWQjaUWglIXBpiAQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 21:29:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TZsXsryWQjaUWglIXBpiAQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 21:29:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TZsXsryWQjaUWglIXBpiAQ/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 21:29:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TZsXsryWQjaUWglIXBpiAQ/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 21:29:02 INFO - Downloaded 14403317 bytes. 21:29:02 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'] 21:29:02 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 21:29:02 INFO - Return code: 0 21:29:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:29:02 INFO - https://queue.taskcluster.net/v1/task/TZsXsryWQjaUWglIXBpiAQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 21:29:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TZsXsryWQjaUWglIXBpiAQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 21:29:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TZsXsryWQjaUWglIXBpiAQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 21:29:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TZsXsryWQjaUWglIXBpiAQ/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 21:29:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TZsXsryWQjaUWglIXBpiAQ/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 21:29:04 INFO - Downloaded 60866904 bytes. 21:29:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TZsXsryWQjaUWglIXBpiAQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 21:29:04 INFO - mkdir: /builds/slave/test/properties 21:29:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:29:04 INFO - Writing to file /builds/slave/test/properties/build_url 21:29:04 INFO - Contents: 21:29:04 INFO - build_url:https://queue.taskcluster.net/v1/task/TZsXsryWQjaUWglIXBpiAQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 21:29:04 INFO - Running post-action listener: _resource_record_post_action 21:29:04 INFO - Running post-action listener: set_extra_try_arguments 21:29:04 INFO - ##### 21:29:04 INFO - ##### Finished download-and-extract step (success) 21:29:04 INFO - ##### 21:29:04 INFO - ##### 21:29:04 INFO - ##### Running populate-webroot step. 21:29:04 INFO - ##### 21:29:04 INFO - Running pre-action listener: _resource_record_pre_action 21:29:04 INFO - Running main action method: populate_webroot 21:29:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:29:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:29:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:29:04 INFO - '--tppagecycles', 21:29:04 INFO - '7'], 21:29:04 INFO - 'tests': ['tsvgm']}}, 21:29:04 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:29:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:29:04 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:29:04 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:29:04 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:29:04 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:29:04 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:29:04 INFO - 'talos_options': ['--disable-e10s'], 21:29:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:29:04 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:29:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:29:04 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:29:04 INFO - 'talos_options': ['--disable-e10s'], 21:29:04 INFO - 'tests': ['damp', 'tps']}, 21:29:04 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:29:04 INFO - 'tests': ['damp', 'tps']}, 21:29:04 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:29:04 INFO - 'tests': ['dromaeo_dom']}, 21:29:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:29:04 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:29:04 INFO - 'tests': ['basic_compositor_video']}, 21:29:04 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:29:04 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:29:04 INFO - 'tests': ['a11yr', 21:29:04 INFO - 'ts_paint', 21:29:04 INFO - 'tpaint', 21:29:04 INFO - 'sessionrestore', 21:29:04 INFO - 'sessionrestore_no_auto_restore', 21:29:04 INFO - 'tabpaint']}, 21:29:04 INFO - 'other-e10s': {'tests': ['a11yr', 21:29:04 INFO - 'ts_paint', 21:29:04 INFO - 'tpaint', 21:29:04 INFO - 'sessionrestore', 21:29:04 INFO - 'sessionrestore_no_auto_restore', 21:29:04 INFO - 'tabpaint']}, 21:29:04 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:29:04 INFO - 'ts_paint', 21:29:04 INFO - 'tpaint', 21:29:04 INFO - 'sessionrestore', 21:29:04 INFO - 'sessionrestore_no_auto_restore', 21:29:04 INFO - 'tabpaint']}, 21:29:04 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:29:04 INFO - 'ts_paint', 21:29:04 INFO - 'tpaint', 21:29:04 INFO - 'sessionrestore', 21:29:04 INFO - 'sessionrestore_no_auto_restore', 21:29:04 INFO - 'tabpaint']}, 21:29:04 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:29:04 INFO - 'tests': ['a11yr', 21:29:04 INFO - 'ts_paint', 21:29:04 INFO - 'tpaint', 21:29:04 INFO - 'sessionrestore', 21:29:04 INFO - 'sessionrestore_no_auto_restore', 21:29:04 INFO - 'tabpaint']}, 21:29:04 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:29:04 INFO - 'tests': ['a11yr', 21:29:04 INFO - 'ts_paint', 21:29:04 INFO - 'tpaint', 21:29:04 INFO - 'sessionrestore', 21:29:04 INFO - 'sessionrestore_no_auto_restore', 21:29:04 INFO - 'tabpaint']}, 21:29:04 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:29:04 INFO - 'tests': ['tsvgx', 21:29:04 INFO - 'tsvgr_opacity', 21:29:04 INFO - 'tart', 21:29:04 INFO - 'tscrollx', 21:29:04 INFO - 'cart']}, 21:29:04 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:29:04 INFO - 'tsvgr_opacity', 21:29:04 INFO - 'tart', 21:29:04 INFO - 'tscrollx', 21:29:04 INFO - 'cart']}, 21:29:04 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:29:04 INFO - 'talos_options': ['--disable-e10s'], 21:29:04 INFO - 'tests': ['tp5o']}, 21:29:04 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:29:04 INFO - 'tests': ['tp5o']}, 21:29:04 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:29:04 INFO - 'talos_options': ['--disable-e10s', 21:29:04 INFO - '--xperf_path', 21:29:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:29:04 INFO - 'tests': ['tp5n']}, 21:29:04 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:29:04 INFO - 'talos_options': ['--xperf_path', 21:29:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:29:04 INFO - 'tests': ['tp5n']}}, 21:29:04 INFO - 'talos.zip': {'path': '', 21:29:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:29:04 INFO - Running post-action listener: _resource_record_post_action 21:29:04 INFO - ##### 21:29:04 INFO - ##### Finished populate-webroot step (success) 21:29:04 INFO - ##### 21:29:04 INFO - ##### 21:29:04 INFO - ##### Running create-virtualenv step. 21:29:04 INFO - ##### 21:29:04 INFO - Running pre-action listener: _resource_record_pre_action 21:29:04 INFO - Running main action method: create_virtualenv 21:29:04 INFO - Creating virtualenv /builds/slave/test/build/venv 21:29:04 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 21:29:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:29:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:29:05 INFO - Using real prefix '/usr' 21:29:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:29:05 INFO - Installing distribute.............................................................................................................................................................................................done. 21:29:07 INFO - Installing pip.................done. 21:29:07 INFO - Return code: 0 21:29:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:29:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:29:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:29:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:29:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:29:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:29:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:29:07 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 0x1425030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16e6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e43b0>, '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 0x16e52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16e5740>, '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': '8887e36bb8e381bfd44124ac000001a8-1468902532.252852-13128552', '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 21:29:07 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 21:29:07 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 21:29:07 INFO - Using env: {'DISPLAY': ':0', 21:29:07 INFO - 'HOME': '/home/cltbld', 21:29:07 INFO - 'LANG': 'en_US.UTF-8', 21:29:07 INFO - 'LANGUAGE': 'en_US:en', 21:29:07 INFO - 'LOGNAME': 'cltbld', 21:29:07 INFO - 'MAIL': '/var/mail/cltbld', 21:29:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:29:07 INFO - 'MOZ_NO_REMOTE': '1', 21:29:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:29:07 INFO - 'NO_EM_RESTART': '1', 21:29:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:29:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:29:07 INFO - 'PWD': '/builds/slave/test', 21:29:07 INFO - 'SHELL': '/bin/bash', 21:29:07 INFO - 'SHLVL': '1', 21:29:07 INFO - 'TERM': 'linux', 21:29:07 INFO - 'TMOUT': '86400', 21:29:07 INFO - 'USER': 'cltbld', 21:29:07 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1468902532.252852-13128552', 21:29:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:29:07 INFO - '_': '/tools/buildbot/bin/python'} 21:29:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:29:07 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 21:29:07 INFO - Cleaning up... 21:29:07 INFO - Return code: 0 21:29:07 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:29:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:29:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:29:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:29:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:29:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:29:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:29:07 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 0x1425030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16e6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e43b0>, '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 0x16e52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16e5740>, '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': '8887e36bb8e381bfd44124ac000001a8-1468902532.252852-13128552', '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 21:29:07 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 21:29:07 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 21:29:07 INFO - Using env: {'DISPLAY': ':0', 21:29:07 INFO - 'HOME': '/home/cltbld', 21:29:07 INFO - 'LANG': 'en_US.UTF-8', 21:29:07 INFO - 'LANGUAGE': 'en_US:en', 21:29:07 INFO - 'LOGNAME': 'cltbld', 21:29:07 INFO - 'MAIL': '/var/mail/cltbld', 21:29:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:29:07 INFO - 'MOZ_NO_REMOTE': '1', 21:29:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:29:07 INFO - 'NO_EM_RESTART': '1', 21:29:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:29:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:29:07 INFO - 'PWD': '/builds/slave/test', 21:29:07 INFO - 'SHELL': '/bin/bash', 21:29:07 INFO - 'SHLVL': '1', 21:29:07 INFO - 'TERM': 'linux', 21:29:07 INFO - 'TMOUT': '86400', 21:29:07 INFO - 'USER': 'cltbld', 21:29:07 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1468902532.252852-13128552', 21:29:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:29:07 INFO - '_': '/tools/buildbot/bin/python'} 21:29:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:29:07 INFO - Downloading/unpacking psutil>=3.1.1 21:29:07 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 21:29:07 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 21:29:07 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 21:29:07 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 21:29:07 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 21:29:07 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 21:29:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:29:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:29:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:29:09 INFO - Installing collected packages: psutil 21:29:09 INFO - Running setup.py install for psutil 21:29:10 INFO - building 'psutil._psutil_linux' extension 21:29:10 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 21:29:10 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 21:29:10 INFO - building 'psutil._psutil_posix' extension 21:29:10 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 21:29:10 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 21:29:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:29:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:29:10 INFO - Successfully installed psutil 21:29:10 INFO - Cleaning up... 21:29:10 INFO - Return code: 0 21:29:10 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:29: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')]} 21:29:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:29:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:29: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')]} 21:29:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:29:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:29:10 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 0x1425030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16e6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e43b0>, '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 0x16e52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16e5740>, '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': '8887e36bb8e381bfd44124ac000001a8-1468902532.252852-13128552', '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 21:29:10 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 21:29:10 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 21:29:10 INFO - Using env: {'DISPLAY': ':0', 21:29:10 INFO - 'HOME': '/home/cltbld', 21:29:10 INFO - 'LANG': 'en_US.UTF-8', 21:29:10 INFO - 'LANGUAGE': 'en_US:en', 21:29:10 INFO - 'LOGNAME': 'cltbld', 21:29:10 INFO - 'MAIL': '/var/mail/cltbld', 21:29:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:29:10 INFO - 'MOZ_NO_REMOTE': '1', 21:29:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:29:10 INFO - 'NO_EM_RESTART': '1', 21:29:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:29:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:29:10 INFO - 'PWD': '/builds/slave/test', 21:29:10 INFO - 'SHELL': '/bin/bash', 21:29:10 INFO - 'SHLVL': '1', 21:29:10 INFO - 'TERM': 'linux', 21:29:10 INFO - 'TMOUT': '86400', 21:29:10 INFO - 'USER': 'cltbld', 21:29:10 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1468902532.252852-13128552', 21:29:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:29:10 INFO - '_': '/tools/buildbot/bin/python'} 21:29:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:29:10 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:29:10 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 21:29:10 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 21:29:10 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 21:29:10 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 21:29:10 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 21:29:10 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 21:29:12 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:29:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:29:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:29:12 INFO - Installing collected packages: mozsystemmonitor 21:29:12 INFO - Running setup.py install for mozsystemmonitor 21:29:12 INFO - Successfully installed mozsystemmonitor 21:29:12 INFO - Cleaning up... 21:29:12 INFO - Return code: 0 21:29:12 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:29:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:29:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:29:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:29:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:29:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:29:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:29:12 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 0x1425030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16e6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e43b0>, '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 0x16e52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16e5740>, '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': '8887e36bb8e381bfd44124ac000001a8-1468902532.252852-13128552', '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 21:29:12 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 21:29:12 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 21:29:12 INFO - Using env: {'DISPLAY': ':0', 21:29:12 INFO - 'HOME': '/home/cltbld', 21:29:12 INFO - 'LANG': 'en_US.UTF-8', 21:29:12 INFO - 'LANGUAGE': 'en_US:en', 21:29:12 INFO - 'LOGNAME': 'cltbld', 21:29:12 INFO - 'MAIL': '/var/mail/cltbld', 21:29:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:29:12 INFO - 'MOZ_NO_REMOTE': '1', 21:29:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:29:12 INFO - 'NO_EM_RESTART': '1', 21:29:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:29:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:29:12 INFO - 'PWD': '/builds/slave/test', 21:29:12 INFO - 'SHELL': '/bin/bash', 21:29:12 INFO - 'SHLVL': '1', 21:29:12 INFO - 'TERM': 'linux', 21:29:12 INFO - 'TMOUT': '86400', 21:29:12 INFO - 'USER': 'cltbld', 21:29:12 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1468902532.252852-13128552', 21:29:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:29:12 INFO - '_': '/tools/buildbot/bin/python'} 21:29:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:29:13 INFO - Downloading/unpacking jsonschema==2.5.1 21:29:13 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 21:29:13 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 21:29:13 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 21:29:13 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 21:29:13 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 21:29:13 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 21:29:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:29:14 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:29:14 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 21:29:14 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 21:29:14 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 21:29:14 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 21:29:14 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 21:29:14 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 21:29:15 INFO - Downloading functools32-3.2.3-2.tar.gz 21:29:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:29:15 INFO - warning: no files found matching '*.txt' 21:29:15 INFO - no previously-included directories found matching 'build' 21:29:15 INFO - no previously-included directories found matching 'dist' 21:29:15 INFO - no previously-included directories found matching '.git*' 21:29:15 INFO - Installing collected packages: jsonschema, functools32 21:29:15 INFO - Running setup.py install for functools32 21:29:15 INFO - warning: no files found matching '*.txt' 21:29:15 INFO - no previously-included directories found matching 'build' 21:29:15 INFO - no previously-included directories found matching 'dist' 21:29:15 INFO - no previously-included directories found matching '.git*' 21:29:15 INFO - Successfully installed jsonschema functools32 21:29:15 INFO - Cleaning up... 21:29:15 INFO - Return code: 0 21:29:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:29:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:29:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:29:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:29:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:29:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:29:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:29:15 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 0x1425030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16e6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e43b0>, '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 0x16e52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16e5740>, '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': '8887e36bb8e381bfd44124ac000001a8-1468902532.252852-13128552', '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 21:29:15 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 21:29:15 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 21:29:15 INFO - Using env: {'DISPLAY': ':0', 21:29:15 INFO - 'HOME': '/home/cltbld', 21:29:15 INFO - 'LANG': 'en_US.UTF-8', 21:29:15 INFO - 'LANGUAGE': 'en_US:en', 21:29:15 INFO - 'LOGNAME': 'cltbld', 21:29:15 INFO - 'MAIL': '/var/mail/cltbld', 21:29:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:29:15 INFO - 'MOZ_NO_REMOTE': '1', 21:29:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:29:15 INFO - 'NO_EM_RESTART': '1', 21:29:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:29:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:29:15 INFO - 'PWD': '/builds/slave/test', 21:29:15 INFO - 'SHELL': '/bin/bash', 21:29:15 INFO - 'SHLVL': '1', 21:29:15 INFO - 'TERM': 'linux', 21:29:15 INFO - 'TMOUT': '86400', 21:29:15 INFO - 'USER': 'cltbld', 21:29:15 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1468902532.252852-13128552', 21:29:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:29:15 INFO - '_': '/tools/buildbot/bin/python'} 21:29:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:29:15 INFO - Downloading/unpacking blobuploader==1.2.4 21:29:15 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 21:29:15 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 21:29:15 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 21:29:15 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 21:29:15 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 21:29:15 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 21:29:17 INFO - Downloading blobuploader-1.2.4.tar.gz 21:29:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:29:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:29:17 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 21:29:17 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 21:29:17 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 21:29:17 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 21:29:17 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 21:29:17 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 21:29:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:29:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:29:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:29:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:29:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:29:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:29:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:29:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:29:18 INFO - Downloading docopt-0.6.1.tar.gz 21:29:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:29:18 INFO - Installing collected packages: blobuploader, requests, docopt 21:29:18 INFO - Running setup.py install for blobuploader 21:29:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:29:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:29:18 INFO - Running setup.py install for requests 21:29:18 INFO - Running setup.py install for docopt 21:29:18 INFO - Successfully installed blobuploader requests docopt 21:29:18 INFO - Cleaning up... 21:29:18 INFO - Return code: 0 21:29:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:29: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')]} 21:29:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:29:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:29: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')]} 21:29:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:29:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:29:18 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 0x1425030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16e6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e43b0>, '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 0x16e52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16e5740>, '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': '8887e36bb8e381bfd44124ac000001a8-1468902532.252852-13128552', '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 21:29:18 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 21:29:18 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 21:29:18 INFO - Using env: {'DISPLAY': ':0', 21:29:18 INFO - 'HOME': '/home/cltbld', 21:29:18 INFO - 'LANG': 'en_US.UTF-8', 21:29:18 INFO - 'LANGUAGE': 'en_US:en', 21:29:18 INFO - 'LOGNAME': 'cltbld', 21:29:18 INFO - 'MAIL': '/var/mail/cltbld', 21:29:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:29:18 INFO - 'MOZ_NO_REMOTE': '1', 21:29:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:29:18 INFO - 'NO_EM_RESTART': '1', 21:29:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:29:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:29:18 INFO - 'PWD': '/builds/slave/test', 21:29:18 INFO - 'SHELL': '/bin/bash', 21:29:18 INFO - 'SHLVL': '1', 21:29:18 INFO - 'TERM': 'linux', 21:29:18 INFO - 'TMOUT': '86400', 21:29:18 INFO - 'USER': 'cltbld', 21:29:18 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1468902532.252852-13128552', 21:29:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:29:18 INFO - '_': '/tools/buildbot/bin/python'} 21:29:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:29:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:29:19 INFO - Running setup.py (path:/tmp/pip-xMxdK8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:29:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:29:19 INFO - Running setup.py (path:/tmp/pip-yLsGb9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:29:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:29:19 INFO - Running setup.py (path:/tmp/pip-nYYwGE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:29:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:29:19 INFO - Running setup.py (path:/tmp/pip-FQwU3j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:29:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:29:19 INFO - Running setup.py (path:/tmp/pip-1Bhkk9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:29:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:29:19 INFO - Running setup.py (path:/tmp/pip-pumUm9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:29:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:29:19 INFO - Running setup.py (path:/tmp/pip-w3ngL9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:29:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:29:19 INFO - Running setup.py (path:/tmp/pip-JKo4NV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:29:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:29:19 INFO - Running setup.py (path:/tmp/pip-iXwIsP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:29:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:29:19 INFO - Running setup.py (path:/tmp/pip-p9CLwb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:29:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:29:19 INFO - Running setup.py (path:/tmp/pip-MK2V4M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:29:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:29:19 INFO - Running setup.py (path:/tmp/pip-RHqyul-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:29:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:29:20 INFO - Running setup.py (path:/tmp/pip-6uJqMP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:29:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:29:20 INFO - Running setup.py (path:/tmp/pip-ihHn61-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:29:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:29:20 INFO - Running setup.py (path:/tmp/pip-0hjx2K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:29:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:29:20 INFO - Running setup.py (path:/tmp/pip-SVU4kE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:29:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:29:20 INFO - Running setup.py (path:/tmp/pip-g4xptT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:29:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:29:20 INFO - Running setup.py install for manifestparser 21:29:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:29:20 INFO - Running setup.py install for mozcrash 21:29:20 INFO - Running setup.py install for mozdebug 21:29:20 INFO - Running setup.py install for mozdevice 21:29:20 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:29:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:29:20 INFO - Running setup.py install for mozfile 21:29:20 INFO - Running setup.py install for mozhttpd 21:29:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:29:21 INFO - Running setup.py install for mozinfo 21:29:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:29:21 INFO - Running setup.py install for mozInstall 21:29:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:29:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:29:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:29:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:29:21 INFO - Running setup.py install for mozleak 21:29:21 INFO - Running setup.py install for mozlog 21:29:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:29:21 INFO - Running setup.py install for moznetwork 21:29:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:29:21 INFO - Running setup.py install for mozprocess 21:29:21 INFO - Running setup.py install for mozprofile 21:29:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:29:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:29:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:29:21 INFO - Running setup.py install for mozrunner 21:29:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:29:21 INFO - Running setup.py install for mozscreenshot 21:29:21 INFO - Running setup.py install for moztest 21:29:22 INFO - Running setup.py install for mozversion 21:29:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:29:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:29:22 INFO - Cleaning up... 21:29:22 INFO - Return code: 0 21:29:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:29:22 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')]} 21:29:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:29:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:29:22 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')]} 21:29:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:29:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:29:22 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 0x1425030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16e6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e43b0>, '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 0x16e52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16e5740>, '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': '8887e36bb8e381bfd44124ac000001a8-1468902532.252852-13128552', '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 21:29:22 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 21:29:22 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 21:29:22 INFO - Using env: {'DISPLAY': ':0', 21:29:22 INFO - 'HOME': '/home/cltbld', 21:29:22 INFO - 'LANG': 'en_US.UTF-8', 21:29:22 INFO - 'LANGUAGE': 'en_US:en', 21:29:22 INFO - 'LOGNAME': 'cltbld', 21:29:22 INFO - 'MAIL': '/var/mail/cltbld', 21:29:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:29:22 INFO - 'MOZ_NO_REMOTE': '1', 21:29:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:29:22 INFO - 'NO_EM_RESTART': '1', 21:29:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:29:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:29:22 INFO - 'PWD': '/builds/slave/test', 21:29:22 INFO - 'SHELL': '/bin/bash', 21:29:22 INFO - 'SHLVL': '1', 21:29:22 INFO - 'TERM': 'linux', 21:29:22 INFO - 'TMOUT': '86400', 21:29:22 INFO - 'USER': 'cltbld', 21:29:22 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1468902532.252852-13128552', 21:29:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:29:22 INFO - '_': '/tools/buildbot/bin/python'} 21:29:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:29:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:29:22 INFO - Running setup.py (path:/tmp/pip-FRRhl4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:29:22 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)) 21:29:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:29:22 INFO - Running setup.py (path:/tmp/pip-apCTsJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:29:22 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)) 21:29:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:29:22 INFO - Running setup.py (path:/tmp/pip-rmxBa7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:29:22 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)) 21:29:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:29:22 INFO - Running setup.py (path:/tmp/pip-esXNAc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:29:22 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)) 21:29:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:29:22 INFO - Running setup.py (path:/tmp/pip-04XIQz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:29:22 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)) 21:29:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:29:22 INFO - Running setup.py (path:/tmp/pip-S1Rch9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:29:22 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)) 21:29:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:29:22 INFO - Running setup.py (path:/tmp/pip-0ao5Su-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:29:22 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)) 21:29:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:29:22 INFO - Running setup.py (path:/tmp/pip-4xBIJB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:29:23 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)) 21:29:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:29:23 INFO - Running setup.py (path:/tmp/pip-F_57tT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:29:23 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)) 21:29:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:29:23 INFO - Running setup.py (path:/tmp/pip-UnzJtZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:29:23 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)) 21:29:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:29:23 INFO - Running setup.py (path:/tmp/pip-_3lcha-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:29:23 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)) 21:29:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:29:23 INFO - Running setup.py (path:/tmp/pip-URdVWn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:29:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 21:29:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:29:23 INFO - Running setup.py (path:/tmp/pip-kb1mRL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:29:23 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)) 21:29:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:29:23 INFO - Running setup.py (path:/tmp/pip-nZAv22-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:29:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 21:29:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:29:23 INFO - Running setup.py (path:/tmp/pip-8IZg98-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:29:23 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)) 21:29:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:29:23 INFO - Running setup.py (path:/tmp/pip-XMuyJW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:29:23 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)) 21:29:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:29:23 INFO - Running setup.py (path:/tmp/pip-Xf5LR3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:29:23 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)) 21:29:23 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)) 21:29:23 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)) 21:29:23 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)) 21:29:23 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)) 21:29:23 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)) 21:29:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:29:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:29:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:29:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:29:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:29:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:29:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:29:25 INFO - Downloading blessings-1.6.tar.gz 21:29:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:29:25 INFO - Installing collected packages: blessings 21:29:25 INFO - Running setup.py install for blessings 21:29:25 INFO - Successfully installed blessings 21:29:25 INFO - Cleaning up... 21:29:25 INFO - Return code: 0 21:29:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:29:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:29:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:29:26 INFO - Reading from file tmpfile_stdout 21:29:26 INFO - Current package versions: 21:29:26 INFO - argparse == 1.2.1 21:29:26 INFO - blessings == 1.6 21:29:26 INFO - blobuploader == 1.2.4 21:29:26 INFO - docopt == 0.6.1 21:29:26 INFO - functools32 == 3.2.3-2 21:29:26 INFO - jsonschema == 2.5.1 21:29:26 INFO - manifestparser == 1.1 21:29:26 INFO - mozInstall == 1.12 21:29:26 INFO - mozcrash == 0.17 21:29:26 INFO - mozdebug == 0.1 21:29:26 INFO - mozdevice == 0.48 21:29:26 INFO - mozfile == 1.2 21:29:26 INFO - mozhttpd == 0.7 21:29:26 INFO - mozinfo == 0.9 21:29:26 INFO - mozleak == 0.1 21:29:26 INFO - mozlog == 3.2 21:29:26 INFO - moznetwork == 0.27 21:29:26 INFO - mozprocess == 0.23 21:29:26 INFO - mozprofile == 0.28 21:29:26 INFO - mozrunner == 6.12 21:29:26 INFO - mozscreenshot == 0.1 21:29:26 INFO - mozsystemmonitor == 0.3 21:29:26 INFO - moztest == 0.7 21:29:26 INFO - mozversion == 1.4 21:29:26 INFO - psutil == 3.1.1 21:29:26 INFO - requests == 1.2.3 21:29:26 INFO - wsgiref == 0.1.2 21:29:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:29:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:29:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:29:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:29:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:29:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:29:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:29:26 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 0x1425030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16e6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e43b0>, '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 0x16e52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16e5740>, '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': '8887e36bb8e381bfd44124ac000001a8-1468902532.252852-13128552', '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 21:29:26 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 21:29:26 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 21:29:26 INFO - Using env: {'DISPLAY': ':0', 21:29:26 INFO - 'HOME': '/home/cltbld', 21:29:26 INFO - 'LANG': 'en_US.UTF-8', 21:29:26 INFO - 'LANGUAGE': 'en_US:en', 21:29:26 INFO - 'LOGNAME': 'cltbld', 21:29:26 INFO - 'MAIL': '/var/mail/cltbld', 21:29:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:29:26 INFO - 'MOZ_NO_REMOTE': '1', 21:29:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:29:26 INFO - 'NO_EM_RESTART': '1', 21:29:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:29:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:29:26 INFO - 'PWD': '/builds/slave/test', 21:29:26 INFO - 'SHELL': '/bin/bash', 21:29:26 INFO - 'SHLVL': '1', 21:29:26 INFO - 'TERM': 'linux', 21:29:26 INFO - 'TMOUT': '86400', 21:29:26 INFO - 'USER': 'cltbld', 21:29:26 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1468902532.252852-13128552', 21:29:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:29:26 INFO - '_': '/tools/buildbot/bin/python'} 21:29:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:29:26 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)) 21:29:26 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)) 21:29:26 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)) 21:29:26 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)) 21:29:26 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)) 21:29:26 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)) 21:29:26 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)) 21:29:26 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)) 21:29:26 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)) 21:29:26 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)) 21:29:26 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)) 21:29:26 INFO - Cleaning up... 21:29:26 INFO - Return code: 0 21:29:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:29:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:29:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:29:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:29:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:29:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:29:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:29:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1425030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16e6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e43b0>, '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 0x16e52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16e5740>, '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': '8887e36bb8e381bfd44124ac000001a8-1468902532.252852-13128552', '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 21:29:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 21:29:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 21:29:26 INFO - Using env: {'DISPLAY': ':0', 21:29:26 INFO - 'HOME': '/home/cltbld', 21:29:26 INFO - 'LANG': 'en_US.UTF-8', 21:29:26 INFO - 'LANGUAGE': 'en_US:en', 21:29:26 INFO - 'LOGNAME': 'cltbld', 21:29:26 INFO - 'MAIL': '/var/mail/cltbld', 21:29:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:29:26 INFO - 'MOZ_NO_REMOTE': '1', 21:29:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:29:26 INFO - 'NO_EM_RESTART': '1', 21:29:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:29:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:29:26 INFO - 'PWD': '/builds/slave/test', 21:29:26 INFO - 'SHELL': '/bin/bash', 21:29:26 INFO - 'SHLVL': '1', 21:29:26 INFO - 'TERM': 'linux', 21:29:26 INFO - 'TMOUT': '86400', 21:29:26 INFO - 'USER': 'cltbld', 21:29:26 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1468902532.252852-13128552', 21:29:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:29:26 INFO - '_': '/tools/buildbot/bin/python'} 21:29:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:29:26 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:29:26 INFO - Cleaning up... 21:29:26 INFO - Return code: 0 21:29:26 INFO - Running post-action listener: _resource_record_post_action 21:29:26 INFO - Running post-action listener: _start_resource_monitoring 21:29:26 INFO - Starting resource monitoring. 21:29:26 INFO - ##### 21:29:26 INFO - ##### Finished create-virtualenv step (success) 21:29:26 INFO - ##### 21:29:26 INFO - ##### 21:29:26 INFO - ##### Running install step. 21:29:26 INFO - ##### 21:29:26 INFO - Running pre-action listener: _resource_record_pre_action 21:29:26 INFO - Running main action method: install 21:29:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:29:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:29:26 INFO - Reading from file tmpfile_stdout 21:29:26 INFO - Detecting whether we're running mozinstall >=1.0... 21:29:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:29:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:29:26 INFO - Reading from file tmpfile_stdout 21:29:26 INFO - Output received: 21:29:26 INFO - Usage: mozinstall [options] installer 21:29:26 INFO - Options: 21:29:26 INFO - -h, --help show this help message and exit 21:29:26 INFO - -d DEST, --destination=DEST 21:29:26 INFO - Directory to install application into. [default: 21:29:26 INFO - "/builds/slave/test"] 21:29:26 INFO - --app=APP Application being installed. [default: firefox] 21:29:26 INFO - mkdir: /builds/slave/test/build/application 21:29:26 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'] 21:29:26 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 21:29:44 INFO - Reading from file tmpfile_stdout 21:29:44 INFO - Output received: 21:29:44 INFO - /builds/slave/test/build/application/firefox/firefox 21:29:44 INFO - Running post-action listener: _resource_record_post_action 21:29:44 INFO - ##### 21:29:44 INFO - ##### Finished install step (success) 21:29:44 INFO - ##### 21:29:44 INFO - ##### 21:29:44 INFO - ##### Running run-tests step. 21:29:44 INFO - ##### 21:29:44 INFO - Running pre-action listener: _resource_record_pre_action 21:29:44 INFO - Running main action method: run_tests 21:29:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:29:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:29:44 INFO - Python 2.7.3 21:29:44 INFO - Return code: 0 21:29:44 INFO - grabbing minidump binary from tooltool 21:29:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:29:44 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 0x16e43b0>, '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 0x16e52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16e5740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:29:44 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 21:29:44 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 21:29:44 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 21:29:44 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:29:44 INFO - Return code: 0 21:29:44 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:29:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:29:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:29:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:29:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:29:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TZsXsryWQjaUWglIXBpiAQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--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 21:29:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/TZsXsryWQjaUWglIXBpiAQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-001 --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 21:29:44 INFO - Using env: {'DISPLAY': ':0', 21:29:44 INFO - 'HOME': '/home/cltbld', 21:29:44 INFO - 'LANG': 'en_US.UTF-8', 21:29:44 INFO - 'LANGUAGE': 'en_US:en', 21:29:44 INFO - 'LOGNAME': 'cltbld', 21:29:44 INFO - 'MAIL': '/var/mail/cltbld', 21:29:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:29:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:29:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:29:44 INFO - 'MOZ_NO_REMOTE': '1', 21:29:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:29:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:29:44 INFO - 'NO_EM_RESTART': '1', 21:29:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:29:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:29:44 INFO - 'PWD': '/builds/slave/test', 21:29:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:29:44 INFO - 'SHELL': '/bin/bash', 21:29:44 INFO - 'SHLVL': '1', 21:29:44 INFO - 'TERM': 'linux', 21:29:44 INFO - 'TMOUT': '86400', 21:29:44 INFO - 'USER': 'cltbld', 21:29:44 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1468902532.252852-13128552', 21:29:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:29:44 INFO - '_': '/tools/buildbot/bin/python'} 21:29:44 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TZsXsryWQjaUWglIXBpiAQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--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 21:29:44 INFO - mozversion application_buildid: 20160718183003 21:29:44 INFO - mozversion application_changeset: 9edae2531988223eb282ec0995eb736fd0fb8762 21:29:44 INFO - mozversion application_display_name: Nightly 21:29:44 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:29:44 INFO - mozversion application_name: Firefox 21:29:44 INFO - mozversion application_remotingname: firefox 21:29:44 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 21:29:44 INFO - mozversion application_vendor: Mozilla 21:29:44 INFO - mozversion application_version: 50.0a1 21:29:44 INFO - mozversion platform_buildid: 20160718183003 21:29:44 INFO - mozversion platform_changeset: 9edae2531988223eb282ec0995eb736fd0fb8762 21:29:44 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 21:29:44 INFO - mozversion platform_version: 50.0a1 21:29:44 INFO - using testdate: 1468902584 21:29:44 INFO - actual date: 1468902584 21:29:44 INFO - starting webserver on 'localhost:60659' 21:29:44 INFO - SUITE-START | Running 2 tests 21:29:44 INFO - TEST-START | dromaeo_css 21:29:44 INFO - operating with platform_type : linux_ 21:29:44 INFO - Initialising browser for dromaeo_css test... 21:29:44 INFO - TEST-INFO | started process 17604 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1f51LN/profile http://localhost:60659/getInfo.html) 21:29:49 INFO - PROCESS | 17604 | __metrics Screen width/height:1600/1200 21:29:49 INFO - PROCESS | 17604 | colorDepth:24 21:29:49 INFO - PROCESS | 17604 | Browser inner width/height: 1024/697 21:29:49 INFO - PROCESS | 17604 | __metrics 21:29:49 ERROR - PROCESS | 17604 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 21:29:50 INFO - TEST-INFO | 17604: exit 0 21:29:50 INFO - Browser initialized. 21:29:50 INFO - Running cycle 1/1 for dromaeo_css test... 21:29:50 INFO - TEST-INFO | started process 17724 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1f51LN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:30:02 INFO - PROCESS | 17724 | RSS: Main: 167813120 21:30:02 INFO - PROCESS | 17724 | 21:30:52 INFO - PROCESS | 17724 | 1468902652127 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] 21:33:00 INFO - PROCESS | 17724 | Cycle 1(1): loaded http://localhost:60659/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60659/tests/dromaeo/cssquery-ext.html) 21:33:01 INFO - PROCESS | 17724 | RSS: Main: 172756992 21:33:01 INFO - PROCESS | 17724 | 21:36:03 INFO - PROCESS | 17724 | Cycle 1(1): loaded http://localhost:60659/tests/dromaeo/cssquery-ext.html (next: http://localhost:60659/tests/dromaeo/cssquery-jquery.html) 21:36:04 INFO - PROCESS | 17724 | RSS: Main: 169439232 21:36:04 INFO - PROCESS | 17724 | 21:39:06 INFO - PROCESS | 17724 | Cycle 1(1): loaded http://localhost:60659/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60659/tests/dromaeo/cssquery-mootools.html) 21:39:06 INFO - PROCESS | 17724 | RSS: Main: 172699648 21:39:06 INFO - PROCESS | 17724 | 21:42:08 INFO - PROCESS | 17724 | Cycle 1(1): loaded http://localhost:60659/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60659/tests/dromaeo/cssquery-prototype.html) 21:42:09 INFO - PROCESS | 17724 | RSS: Main: 167452672 21:42:09 INFO - PROCESS | 17724 | 21:45:11 INFO - PROCESS | 17724 | Cycle 1(1): loaded http://localhost:60659/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60659/tests/dromaeo/cssquery-yui.html) 21:45:12 INFO - PROCESS | 17724 | RSS: Main: 168722432 21:45:12 INFO - PROCESS | 17724 | 21:48:14 INFO - PROCESS | 17724 | Cycle 1(1): loaded http://localhost:60659/tests/dromaeo/cssquery-yui.html (next: http://localhost:60659/tests/dromaeo/cssquery-dojo.html) 21:48:15 INFO - PROCESS | 17724 | RSS: Main: 170147840 21:48:15 INFO - PROCESS | 17724 | 21:48:15 INFO - PROCESS | 17724 | __start_tp_report 21:48:15 INFO - PROCESS | 17724 | _x_x_mozilla_page_load 21:48:15 INFO - PROCESS | 17724 | _x_x_mozilla_page_load_details 21:48:15 INFO - PROCESS | 17724 | |i|pagename|runs| 21:48:15 INFO - PROCESS | 17724 | |0;dojo.html;3062.3415965567397;3064.8927287544934;3073.4314151881904;3103.9689603103975;3107.378524295141;5393.784248630055;5421.728913554326;5422.186671999202;5479.917801232985;5482.972585137079;5319.069162896497;5432.994895944244;5437.972810135944;5450.4549545045475;5471.50756431921;4910.435299940499;4926.679765815211;4973.179425394806;5083.262926875601;5113.872153196163;4893.4617192108835;5040.823571175009;5144.279800827869;5155.948440515603;5187.3775146982225;4888.315635810972;4903.68126071806;4933.358663373774;4952.158133117378;4991.650584459089;4956.1822299320565;4983.950160498385;4985.850424487271;4986.551210391082;5034.194528875362;4812.470628230892;4920.704757714513;4973.104841128596;4986.2769898364895;4988.326575912278;5325.4940780625775;5370.4361042090795;5413.377461591888;5418.485243901823;5454.53636440899;5812.38969908162;5814.418558144194;5835.5915085944;5860.296764388258;5869.471747542699;5745.138229265602;5806.970965145189;5900.498457631106;5906.645601263938;5915.940840591625;5462.508374246337;5477.945220547784;5483.232347471358;5498.532624726903;5546.500814926676;5968.313643930916;5993.700314984233;6002.54980876436;6002.609830361012;6020.337762846083;5585.273914391103;5649.096144616924;5742;5778.162166485836;5780.88438231233;5657.43425657431;5742;5743.684097374685;5756.913646295309;5789.623674461147;5670.092785154356;5693.658380497183;5740.655560666373;5750.108733146369;5771.480566749013;5856.736446859902;5862.70686465675;5866.823995280149;5867.677277749679;5887.676177810262;4380.956190438119;4409.470863496337;4410;4421.115776844644;4470.776461176928;3977.463042489285;3981.2634662586934;3981.442598036277;4028.3554631258858;4029.093453972833;5472.2338872557875;5553.8333849984565;5555.388907220203;5556.666600004012;5603.075492543685;5831.620944638585;5844.766209351664;5855.824325270249;5868.295804503487;5884.0585506318785;5547.140193270049;5553.389127196006;5555.416681248411;5562.443755624405;5571.777128914798;4815.085133824562;4872.293517439952;4886.780094895738;4893.535114164149;4939.950600493949;6088.63468191901;6156.969215153985;6167.599106058092;6172;6178.474829639531;5953.613015154001;5955.434233747787;5958.106284057253;5990.131430942576;6010.579259451972;5921.348651648402;6034.426729460694;6052.515798736003;6161.753529858935;6171.722272497838;5726.685032323262;5734.082546792493;5762.971185144047;5788.594798364074;5831.387704291158;5840.094785308284;5888.234529511136;5895.793647222326;5896.321922978912;5902.439268269508;5555.055640541037;5587.0502014656795;5597.3003374578175;5678.971605141948;5723.3418156912485;5722.599418040697;5776.508996735157;5791.044477661138;5802.680852552981;5828.242328497268;5739.856503587277;5748.885022299614;5789.044807606698;5790.363060063305;5810.389909059488;5573.554115670818;5762.366139724711;5769.221155144001;5777.104548794943;5780.479756821906;5683.914741278802;5708.743106560298;5714.571407144564;5721.799737009184;5730.828075157752 21:48:15 INFO - PROCESS | 17724 | |1;ext.html;549.8911673731243;598.5600583571074;618.6535540097544;618.6875627807954;643.131772107655;39603.20793584127;43891.56108438915;44293.55706442935;44353.55646443534;44587.10825783482;44366.77816610912;45048.54951450485;45164.774176129074;45219.32171017429;45413.318800218025;8898.555072246378;9002;9004.279657627407;9012.41419307743;9092.36353455255;8929.55352232389;9025.503597302146;9074.500902450363;9083.318751093695;9100.954495227514;9092.40899341544;9112.726618201465;9123.361364704473;9161.679341223058;9177.03641117683;9047.638094476213;9079.182873541413;9125.04187060359;9133.406328588688;9156.725298241063;8980.46117232968;9058.954705226497;9119.726408207764;9126.817463650756;9129.863052054225;42728.78635606802;43256.56743432557;43310.35034474485;43506.564934350565;43566.34650480245;3367.6295607483157;3375.122468158272;3460.2560449503476;3546.982265088684;4004.539477960043;32384.514232286536;32709;32732.509012364597;33147.33705325904;33939.15152121192;4415.448068991376;4417.09449562842;4507.706999045085;4511.639068874482;4537.137943790669;377476;379342;379455;379651;380951;34872.82563587216;35005.299894001975;35046.82476587601;60081;60516.69741651264;37331.626683732815;37349.813250934116;37463.43804842875;37579.06052348713;37776;14574.19841908684;14602.780958285633;14636.414543418357;14642.194679292528;14649.560513184622;11424.028957538536;11477.311361318347;11502.94248528752;11632.069434445224;11743;8380.8742868857;8385.580720963928;8387.203215694499;8393.664253429917;8445.324374050062;3215.437298472758;3230.854611542486;3247.123276715321;3289.555909952174;3353.836775279931;1028.2339656955467;1068.369661899483;1069.8288273876142;1084.8806631270554;1168.5968340922368;33221.83389083087;33344;33361.165970850925;33640;34091.82954085214;1090.4820210400155;1110.4725255503572;1144.9141314401454;1158.223989926751;1184.6860581945791;17283.481495555152;17295.74056389155;17509.467809447724;17599.03205323694;17604.119794010247;585233;599599;604053;604651.7441540669;608842;61164;61794;61900;62163.689181554706;62228;1348.339313736262;1385.9722805544034;1393.4565519447424;1400.5308221745624;1403.1440821099122;31683.841580792872;31785.523217151298;31977.840110799298;32265.35469290554;32772.672273277916;52923.73538132285;53029.469705304;53269.733651333045;53338.46661533335;53403.46596533985;352017;353947;354544;355365;355718;28308.85845570759;28380.148595542167;28551.857240713663;28788.280292992844;28916;44312;44383.11233775371;45321.77339113415;48871.266930996775;50644.746776265885;41966.79016604897;43825.780871096715;43970;43996.780016099714;44839;41795.37306940337;43033.7848310769;43391.34912976245;43428.348574770775;43706.562934370246;41931;42355.576444235165;42598;42638.36042459303;42883.35674964941;37906.83149765573;38625.22749544937;39318;39463.80268098641;39721.40417893792;28692.856535717186;28831.855840720662;28885;29126.417471650024;29303.560446592892 21:48:15 INFO - PROCESS | 17724 | |2;jquery.html;378.273714468221;386.7602086706242;389.851856294608;391.11607766447827;400.6894656641103;18551.257949682014;19770;20511.794882051192;20956.16175352986;20998.8450635215;19655.901720491376;19857.900710496462;20306.289279875207;20391.796082039175;20457.079431425584;5347.946520534803;5547.889042219153;5721.628094173886;5971.432713892195;5988.640681559121;5768.5385169186575;5860.296764388279;5896.734646940898;5909.734061967221;5911.556633252501;5458.9454105459035;5663.753974125706;5714.942850571503;5793.681347525884;5862.824115276549;5708.115242137475;5757.827265182052;5880.794172203974;6304.117423560705;6385.680715964229;5788.04497257952;5806.970965145148;5812.505936995361;5813.4477224664015;5827.271591051119;13861.514846980408;14689.118652880861;14691.045082069631;14696.485623003251;14712.411503539846;2338.543983923136;2346.4485845826216;2392.748761380065;2557.6802899637546;2610.9477810443873;9700.563474643657;10159.746006349826;10349.22380821434;10737.731556711067;14884.62788430298;1789.3111152206363;1797.451777207951;1850.5928695686928;1888.5089876632037;1949.3177387914116;72091.27908720898;82091.58954205191;85099.14900850975;85873.57063214706;89268.55365723195;10888;11165.330080195214;11298.887011129784;11361.943190283995;11621.571636367124;15645.295961681752;15782.763258551131;15800.525984220492;15850.365985360457;15857.762133568005;8381.664733410717;8392.664293428195;8730.476171429735;8739.21347078766;8824;8068.919310806934;8097.2307630774985;8170.264676179054;8253.257206851413;8291.8341633167;4738.147133516;4740.146773580788;4788.4253889533475;4792.614757496921;4811.735354555533;1968.193040853272;1989.3932350632906;2028.9797102029086;2033.6237796007786;2068.844836637258;445.4209527614089;483.6976889444097;992.6575331510762;1055.466989170464;1056.8150573649734;11855.703607409883;12454.626361209179;12471.812922806164;12520.123591348518;12551.623451296477;452.38249789037724;463.5248869908371;487.9634027447956;489.7012822178468;492.96795708279564;6596.769113081019;6597.80206593803;6638.103855979478;6640.900386494206;6666.933330666729;541313;544719;553526;560981;562723;60863.39136608577;88737;90566;93324;98120;484.8230395905469;498.3023766726612;498.7954938475208;499.6402590135097;499.7301457213137;10874.891251087387;11103.555857765921;11318.547258109913;11539.36533490666;11672.416379181177;41166.1766764669;42153.57846421497;43057.56942430536;43523.56476435322;43990.780046099564;58255.41744582669;61407;61656.383436165066;62225.37774622377;63581.682091589246;8399.328053755808;8452.112528184452;8471;8517.318614510948;8653;9342;13021.242132312016;13430.529931452353;13579;13639.181649101085;11780.823287650863;12019.519219231133;12087.516499339928;12191.51233950632;12232.204906681038;11333.150013748836;11399.145064120059;11595.768084638428;11636;11684.47419866125;11285.548578056785;11613.709657258636;11916.344601047025;12373.443195056425;12396.194247373893;8267.503949763033;8412.158784121539;8543;8587.570621468776;8678.652853886026;8531.573421329032;11310.83033754478;11795.174337796272;11866.644000679993;11929.403529823301 21:48:15 INFO - PROCESS | 17724 | |3;mootools.html;1483.896127271091;1534.048889688393;1663.5674724571616;1763.3916298876884;1807.6475087357962;7876.5667888266125;8673.04596494386;8678.088800675932;9249.260059195265;9263.980962094172;8948.06045365237;8950.239229665487;8950.641974321019;9001.234895033913;9006.954965225164;2358.5282943411303;2389.685672879918;2392.162743039931;2402.8077753779658;2409.8915548800346;2332.3119679694532;2368.336865677613;2375.904963801446;2380.214529205367;2386.2364043506086;2358.151065616377;2368.3250273672006;2373.4303767095857;2403.134871446278;2404.1104791227185;2260.242818655752;2260.8530445520987;2261.321603518946;2264.818814494845;2315.5021670340957;2208.4699672078746;2211.966820497678;2224.7552769195377;2228.097620463715;2242.3609271357586;9011.459312441275;9105.408148470327;9120;9171;9189.402688825205;5384.9730751346;5483.122700367922;5500.532454741352;5513.862153446155;5514.531264842493;3292.5555050068415;3323.135984643986;3359.0930448778936;3391.0505058583635;3429.9485507717404;1038.1383451735041;1068.2255364860491;1069.0645685025602;1073.4739977411011;1081.1080608934365;12601.810972835507;12678.746425071538;12696.80954785679;12722.936385318108;12762.553310634083;4760.833370832073;4817.494163112893;4866.124097662384;4926.088673595396;4971.6271279654175;10513.896040915746;10683.519241634145;10686.51910664022;10727.356358618508;10790.136789056856;5529.861753456195;5547.750351234205;5573.916391254134;5576.9163462548095;5578.30271216098;4335.414719012956;4939.90120197594;5033.823816166489;5042.520960508819;5138;3958.940615890764;4026.0941288210506;4100.897477563025;4127.360259159835;4133.441985332001;1188.8097904335266;1212.4119801896074;1218.8902998730157;1226.92638441692;1275.005495713345;1005.4269066631949;1007.6120693533043;1011.8633984412157;1024.2113572549094;1032.9793404131876;6158.692065396713;6333.873322533524;6368.395002474757;6400.807975760735;6403.295637479873;451.45148644397216;454.6113073322262;458.6674660870842;459.65755512143664;467.2873867352315;4333.978330108329;4403.823847046082;4485.955140448554;4488.438945131858;4515.187266292033;11000;11235.550577976954;11286.097112231002;11326.660200194008;11362.261453005529;11169.329840209613;11181.32912025281;11201.943990279997;11206.159538034517;11209.271397359145;8005.719799807095;8073.919260807317;8345.833083338299;8348.66605335792;8479.745607631658;6330.3669633036325;6379.649119298298;6538.640374779243;6622.536422450382;6637.535372523877;10301.9484902575;10482.895171048496;10582.153427725918;10717.35695858251;10730.356178629307;10298.948505257425;10477.790444190921;10759.408232547285;10785.460726963463;10828.5127169276;6909.930900690929;7683.577403242875;7935.1271360149185;7973.282404583615;8083.19168083187;8748.956255218938;8779.517126558101;8813.647454101763;8813.735587932373;8827.867581986404;7655.732049378245;7799.9220007799195;7826.530408175528;7976.601169941596;8012.118666946748;7880.408969327209;7899;7910.2089791020435;7972.162922893012;7974.16271291506;7242.348188663045;7303.817404564928;7339.669714862951;7345.118585769742;7401.0748656417945;5430.755615997211;5440.319960004999;5491.478309560585;5522.337319521523;5568.55451563882;5405.378381486022;5544.0575102231915;5557.72211389437;5648.491635752802;5695.829125126253 21:48:15 INFO - PROCESS | 17724 | |4;prototype.html;317.2702783597725;321.9967800321996;323.4808132946621;330.9007297810657;331.48785126978817;5669.376368599451;5688.488036076752;5696.943030569693;5720.856978575538;5748.913766293509;5565.276514053177;5568.749406276717;5591;5629.887402251952;5632.324121105463;4142.212979533879;4241.300185469394;4329.307310830268;4331.242032644291;4351.151525452522;4323.125121794019;4330.415393921828;4333.1117120990275;4376.256036473807;4385.342198670193;4374.890627734316;4375.890602734941;4381.408509851161;4382.233109205892;4396.164728701552;4255.999680150325;4319.8488052918;4326.329418940069;4350.12997400518;4356.934645980313;3785.0915780212827;3785.1861849702445;3798.9620103798884;3799.6010418905894;3809.5904515329507;5508.091164957777;5517.917231241535;5533.861653458655;5534.640248383842;5537.473939975695;4793.856184314476;4864.1974074277705;4881.316615673809;4894.528263227047;5002.849344650715;5844.45122042659;5866.178734977107;5873.177755114288;5927.051671732502;5946.769961264526;4150.211459822624;4157.10622216222;4159.064210552631;4164.5210800758;4187.623113919732;5785.334686511063;6094.603850749687;6102.20671312731;6162.96918515409;6163.87672246557;4208.36874468826;4248.024668529149;4262.957370426318;4268.509121451011;4289.656827453796;4284.400183974246;4310.159518893785;4321.286987647003;4323.286657701444;4324.891877703082;4776.832810851603;4922.212446008693;4957.380327459067;4958.677685950402;4983.103041452573;5944.910826337608;5949.8215053548465;5954.315253745788;5972.850678733066;5982.880342393128;1467.4130347860942;1479.5487376350316;1490.6646004648867;1492.6268432891777;1496.8698632532369;937.7527887909065;986.161762501882;1002.8445590933417;1008.8032833597379;1009.4448053570507;5603.497813866334;5663.518600918968;5666.886662266732;5688.829335119953;5697.259356283739;6044.7582096716515;6072.666003369857;6077.969610151921;6083.847903802441;6109;5449.3460784706085;5674.801381951695;5699.971500142473;5776.740046697909;5785.611453251189;3287.4904389819617;3289.276359200972;3298.9835050825072;3304.520844477537;3317.0712200583876;6206.379362063757;6301.8109456716375;6359.268684101295;6359.523035772336;6382.521310901701;6217.533684973645;6279.843003924939;6286.402791734869;6300.401461861115;6300.653464059429;6090.451859332681;6300.684031438479;6323.936760632427;6356.77751278703;6358.586691865014;6094.908576371269;6112.510999120149;6114.816555503164;6121.081837724377;6181.938180618136;6067.757289708362;6100.328963814066;6100.847478812888;6113.205283313141;6154.692265386623;6020.39796020412;6276.1799078266795;6290.465310448663;6315.431611155018;6337.271213810471;4195.804195804181;4214.1361020991235;4240.575942405735;4250;4255.553166917429;5897.292324921037;6100.145979562776;6170.321264660974;6175.351588083367;6184.752609895734;5963.807238552394;5990.820275391745;6010.549208809444;6024.006039003515;6036;6004.939950600613;6011.587276989992;6011.699415029144;6039.305479869696;6043.8186854394435;5687.573431992534;5966.552508561962;5994.31065427464;5994.6403215807195;6010.849728756816;5986.850328741816;6034.426729460694;6092.360302168208;6111.449969502766;6113.786017489367;5607.971960140173;5862.589618726819;5905.4685078343155;5934.1900720279;5978.581499295007 21:48:15 INFO - PROCESS | 17724 | |5;yui.html;756.5044895593388;760.5056713136464;778.750799744082;782.1607564540716;794.0947320055136;14845.331960061796;15801.367945282203;15885.84114158858;15896.04623722576;15934;15242.466513672023;15463.30415131319;15470.458533951314;15481.225938703075;15498.5350439487;658.5883822610868;777.7122464688073;792.7106606088765;797.8803179523089;815.4088285992667;799.6201804143044;803.8874557561917;805.2350267246111;812.3947658994058;813.3086876155251;854.239726643288;856.2764464027887;856.5674334461088;857.2327766648846;858.6737039924819;845.9280961118312;852.7953291210096;853.0318088969003;855.6149732620346;855.9828803423928;616.3466725271227;617.0189398855796;617.5646169450526;620.7951376045894;621.7264403662374;15363.308651110727;15505.689886202326;15508;15523.611909702235;15527.534173974798;15223.238838058052;15519.922400387926;15627.609309767233;15675.294611742385;15806.9209653951;11684.415779211091;12183.390830458531;12250.632481025583;12263.570775022832;12267.877321226852;3968.206358728237;4017.6986725995666;4089.5297040840387;4102.425660407545;4117.444145040411;72256.63871680608;73397.6330118346;73936.6303168486;74048.25951740467;74496.62751686262;11127.777444451065;11547.595834145764;11558.826617600742;11666.766664666658;11805.40972951349;22481.887590561942;22483.775162248494;22556.436089097904;22632.886835565718;22932.6240425575;8574.871376929352;8646.6973655923;8653.956730216309;8811.515366654767;8869.290456763443;4523.7285762854335;4585.816567337336;4709.340692303081;4724.456687480983;4868.683535570177;3523.101609089717;3627.7279204059273;3631.473436351767;3632.3824949758077;3633.1462106404974;619.755196697302;623.2676604989119;638.6487431912429;639.9808005759742;644.4168027934727;664.6244871647503;680.5610381304031;705.4603228530178;718.8131085917595;725.1986554856912;10046.648367307109;10320.741981450525;10329.276950613385;10381;10541.894581054092;759.1232126893447;759.6581538307673;772.837704082149;775.972840950564;776.0958483366927;4657.208274593328;4856.635752318591;4902.142125128088;5039.672421292605;5046.722430266371;71792.64103679448;72340;73219.2678073223;95614.52192738991;103882.4805875981;62317.37682623207;90257;97987.51006244923;98047.50976245073;99392;76219;91520.54239728893;91948;93175;93362;9478.971437139051;9708.660196893075;9739.673724401193;9874.901250987397;9914;53374.466255338506;53949;54089.72955135199;54639.180412293055;56196.15705764335;68704.6564767173;80782.59608702153;82864;83207.5839620798;84032.57983710042;12341.665175286857;12417.503299867903;12452.626421207378;12574.685632859251;12866.67833304175;12041.157119001586;12251.203671761306;13059.869401305865;13253.933730331286;13491.662708432368;12607.369631518204;12761.61715148547;12936.805947910978;12974.481020759064;13196.406161722938;12446.502139914302;12504.812427813407;12783.488660453479;12886.48454061827;13291.933540332237;12540.87459125397;12571.87428125707;12848.614541563767;12923.095383323078;13025.869741302466;9859.161971232526;9880.25898057663;10182.898171018194;10439.530221139916;10454.486417360165;9684.837819461709;10182.796344072929;10365.689029329133;10389.220808439246;10400.791984160425 21:48:15 INFO - PROCESS | 17724 | __end_tp_report 21:48:15 INFO - PROCESS | 17724 | __start_cc_report 21:48:15 INFO - PROCESS | 17724 | _x_x_mozilla_cycle_collect,337 21:48:15 INFO - PROCESS | 17724 | __end_cc_report 21:48:15 INFO - PROCESS | 17724 | __startTimestamp1468903695039__endTimestamp 21:48:15 INFO - PROCESS | 17724 | 21:48:15 INFO - PROCESS | 17724 | ------- Summary: start ------- 21:48:15 INFO - PROCESS | 17724 | Number of tests: 6 21:48:15 INFO - PROCESS | 17724 | 21:48:15 INFO - PROCESS | 17724 | [#0] dojo.html Cycles:165 Average:5431.92 Median:5670.09 stddev:636.44 (11.2%) stddev-sans-first:610.64 21:48:15 INFO - PROCESS | 17724 | Values: 3062.3 3064.9 3073.4 3104.0 3107.4 5393.8 5421.7 5422.2 5479.9 5483.0 5319.1 5433.0 5438.0 5450.5 5471.5 4910.4 4926.7 4973.2 5083.3 5113.9 4893.5 5040.8 5144.3 5155.9 5187.4 4888.3 4903.7 4933.4 4952.2 4991.7 4956.2 4984.0 4985.9 4986.6 5034.2 4812.5 4920.7 4973.1 4986.3 4988.3 5325.5 5370.4 5413.4 5418.5 5454.5 5812.4 5814.4 5835.6 5860.3 5869.5 5745.1 5807.0 5900.5 5906.6 5915.9 5462.5 5477.9 5483.2 5498.5 5546.5 5968.3 5993.7 6002.5 6002.6 6020.3 5585.3 5649.1 5742.0 5778.2 5780.9 5657.4 5742.0 5743.7 5756.9 5789.6 5670.1 5693.7 5740.7 5750.1 5771.5 5856.7 5862.7 5866.8 5867.7 5887.7 4381.0 4409.5 4410.0 4421.1 4470.8 3977.5 3981.3 3981.4 4028.4 4029.1 5472.2 5553.8 5555.4 5556.7 5603.1 5831.6 5844.8 5855.8 5868.3 5884.1 5547.1 5553.4 5555.4 5562.4 5571.8 4815.1 4872.3 4886.8 4893.5 4940.0 6088.6 6157.0 6167.6 6172.0 6178.5 5953.6 5955.4 5958.1 5990.1 6010.6 5921.3 6034.4 6052.5 6161.8 6171.7 5726.7 5734.1 5763.0 5788.6 5831.4 5840.1 5888.2 5895.8 5896.3 5902.4 5555.1 5587.1 5597.3 5679.0 5723.3 5722.6 5776.5 5791.0 5802.7 5828.2 5739.9 5748.9 5789.0 5790.4 5810.4 5573.6 5762.4 5769.2 5777.1 5780.5 5683.9 5708.7 5714.6 5721.8 5730.8 21:48:15 INFO - PROCESS | 17724 | 21:48:15 INFO - PROCESS | 17724 | [#1] ext.html Cycles:180 Average:59654.05 Median:41948.90 stddev:122062.85 (291.0%) stddev-sans-first:122324.61 21:48:15 INFO - PROCESS | 17724 | Values: 549.9 598.6 618.7 618.7 643.1 39603.2 43891.6 44293.6 44353.6 44587.1 44366.8 45048.5 45164.8 45219.3 45413.3 8898.6 9002.0 9004.3 9012.4 9092.4 8929.6 9025.5 9074.5 9083.3 9101.0 9092.4 9112.7 9123.4 9161.7 9177.0 9047.6 9079.2 9125.0 9133.4 9156.7 8980.5 9059.0 9119.7 9126.8 9129.9 42728.8 43256.6 43310.4 43506.6 43566.3 3367.6 3375.1 3460.3 3547.0 4004.5 32384.5 32709.0 32732.5 33147.3 33939.2 4415.4 4417.1 4507.7 4511.6 4537.1 377476.0 379342.0 379455.0 379651.0 380951.0 34872.8 35005.3 35046.8 60081.0 60516.7 37331.6 37349.8 37463.4 37579.1 37776.0 14574.2 14602.8 14636.4 14642.2 14649.6 11424.0 11477.3 11502.9 11632.1 11743.0 8380.9 8385.6 8387.2 8393.7 8445.3 3215.4 3230.9 3247.1 3289.6 3353.8 1028.2 1068.4 1069.8 1084.9 1168.6 33221.8 33344.0 33361.2 33640.0 34091.8 1090.5 1110.5 1144.9 1158.2 1184.7 17283.5 17295.7 17509.5 17599.0 17604.1 585233.0 599599.0 604053.0 604651.7 608842.0 61164.0 61794.0 61900.0 62163.7 62228.0 1348.3 1386.0 1393.5 1400.5 1403.1 31683.8 31785.5 31977.8 32265.4 32772.7 52923.7 53029.5 53269.7 53338.5 53403.5 352017.0 353947.0 354544.0 355365.0 355718.0 28308.9 28380.1 28551.9 28788.3 28916.0 44312.0 44383.1 45321.8 48871.3 50644.7 41966.8 43825.8 43970.0 43996.8 44839.0 41795.4 43033.8 43391.3 43428.3 43706.6 41931.0 42355.6 42598.0 42638.4 42883.4 37906.8 38625.2 39318.0 39463.8 39721.4 28692.9 28831.9 28885.0 29126.4 29303.6 21:48:15 INFO - PROCESS | 17724 | 21:48:15 INFO - PROCESS | 17724 | [#2] jquery.html Cycles:180 Average:30132.14 Median:457.95 stddev:90929.25 (19855.6%) stddev-sans-first:91156.89 21:48:15 INFO - PROCESS | 17724 | Values: 378.3 386.8 389.9 391.1 400.7 18551.3 19770.0 20511.8 20956.2 20998.8 19655.9 19857.9 20306.3 20391.8 20457.1 5347.9 5547.9 5721.6 5971.4 5988.6 5768.5 5860.3 5896.7 5909.7 5911.6 5458.9 5663.8 5714.9 5793.7 5862.8 5708.1 5757.8 5880.8 6304.1 6385.7 5788.0 5807.0 5812.5 5813.4 5827.3 13861.5 14689.1 14691.0 14696.5 14712.4 2338.5 2346.4 2392.7 2557.7 2610.9 9700.6 10159.7 10349.2 10737.7 14884.6 1789.3 1797.5 1850.6 1888.5 1949.3 72091.3 82091.6 85099.1 85873.6 89268.6 10888.0 11165.3 11298.9 11361.9 11621.6 15645.3 15782.8 15800.5 15850.4 15857.8 8381.7 8392.7 8730.5 8739.2 8824.0 8068.9 8097.2 8170.3 8253.3 8291.8 4738.1 4740.1 4788.4 4792.6 4811.7 1968.2 1989.4 2029.0 2033.6 2068.8 445.4 483.7 992.7 1055.5 1056.8 11855.7 12454.6 12471.8 12520.1 12551.6 452.4 463.5 488.0 489.7 493.0 6596.8 6597.8 6638.1 6640.9 6666.9 541313.0 544719.0 553526.0 560981.0 562723.0 60863.4 88737.0 90566.0 93324.0 98120.0 484.8 498.3 498.8 499.6 499.7 10874.9 11103.6 11318.5 11539.4 11672.4 41166.2 42153.6 43057.6 43523.6 43990.8 58255.4 61407.0 61656.4 62225.4 63581.7 8399.3 8452.1 8471.0 8517.3 8653.0 9342.0 13021.2 13430.5 13579.0 13639.2 11780.8 12019.5 12087.5 12191.5 12232.2 11333.2 11399.1 11595.8 11636.0 11684.5 11285.5 11613.7 11916.3 12373.4 12396.2 8267.5 8412.2 8543.0 8587.6 8678.7 8531.6 11310.8 11795.2 11866.6 11929.4 21:48:15 INFO - PROCESS | 17724 | 21:48:15 INFO - PROCESS | 17724 | [#3] mootools.html Cycles:180 Average:5981.72 Median:2483.32 stddev:3429.13 (138.1%) stddev-sans-first:3422.09 21:48:15 INFO - PROCESS | 17724 | Values: 1483.9 1534.0 1663.6 1763.4 1807.6 7876.6 8673.0 8678.1 9249.3 9264.0 8948.1 8950.2 8950.6 9001.2 9007.0 2358.5 2389.7 2392.2 2402.8 2409.9 2332.3 2368.3 2375.9 2380.2 2386.2 2358.2 2368.3 2373.4 2403.1 2404.1 2260.2 2260.9 2261.3 2264.8 2315.5 2208.5 2212.0 2224.8 2228.1 2242.4 9011.5 9105.4 9120.0 9171.0 9189.4 5385.0 5483.1 5500.5 5513.9 5514.5 3292.6 3323.1 3359.1 3391.1 3429.9 1038.1 1068.2 1069.1 1073.5 1081.1 12601.8 12678.7 12696.8 12722.9 12762.6 4760.8 4817.5 4866.1 4926.1 4971.6 10513.9 10683.5 10686.5 10727.4 10790.1 5529.9 5547.8 5573.9 5576.9 5578.3 4335.4 4939.9 5033.8 5042.5 5138.0 3958.9 4026.1 4100.9 4127.4 4133.4 1188.8 1212.4 1218.9 1226.9 1275.0 1005.4 1007.6 1011.9 1024.2 1033.0 6158.7 6333.9 6368.4 6400.8 6403.3 451.5 454.6 458.7 459.7 467.3 4334.0 4403.8 4486.0 4488.4 4515.2 11000.0 11235.6 11286.1 11326.7 11362.3 11169.3 11181.3 11201.9 11206.2 11209.3 8005.7 8073.9 8345.8 8348.7 8479.7 6330.4 6379.6 6538.6 6622.5 6637.5 10301.9 10482.9 10582.2 10717.4 10730.4 10298.9 10477.8 10759.4 10785.5 10828.5 6909.9 7683.6 7935.1 7973.3 8083.2 8749.0 8779.5 8813.6 8813.7 8827.9 7655.7 7799.9 7826.5 7976.6 8012.1 7880.4 7899.0 7910.2 7972.2 7974.2 7242.3 7303.8 7339.7 7345.1 7401.1 5430.8 5440.3 5491.5 5522.3 5568.6 5405.4 5544.1 5557.7 5648.5 5695.8 21:48:15 INFO - PROCESS | 17724 | 21:48:15 INFO - PROCESS | 17724 | [#4] prototype.html Cycles:180 Average:4986.50 Median:5688.03 stddev:1495.13 (26.3%) stddev-sans-first:1457.68 21:48:15 INFO - PROCESS | 17724 | Values: 317.3 322.0 323.5 330.9 331.5 5669.4 5688.5 5696.9 5720.9 5748.9 5565.3 5568.7 5591.0 5629.9 5632.3 4142.2 4241.3 4329.3 4331.2 4351.2 4323.1 4330.4 4333.1 4376.3 4385.3 4374.9 4375.9 4381.4 4382.2 4396.2 4256.0 4319.8 4326.3 4350.1 4356.9 3785.1 3785.2 3799.0 3799.6 3809.6 5508.1 5517.9 5533.9 5534.6 5537.5 4793.9 4864.2 4881.3 4894.5 5002.8 5844.5 5866.2 5873.2 5927.1 5946.8 4150.2 4157.1 4159.1 4164.5 4187.6 5785.3 6094.6 6102.2 6163.0 6163.9 4208.4 4248.0 4263.0 4268.5 4289.7 4284.4 4310.2 4321.3 4323.3 4324.9 4776.8 4922.2 4957.4 4958.7 4983.1 5944.9 5949.8 5954.3 5972.9 5982.9 1467.4 1479.5 1490.7 1492.6 1496.9 937.8 986.2 1002.8 1008.8 1009.4 5603.5 5663.5 5666.9 5688.8 5697.3 6044.8 6072.7 6078.0 6083.8 6109.0 5449.3 5674.8 5700.0 5776.7 5785.6 3287.5 3289.3 3299.0 3304.5 3317.1 6206.4 6301.8 6359.3 6359.5 6382.5 6217.5 6279.8 6286.4 6300.4 6300.7 6090.5 6300.7 6323.9 6356.8 6358.6 6094.9 6112.5 6114.8 6121.1 6181.9 6067.8 6100.3 6100.8 6113.2 6154.7 6020.4 6276.2 6290.5 6315.4 6337.3 4195.8 4214.1 4240.6 4250.0 4255.6 5897.3 6100.1 6170.3 6175.4 6184.8 5963.8 5990.8 6010.5 6024.0 6036.0 6004.9 6011.6 6011.7 6039.3 6043.8 5687.6 5966.6 5994.3 5994.6 6010.8 5986.9 6034.4 6092.4 6111.4 6113.8 5608.0 5862.6 5905.5 5934.2 5978.6 21:48:15 INFO - PROCESS | 17724 | 21:48:15 INFO - PROCESS | 17724 | [#5] yui.html Cycles:180 Average:19879.04 Median:4970.91 stddev:27507.21 (553.4%) stddev-sans-first:27546.90 21:48:15 INFO - PROCESS | 17724 | Values: 756.5 760.5 778.8 782.2 794.1 14845.3 15801.4 15885.8 15896.0 15934.0 15242.5 15463.3 15470.5 15481.2 15498.5 658.6 777.7 792.7 797.9 815.4 799.6 803.9 805.2 812.4 813.3 854.2 856.3 856.6 857.2 858.7 845.9 852.8 853.0 855.6 856.0 616.3 617.0 617.6 620.8 621.7 15363.3 15505.7 15508.0 15523.6 15527.5 15223.2 15519.9 15627.6 15675.3 15806.9 11684.4 12183.4 12250.6 12263.6 12267.9 3968.2 4017.7 4089.5 4102.4 4117.4 72256.6 73397.6 73936.6 74048.3 74496.6 11127.8 11547.6 11558.8 11666.8 11805.4 22481.9 22483.8 22556.4 22632.9 22932.6 8574.9 8646.7 8654.0 8811.5 8869.3 4523.7 4585.8 4709.3 4724.5 4868.7 3523.1 3627.7 3631.5 3632.4 3633.1 619.8 623.3 638.6 640.0 644.4 664.6 680.6 705.5 718.8 725.2 10046.6 10320.7 10329.3 10381.0 10541.9 759.1 759.7 772.8 776.0 776.1 4657.2 4856.6 4902.1 5039.7 5046.7 71792.6 72340.0 73219.3 95614.5 103882.5 62317.4 90257.0 97987.5 98047.5 99392.0 76219.0 91520.5 91948.0 93175.0 93362.0 9479.0 9708.7 9739.7 9874.9 9914.0 53374.5 53949.0 54089.7 54639.2 56196.2 68704.7 80782.6 82864.0 83207.6 84032.6 12341.7 12417.5 12452.6 12574.7 12866.7 12041.2 12251.2 13059.9 13253.9 13491.7 12607.4 12761.6 12936.8 12974.5 13196.4 12446.5 12504.8 12783.5 12886.5 13291.9 12540.9 12571.9 12848.6 12923.1 13025.9 9859.2 9880.3 10182.9 10439.5 10454.5 9684.8 10182.8 10365.7 10389.2 10400.8 21:48:15 INFO - PROCESS | 17724 | -------- Summary: end -------- 21:48:15 INFO - PROCESS | 17724 | 21:48:15 INFO - TEST-INFO | 17724: exit 0 21:48:15 INFO - TEST-OK | dromaeo_css | took 1111324ms 21:48:15 INFO - TEST-START | kraken 21:48:15 INFO - operating with platform_type : linux_ 21:48:15 INFO - Initialising browser for kraken test... 21:48:15 INFO - TEST-INFO | started process 17971 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptG9D1r/profile http://localhost:60659/getInfo.html) 21:48:20 INFO - PROCESS | 17971 | __metrics Screen width/height:1600/1200 21:48:20 INFO - PROCESS | 17971 | colorDepth:24 21:48:20 INFO - PROCESS | 17971 | Browser inner width/height: 1024/697 21:48:20 INFO - PROCESS | 17971 | __metrics 21:48:21 ERROR - PROCESS | 17971 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 21:48:21 INFO - TEST-INFO | 17971: exit 0 21:48:21 INFO - Browser initialized. 21:48:21 INFO - Running cycle 1/1 for kraken test... 21:48:21 INFO - TEST-INFO | started process 18091 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptG9D1r/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:48:33 INFO - PROCESS | 18091 | RSS: Main: 167612416 21:48:33 INFO - PROCESS | 18091 | 21:48:36 INFO - PROCESS | 18091 | Cycle 1(1): loaded http://localhost:60659/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60659/tests/kraken/driver.html?testName=audio-beat-detection) 21:48:36 INFO - PROCESS | 18091 | RSS: Main: 172879872 21:48:36 INFO - PROCESS | 18091 | 21:48:39 INFO - PROCESS | 18091 | Cycle 1(1): loaded http://localhost:60659/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60659/tests/kraken/driver.html?testName=audio-dft) 21:48:40 INFO - PROCESS | 18091 | RSS: Main: 172163072 21:48:40 INFO - PROCESS | 18091 | 21:48:43 INFO - PROCESS | 18091 | Cycle 1(1): loaded http://localhost:60659/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60659/tests/kraken/driver.html?testName=audio-fft) 21:48:43 INFO - PROCESS | 18091 | RSS: Main: 167010304 21:48:43 INFO - PROCESS | 18091 | 21:48:45 INFO - PROCESS | 18091 | Cycle 1(1): loaded http://localhost:60659/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60659/tests/kraken/driver.html?testName=audio-oscillator) 21:48:46 INFO - PROCESS | 18091 | RSS: Main: 168218624 21:48:46 INFO - PROCESS | 18091 | 21:48:48 INFO - PROCESS | 18091 | Cycle 1(1): loaded http://localhost:60659/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60659/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:48:49 INFO - PROCESS | 18091 | RSS: Main: 169111552 21:48:49 INFO - PROCESS | 18091 | 21:48:52 INFO - PROCESS | 18091 | Cycle 1(1): loaded http://localhost:60659/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60659/tests/kraken/driver.html?testName=imaging-darkroom) 21:48:53 INFO - PROCESS | 18091 | RSS: Main: 167759872 21:48:53 INFO - PROCESS | 18091 | 21:48:56 INFO - PROCESS | 18091 | Cycle 1(1): loaded http://localhost:60659/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60659/tests/kraken/driver.html?testName=imaging-desaturate) 21:48:57 INFO - PROCESS | 18091 | RSS: Main: 169525248 21:48:57 INFO - PROCESS | 18091 | 21:48:59 INFO - PROCESS | 18091 | Cycle 1(1): loaded http://localhost:60659/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60659/tests/kraken/driver.html?testName=json-parse-financial) 21:49:00 INFO - PROCESS | 18091 | RSS: Main: 168747008 21:49:00 INFO - PROCESS | 18091 | 21:49:02 INFO - PROCESS | 18091 | Cycle 1(1): loaded http://localhost:60659/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60659/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:49:02 INFO - PROCESS | 18091 | RSS: Main: 168648704 21:49:02 INFO - PROCESS | 18091 | 21:49:04 INFO - PROCESS | 18091 | Cycle 1(1): loaded http://localhost:60659/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60659/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:49:05 INFO - PROCESS | 18091 | RSS: Main: 169582592 21:49:05 INFO - PROCESS | 18091 | 21:49:07 INFO - PROCESS | 18091 | Cycle 1(1): loaded http://localhost:60659/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60659/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:49:07 INFO - PROCESS | 18091 | RSS: Main: 169558016 21:49:07 INFO - PROCESS | 18091 | 21:49:10 INFO - PROCESS | 18091 | Cycle 1(1): loaded http://localhost:60659/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60659/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:49:11 INFO - PROCESS | 18091 | RSS: Main: 169586688 21:49:11 INFO - PROCESS | 18091 | 21:49:13 INFO - PROCESS | 18091 | Cycle 1(1): loaded http://localhost:60659/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60659/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:49:14 INFO - PROCESS | 18091 | RSS: Main: 169320448 21:49:14 INFO - PROCESS | 18091 | 21:49:16 INFO - PROCESS | 18091 | Cycle 1(1): loaded http://localhost:60659/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60659/tests/kraken/driver.html?testName=ai-astar) 21:49:16 INFO - PROCESS | 18091 | RSS: Main: 170713088 21:49:16 INFO - PROCESS | 18091 | 21:49:16 INFO - PROCESS | 18091 | __start_tp_report 21:49:16 INFO - PROCESS | 18091 | _x_x_mozilla_page_load 21:49:16 INFO - PROCESS | 18091 | _x_x_mozilla_page_load_details 21:49:16 INFO - PROCESS | 18091 | |i|pagename|runs| 21:49:16 INFO - PROCESS | 18091 | |0;ai-astar;103;112;104;110;110;112;113;116;112;112 21:49:16 INFO - PROCESS | 18091 | |1;audio-beat-detection;145;116;142;189;120;152;144;120;171;123 21:49:16 INFO - PROCESS | 18091 | |2;audio-dft;164;162;163;160;168;165;175;163;161;164 21:49:16 INFO - PROCESS | 18091 | |3;audio-fft;75;75;81;157;76;76;76;76;174;76 21:49:16 INFO - PROCESS | 18091 | |4;audio-oscillator;84;86;158;84;84;84;141;83;83;153 21:49:16 INFO - PROCESS | 18091 | |5;imaging-gaussian-blur;118;118;117;117;118;118;117;118;119;117 21:49:16 INFO - PROCESS | 18091 | |6;imaging-darkroom;147;147;147;147;147;146;147;147;147;146 21:49:16 INFO - PROCESS | 18091 | |7;imaging-desaturate;96;97;96;95;96;95;101;101;95;96 21:49:16 INFO - PROCESS | 18091 | |8;json-parse-financial;53;52;53;52;53;52;52;53;52;58 21:49:16 INFO - PROCESS | 18091 | |9;json-stringify-tinderbox;63;62;62;62;62;62;61;62;65;63 21:49:16 INFO - PROCESS | 18091 | |10;stanford-crypto-aes;77;75;83;84;81;80;77;76;84;76 21:49:16 INFO - PROCESS | 18091 | |11;stanford-crypto-ccm;124;140;134;128;134;125;123;121;156;121 21:49:16 INFO - PROCESS | 18091 | |12;stanford-crypto-pbkdf2;159;160;160;160;159;160;161;161;164;159 21:49:16 INFO - PROCESS | 18091 | |13;stanford-crypto-sha256-iterative;64;66;64;63;64;62;63;63;63;62 21:49:16 INFO - PROCESS | 18091 | __end_tp_report 21:49:16 INFO - PROCESS | 18091 | __start_cc_report 21:49:16 INFO - PROCESS | 18091 | _x_x_mozilla_cycle_collect,923 21:49:16 INFO - PROCESS | 18091 | __end_cc_report 21:49:16 INFO - PROCESS | 18091 | __startTimestamp1468903756372__endTimestamp 21:49:16 INFO - PROCESS | 18091 | 21:49:16 INFO - PROCESS | 18091 | ------- Summary: start ------- 21:49:16 INFO - PROCESS | 18091 | Number of tests: 14 21:49:16 INFO - PROCESS | 18091 | 21:49:16 INFO - PROCESS | 18091 | [#0] ai-astar Cycles:10 Average:110.40 Median:112.00 stddev:4.01 (3.6%) stddev-sans-first:3.23 21:49:16 INFO - PROCESS | 18091 | Values: 103.0 112.0 104.0 110.0 110.0 112.0 113.0 116.0 112.0 112.0 21:49:16 INFO - PROCESS | 18091 | 21:49:16 INFO - PROCESS | 18091 | [#1] audio-beat-detection Cycles:10 Average:142.20 Median:144.50 stddev:23.96 (16.6%) stddev-sans-first:25.39 21:49:16 INFO - PROCESS | 18091 | Values: 145.0 116.0 142.0 189.0 120.0 152.0 144.0 120.0 171.0 123.0 21:49:16 INFO - PROCESS | 18091 | 21:49:16 INFO - PROCESS | 18091 | [#2] audio-dft Cycles:10 Average:164.50 Median:164.00 stddev:4.30 (2.6%) stddev-sans-first:4.56 21:49:16 INFO - PROCESS | 18091 | Values: 164.0 162.0 163.0 160.0 168.0 165.0 175.0 163.0 161.0 164.0 21:49:16 INFO - PROCESS | 18091 | 21:49:16 INFO - PROCESS | 18091 | [#3] audio-fft Cycles:10 Average:94.20 Median:76.00 stddev:37.83 (49.8%) stddev-sans-first:39.48 21:49:16 INFO - PROCESS | 18091 | Values: 75.0 75.0 81.0 157.0 76.0 76.0 76.0 76.0 174.0 76.0 21:49:16 INFO - PROCESS | 18091 | 21:49:16 INFO - PROCESS | 18091 | [#4] audio-oscillator Cycles:10 Average:104.00 Median:84.00 stddev:32.48 (38.7%) stddev-sans-first:33.63 21:49:16 INFO - PROCESS | 18091 | Values: 84.0 86.0 158.0 84.0 84.0 84.0 141.0 83.0 83.0 153.0 21:49:16 INFO - PROCESS | 18091 | 21:49:16 INFO - PROCESS | 18091 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 21:49:16 INFO - PROCESS | 18091 | Values: 118.0 118.0 117.0 117.0 118.0 118.0 117.0 118.0 119.0 117.0 21:49:16 INFO - PROCESS | 18091 | 21:49:16 INFO - PROCESS | 18091 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 21:49:16 INFO - PROCESS | 18091 | Values: 147.0 147.0 147.0 147.0 147.0 146.0 147.0 147.0 147.0 146.0 21:49:16 INFO - PROCESS | 18091 | 21:49:16 INFO - PROCESS | 18091 | [#7] imaging-desaturate Cycles:10 Average:96.80 Median:96.00 stddev:2.30 (2.4%) stddev-sans-first:2.42 21:49:16 INFO - PROCESS | 18091 | Values: 96.0 97.0 96.0 95.0 96.0 95.0 101.0 101.0 95.0 96.0 21:49:16 INFO - PROCESS | 18091 | 21:49:16 INFO - PROCESS | 18091 | [#8] json-parse-financial Cycles:10 Average:53.00 Median:53.00 stddev:1.83 (3.4%) stddev-sans-first:1.94 21:49:16 INFO - PROCESS | 18091 | Values: 53.0 52.0 53.0 52.0 53.0 52.0 52.0 53.0 52.0 58.0 21:49:16 INFO - PROCESS | 18091 | 21:49:16 INFO - PROCESS | 18091 | [#9] json-stringify-tinderbox Cycles:10 Average:62.40 Median:62.00 stddev:1.07 (1.7%) stddev-sans-first:1.12 21:49:16 INFO - PROCESS | 18091 | Values: 63.0 62.0 62.0 62.0 62.0 62.0 61.0 62.0 65.0 63.0 21:49:16 INFO - PROCESS | 18091 | 21:49:16 INFO - PROCESS | 18091 | [#10] stanford-crypto-aes Cycles:10 Average:79.30 Median:80.50 stddev:3.53 (4.4%) stddev-sans-first:3.64 21:49:16 INFO - PROCESS | 18091 | Values: 77.0 75.0 83.0 84.0 81.0 80.0 77.0 76.0 84.0 76.0 21:49:16 INFO - PROCESS | 18091 | 21:49:16 INFO - PROCESS | 18091 | [#11] stanford-crypto-ccm Cycles:10 Average:130.60 Median:131.00 stddev:10.96 (8.4%) stddev-sans-first:11.36 21:49:16 INFO - PROCESS | 18091 | Values: 124.0 140.0 134.0 128.0 134.0 125.0 123.0 121.0 156.0 121.0 21:49:16 INFO - PROCESS | 18091 | 21:49:16 INFO - PROCESS | 18091 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.30 Median:160.00 stddev:1.49 (0.9%) stddev-sans-first:1.51 21:49:16 INFO - PROCESS | 18091 | Values: 159.0 160.0 160.0 160.0 159.0 160.0 161.0 161.0 164.0 159.0 21:49:16 INFO - PROCESS | 18091 | 21:49:16 INFO - PROCESS | 18091 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.40 Median:63.50 stddev:1.17 (1.8%) stddev-sans-first:1.22 21:49:16 INFO - PROCESS | 18091 | Values: 64.0 66.0 64.0 63.0 64.0 62.0 63.0 63.0 63.0 62.0 21:49:16 INFO - PROCESS | 18091 | -------- Summary: end -------- 21:49:16 INFO - PROCESS | 18091 | 21:49:17 INFO - TEST-INFO | 18091: exit 0 21:49:17 INFO - TEST-OK | kraken | took 61450ms 21:49:17 INFO - SUITE-END | took 1172s 21:49:17 INFO - Completed test suite (00:19:33) 21:49:17 INFO - javascript benchmark 21:49:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7189.373978811154, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3062.3415965567397, 3064.8927287544934, 3073.4314151881904, 3103.9689603103975, 3107.378524295141, 5393.784248630055, 5421.728913554326, 5422.186671999202, 5479.917801232985, 5482.972585137079, 5319.069162896497, 5432.994895944244, 5437.972810135944, 5450.4549545045475, 5471.50756431921, 4910.435299940499, 4926.679765815211, 4973.179425394806, 5083.262926875601, 5113.872153196163, 4893.4617192108835, 5040.823571175009, 5144.279800827869, 5155.948440515603, 5187.3775146982225, 4888.315635810972, 4903.68126071806, 4933.358663373774, 4952.158133117378, 4991.650584459089, 4956.1822299320565, 4983.950160498385, 4985.850424487271, 4986.551210391082, 5034.194528875362, 4812.470628230892, 4920.704757714513, 4973.104841128596, 4986.2769898364895, 4988.326575912278, 5325.4940780625775, 5370.4361042090795, 5413.377461591888, 5418.485243901823, 5454.53636440899, 5812.38969908162, 5814.418558144194, 5835.5915085944, 5860.296764388258, 5869.471747542699, 5745.138229265602, 5806.970965145189, 5900.498457631106, 5906.645601263938, 5915.940840591625, 5462.508374246337, 5477.945220547784, 5483.232347471358, 5498.532624726903, 5546.500814926676, 5968.313643930916, 5993.700314984233, 6002.54980876436, 6002.609830361012, 6020.337762846083, 5585.273914391103, 5649.096144616924, 5742.0, 5778.162166485836, 5780.88438231233, 5657.43425657431, 5742.0, 5743.684097374685, 5756.913646295309, 5789.623674461147, 5670.092785154356, 5693.658380497183, 5740.655560666373, 5750.108733146369, 5771.480566749013, 5856.736446859902, 5862.70686465675, 5866.823995280149, 5867.677277749679, 5887.676177810262, 4380.956190438119, 4409.470863496337, 4410.0, 4421.115776844644, 4470.776461176928, 3977.463042489285, 3981.2634662586934, 3981.442598036277, 4028.3554631258858, 4029.093453972833, 5472.2338872557875, 5553.8333849984565, 5555.388907220203, 5556.666600004012, 5603.075492543685, 5831.620944638585, 5844.766209351664, 5855.824325270249, 5868.295804503487, 5884.0585506318785, 5547.140193270049, 5553.389127196006, 5555.416681248411, 5562.443755624405, 5571.777128914798, 4815.085133824562, 4872.293517439952, 4886.780094895738, 4893.535114164149, 4939.950600493949, 6088.63468191901, 6156.969215153985, 6167.599106058092, 6172.0, 6178.474829639531, 5953.613015154001, 5955.434233747787, 5958.106284057253, 5990.131430942576, 6010.579259451972, 5921.348651648402, 6034.426729460694, 6052.515798736003, 6161.753529858935, 6171.722272497838, 5726.685032323262, 5734.082546792493, 5762.971185144047, 5788.594798364074, 5831.387704291158, 5840.094785308284, 5888.234529511136, 5895.793647222326, 5896.321922978912, 5902.439268269508, 5555.055640541037, 5587.0502014656795, 5597.3003374578175, 5678.971605141948, 5723.3418156912485, 5722.599418040697, 5776.508996735157, 5791.044477661138, 5802.680852552981, 5828.242328497268, 5739.856503587277, 5748.885022299614, 5789.044807606698, 5790.363060063305, 5810.389909059488, 5573.554115670818, 5762.366139724711, 5769.221155144001, 5777.104548794943, 5780.479756821906, 5683.914741278802, 5708.743106560298, 5714.571407144564, 5721.799737009184, 5730.828075157752], "value": 5387.2198980900175, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [549.8911673731243, 598.5600583571074, 618.6535540097544, 618.6875627807954, 643.131772107655, 39603.20793584127, 43891.56108438915, 44293.55706442935, 44353.55646443534, 44587.10825783482, 44366.77816610912, 45048.54951450485, 45164.774176129074, 45219.32171017429, 45413.318800218025, 8898.555072246378, 9002.0, 9004.279657627407, 9012.41419307743, 9092.36353455255, 8929.55352232389, 9025.503597302146, 9074.500902450363, 9083.318751093695, 9100.954495227514, 9092.40899341544, 9112.726618201465, 9123.361364704473, 9161.679341223058, 9177.03641117683, 9047.638094476213, 9079.182873541413, 9125.04187060359, 9133.406328588688, 9156.725298241063, 8980.46117232968, 9058.954705226497, 9119.726408207764, 9126.817463650756, 9129.863052054225, 42728.78635606802, 43256.56743432557, 43310.35034474485, 43506.564934350565, 43566.34650480245, 3367.6295607483157, 3375.122468158272, 3460.2560449503476, 3546.982265088684, 4004.539477960043, 32384.514232286536, 32709.0, 32732.509012364597, 33147.33705325904, 33939.15152121192, 4415.448068991376, 4417.09449562842, 4507.706999045085, 4511.639068874482, 4537.137943790669, 377476.0, 379342.0, 379455.0, 379651.0, 380951.0, 34872.82563587216, 35005.299894001975, 35046.82476587601, 60081.0, 60516.69741651264, 37331.626683732815, 37349.813250934116, 37463.43804842875, 37579.06052348713, 37776.0, 14574.19841908684, 14602.780958285633, 14636.414543418357, 14642.194679292528, 14649.560513184622, 11424.028957538536, 11477.311361318347, 11502.94248528752, 11632.069434445224, 11743.0, 8380.8742868857, 8385.580720963928, 8387.203215694499, 8393.664253429917, 8445.324374050062, 3215.437298472758, 3230.854611542486, 3247.123276715321, 3289.555909952174, 3353.836775279931, 1028.2339656955467, 1068.369661899483, 1069.8288273876142, 1084.8806631270554, 1168.5968340922368, 33221.83389083087, 33344.0, 33361.165970850925, 33640.0, 34091.82954085214, 1090.4820210400155, 1110.4725255503572, 1144.9141314401454, 1158.223989926751, 1184.6860581945791, 17283.481495555152, 17295.74056389155, 17509.467809447724, 17599.03205323694, 17604.119794010247, 585233.0, 599599.0, 604053.0, 604651.7441540669, 608842.0, 61164.0, 61794.0, 61900.0, 62163.689181554706, 62228.0, 1348.339313736262, 1385.9722805544034, 1393.4565519447424, 1400.5308221745624, 1403.1440821099122, 31683.841580792872, 31785.523217151298, 31977.840110799298, 32265.35469290554, 32772.672273277916, 52923.73538132285, 53029.469705304, 53269.733651333045, 53338.46661533335, 53403.46596533985, 352017.0, 353947.0, 354544.0, 355365.0, 355718.0, 28308.85845570759, 28380.148595542167, 28551.857240713663, 28788.280292992844, 28916.0, 44312.0, 44383.11233775371, 45321.77339113415, 48871.266930996775, 50644.746776265885, 41966.79016604897, 43825.780871096715, 43970.0, 43996.780016099714, 44839.0, 41795.37306940337, 43033.7848310769, 43391.34912976245, 43428.348574770775, 43706.562934370246, 41931.0, 42355.576444235165, 42598.0, 42638.36042459303, 42883.35674964941, 37906.83149765573, 38625.22749544937, 39318.0, 39463.80268098641, 39721.40417893792, 28692.856535717186, 28831.855840720662, 28885.0, 29126.417471650024, 29303.560446592892], "value": 19111.73123161924, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.273714468221, 386.7602086706242, 389.851856294608, 391.11607766447827, 400.6894656641103, 18551.257949682014, 19770.0, 20511.794882051192, 20956.16175352986, 20998.8450635215, 19655.901720491376, 19857.900710496462, 20306.289279875207, 20391.796082039175, 20457.079431425584, 5347.946520534803, 5547.889042219153, 5721.628094173886, 5971.432713892195, 5988.640681559121, 5768.5385169186575, 5860.296764388279, 5896.734646940898, 5909.734061967221, 5911.556633252501, 5458.9454105459035, 5663.753974125706, 5714.942850571503, 5793.681347525884, 5862.824115276549, 5708.115242137475, 5757.827265182052, 5880.794172203974, 6304.117423560705, 6385.680715964229, 5788.04497257952, 5806.970965145148, 5812.505936995361, 5813.4477224664015, 5827.271591051119, 13861.514846980408, 14689.118652880861, 14691.045082069631, 14696.485623003251, 14712.411503539846, 2338.543983923136, 2346.4485845826216, 2392.748761380065, 2557.6802899637546, 2610.9477810443873, 9700.563474643657, 10159.746006349826, 10349.22380821434, 10737.731556711067, 14884.62788430298, 1789.3111152206363, 1797.451777207951, 1850.5928695686928, 1888.5089876632037, 1949.3177387914116, 72091.27908720898, 82091.58954205191, 85099.14900850975, 85873.57063214706, 89268.55365723195, 10888.0, 11165.330080195214, 11298.887011129784, 11361.943190283995, 11621.571636367124, 15645.295961681752, 15782.763258551131, 15800.525984220492, 15850.365985360457, 15857.762133568005, 8381.664733410717, 8392.664293428195, 8730.476171429735, 8739.21347078766, 8824.0, 8068.919310806934, 8097.2307630774985, 8170.264676179054, 8253.257206851413, 8291.8341633167, 4738.147133516, 4740.146773580788, 4788.4253889533475, 4792.614757496921, 4811.735354555533, 1968.193040853272, 1989.3932350632906, 2028.9797102029086, 2033.6237796007786, 2068.844836637258, 445.4209527614089, 483.6976889444097, 992.6575331510762, 1055.466989170464, 1056.8150573649734, 11855.703607409883, 12454.626361209179, 12471.812922806164, 12520.123591348518, 12551.623451296477, 452.38249789037724, 463.5248869908371, 487.9634027447956, 489.7012822178468, 492.96795708279564, 6596.769113081019, 6597.80206593803, 6638.103855979478, 6640.900386494206, 6666.933330666729, 541313.0, 544719.0, 553526.0, 560981.0, 562723.0, 60863.39136608577, 88737.0, 90566.0, 93324.0, 98120.0, 484.8230395905469, 498.3023766726612, 498.7954938475208, 499.6402590135097, 499.7301457213137, 10874.891251087387, 11103.555857765921, 11318.547258109913, 11539.36533490666, 11672.416379181177, 41166.1766764669, 42153.57846421497, 43057.56942430536, 43523.56476435322, 43990.780046099564, 58255.41744582669, 61407.0, 61656.383436165066, 62225.37774622377, 63581.682091589246, 8399.328053755808, 8452.112528184452, 8471.0, 8517.318614510948, 8653.0, 9342.0, 13021.242132312016, 13430.529931452353, 13579.0, 13639.181649101085, 11780.823287650863, 12019.519219231133, 12087.516499339928, 12191.51233950632, 12232.204906681038, 11333.150013748836, 11399.145064120059, 11595.768084638428, 11636.0, 11684.47419866125, 11285.548578056785, 11613.709657258636, 11916.344601047025, 12373.443195056425, 12396.194247373893, 8267.503949763033, 8412.158784121539, 8543.0, 8587.570621468776, 8678.652853886026, 8531.573421329032, 11310.83033754478, 11795.174337796272, 11866.644000679993, 11929.403529823301], "value": 8502.536920737306, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1483.896127271091, 1534.048889688393, 1663.5674724571616, 1763.3916298876884, 1807.6475087357962, 7876.5667888266125, 8673.04596494386, 8678.088800675932, 9249.260059195265, 9263.980962094172, 8948.06045365237, 8950.239229665487, 8950.641974321019, 9001.234895033913, 9006.954965225164, 2358.5282943411303, 2389.685672879918, 2392.162743039931, 2402.8077753779658, 2409.8915548800346, 2332.3119679694532, 2368.336865677613, 2375.904963801446, 2380.214529205367, 2386.2364043506086, 2358.151065616377, 2368.3250273672006, 2373.4303767095857, 2403.134871446278, 2404.1104791227185, 2260.242818655752, 2260.8530445520987, 2261.321603518946, 2264.818814494845, 2315.5021670340957, 2208.4699672078746, 2211.966820497678, 2224.7552769195377, 2228.097620463715, 2242.3609271357586, 9011.459312441275, 9105.408148470327, 9120.0, 9171.0, 9189.402688825205, 5384.9730751346, 5483.122700367922, 5500.532454741352, 5513.862153446155, 5514.531264842493, 3292.5555050068415, 3323.135984643986, 3359.0930448778936, 3391.0505058583635, 3429.9485507717404, 1038.1383451735041, 1068.2255364860491, 1069.0645685025602, 1073.4739977411011, 1081.1080608934365, 12601.810972835507, 12678.746425071538, 12696.80954785679, 12722.936385318108, 12762.553310634083, 4760.833370832073, 4817.494163112893, 4866.124097662384, 4926.088673595396, 4971.6271279654175, 10513.896040915746, 10683.519241634145, 10686.51910664022, 10727.356358618508, 10790.136789056856, 5529.861753456195, 5547.750351234205, 5573.916391254134, 5576.9163462548095, 5578.30271216098, 4335.414719012956, 4939.90120197594, 5033.823816166489, 5042.520960508819, 5138.0, 3958.940615890764, 4026.0941288210506, 4100.897477563025, 4127.360259159835, 4133.441985332001, 1188.8097904335266, 1212.4119801896074, 1218.8902998730157, 1226.92638441692, 1275.005495713345, 1005.4269066631949, 1007.6120693533043, 1011.8633984412157, 1024.2113572549094, 1032.9793404131876, 6158.692065396713, 6333.873322533524, 6368.395002474757, 6400.807975760735, 6403.295637479873, 451.45148644397216, 454.6113073322262, 458.6674660870842, 459.65755512143664, 467.2873867352315, 4333.978330108329, 4403.823847046082, 4485.955140448554, 4488.438945131858, 4515.187266292033, 11000.0, 11235.550577976954, 11286.097112231002, 11326.660200194008, 11362.261453005529, 11169.329840209613, 11181.32912025281, 11201.943990279997, 11206.159538034517, 11209.271397359145, 8005.719799807095, 8073.919260807317, 8345.833083338299, 8348.66605335792, 8479.745607631658, 6330.3669633036325, 6379.649119298298, 6538.640374779243, 6622.536422450382, 6637.535372523877, 10301.9484902575, 10482.895171048496, 10582.153427725918, 10717.35695858251, 10730.356178629307, 10298.948505257425, 10477.790444190921, 10759.408232547285, 10785.460726963463, 10828.5127169276, 6909.930900690929, 7683.577403242875, 7935.1271360149185, 7973.282404583615, 8083.19168083187, 8748.956255218938, 8779.517126558101, 8813.647454101763, 8813.735587932373, 8827.867581986404, 7655.732049378245, 7799.9220007799195, 7826.530408175528, 7976.601169941596, 8012.118666946748, 7880.408969327209, 7899.0, 7910.2089791020435, 7972.162922893012, 7974.16271291506, 7242.348188663045, 7303.817404564928, 7339.669714862951, 7345.118585769742, 7401.0748656417945, 5430.755615997211, 5440.319960004999, 5491.478309560585, 5522.337319521523, 5568.55451563882, 5405.378381486022, 5544.0575102231915, 5557.72211389437, 5648.491635752802, 5695.829125126253], "value": 4679.166426911848, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [317.2702783597725, 321.9967800321996, 323.4808132946621, 330.9007297810657, 331.48785126978817, 5669.376368599451, 5688.488036076752, 5696.943030569693, 5720.856978575538, 5748.913766293509, 5565.276514053177, 5568.749406276717, 5591.0, 5629.887402251952, 5632.324121105463, 4142.212979533879, 4241.300185469394, 4329.307310830268, 4331.242032644291, 4351.151525452522, 4323.125121794019, 4330.415393921828, 4333.1117120990275, 4376.256036473807, 4385.342198670193, 4374.890627734316, 4375.890602734941, 4381.408509851161, 4382.233109205892, 4396.164728701552, 4255.999680150325, 4319.8488052918, 4326.329418940069, 4350.12997400518, 4356.934645980313, 3785.0915780212827, 3785.1861849702445, 3798.9620103798884, 3799.6010418905894, 3809.5904515329507, 5508.091164957777, 5517.917231241535, 5533.861653458655, 5534.640248383842, 5537.473939975695, 4793.856184314476, 4864.1974074277705, 4881.316615673809, 4894.528263227047, 5002.849344650715, 5844.45122042659, 5866.178734977107, 5873.177755114288, 5927.051671732502, 5946.769961264526, 4150.211459822624, 4157.10622216222, 4159.064210552631, 4164.5210800758, 4187.623113919732, 5785.334686511063, 6094.603850749687, 6102.20671312731, 6162.96918515409, 6163.87672246557, 4208.36874468826, 4248.024668529149, 4262.957370426318, 4268.509121451011, 4289.656827453796, 4284.400183974246, 4310.159518893785, 4321.286987647003, 4323.286657701444, 4324.891877703082, 4776.832810851603, 4922.212446008693, 4957.380327459067, 4958.677685950402, 4983.103041452573, 5944.910826337608, 5949.8215053548465, 5954.315253745788, 5972.850678733066, 5982.880342393128, 1467.4130347860942, 1479.5487376350316, 1490.6646004648867, 1492.6268432891777, 1496.8698632532369, 937.7527887909065, 986.161762501882, 1002.8445590933417, 1008.8032833597379, 1009.4448053570507, 5603.497813866334, 5663.518600918968, 5666.886662266732, 5688.829335119953, 5697.259356283739, 6044.7582096716515, 6072.666003369857, 6077.969610151921, 6083.847903802441, 6109.0, 5449.3460784706085, 5674.801381951695, 5699.971500142473, 5776.740046697909, 5785.611453251189, 3287.4904389819617, 3289.276359200972, 3298.9835050825072, 3304.520844477537, 3317.0712200583876, 6206.379362063757, 6301.8109456716375, 6359.268684101295, 6359.523035772336, 6382.521310901701, 6217.533684973645, 6279.843003924939, 6286.402791734869, 6300.401461861115, 6300.653464059429, 6090.451859332681, 6300.684031438479, 6323.936760632427, 6356.77751278703, 6358.586691865014, 6094.908576371269, 6112.510999120149, 6114.816555503164, 6121.081837724377, 6181.938180618136, 6067.757289708362, 6100.328963814066, 6100.847478812888, 6113.205283313141, 6154.692265386623, 6020.39796020412, 6276.1799078266795, 6290.465310448663, 6315.431611155018, 6337.271213810471, 4195.804195804181, 4214.1361020991235, 4240.575942405735, 4250.0, 4255.553166917429, 5897.292324921037, 6100.145979562776, 6170.321264660974, 6175.351588083367, 6184.752609895734, 5963.807238552394, 5990.820275391745, 6010.549208809444, 6024.006039003515, 6036.0, 6004.939950600613, 6011.587276989992, 6011.699415029144, 6039.305479869696, 6043.8186854394435, 5687.573431992534, 5966.552508561962, 5994.31065427464, 5994.6403215807195, 6010.849728756816, 5986.850328741816, 6034.426729460694, 6092.360302168208, 6111.449969502766, 6113.786017489367, 5607.971960140173, 5862.589618726819, 5905.4685078343155, 5934.1900720279, 5978.581499295007], "value": 4499.885555322726, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [756.5044895593388, 760.5056713136464, 778.750799744082, 782.1607564540716, 794.0947320055136, 14845.331960061796, 15801.367945282203, 15885.84114158858, 15896.04623722576, 15934.0, 15242.466513672023, 15463.30415131319, 15470.458533951314, 15481.225938703075, 15498.5350439487, 658.5883822610868, 777.7122464688073, 792.7106606088765, 797.8803179523089, 815.4088285992667, 799.6201804143044, 803.8874557561917, 805.2350267246111, 812.3947658994058, 813.3086876155251, 854.239726643288, 856.2764464027887, 856.5674334461088, 857.2327766648846, 858.6737039924819, 845.9280961118312, 852.7953291210096, 853.0318088969003, 855.6149732620346, 855.9828803423928, 616.3466725271227, 617.0189398855796, 617.5646169450526, 620.7951376045894, 621.7264403662374, 15363.308651110727, 15505.689886202326, 15508.0, 15523.611909702235, 15527.534173974798, 15223.238838058052, 15519.922400387926, 15627.609309767233, 15675.294611742385, 15806.9209653951, 11684.415779211091, 12183.390830458531, 12250.632481025583, 12263.570775022832, 12267.877321226852, 3968.206358728237, 4017.6986725995666, 4089.5297040840387, 4102.425660407545, 4117.444145040411, 72256.63871680608, 73397.6330118346, 73936.6303168486, 74048.25951740467, 74496.62751686262, 11127.777444451065, 11547.595834145764, 11558.826617600742, 11666.766664666658, 11805.40972951349, 22481.887590561942, 22483.775162248494, 22556.436089097904, 22632.886835565718, 22932.6240425575, 8574.871376929352, 8646.6973655923, 8653.956730216309, 8811.515366654767, 8869.290456763443, 4523.7285762854335, 4585.816567337336, 4709.340692303081, 4724.456687480983, 4868.683535570177, 3523.101609089717, 3627.7279204059273, 3631.473436351767, 3632.3824949758077, 3633.1462106404974, 619.755196697302, 623.2676604989119, 638.6487431912429, 639.9808005759742, 644.4168027934727, 664.6244871647503, 680.5610381304031, 705.4603228530178, 718.8131085917595, 725.1986554856912, 10046.648367307109, 10320.741981450525, 10329.276950613385, 10381.0, 10541.894581054092, 759.1232126893447, 759.6581538307673, 772.837704082149, 775.972840950564, 776.0958483366927, 4657.208274593328, 4856.635752318591, 4902.142125128088, 5039.672421292605, 5046.722430266371, 71792.64103679448, 72340.0, 73219.2678073223, 95614.52192738991, 103882.4805875981, 62317.37682623207, 90257.0, 97987.51006244923, 98047.50976245073, 99392.0, 76219.0, 91520.54239728893, 91948.0, 93175.0, 93362.0, 9478.971437139051, 9708.660196893075, 9739.673724401193, 9874.901250987397, 9914.0, 53374.466255338506, 53949.0, 54089.72955135199, 54639.180412293055, 56196.15705764335, 68704.6564767173, 80782.59608702153, 82864.0, 83207.5839620798, 84032.57983710042, 12341.665175286857, 12417.503299867903, 12452.626421207378, 12574.685632859251, 12866.67833304175, 12041.157119001586, 12251.203671761306, 13059.869401305865, 13253.933730331286, 13491.662708432368, 12607.369631518204, 12761.61715148547, 12936.805947910978, 12974.481020759064, 13196.406161722938, 12446.502139914302, 12504.812427813407, 12783.488660453479, 12886.48454061827, 13291.933540332237, 12540.87459125397, 12571.87428125707, 12848.614541563767, 12923.095383323078, 13025.869741302466, 9859.161971232526, 9880.25898057663, 10182.898171018194, 10439.530221139916, 10454.486417360165, 9684.837819461709, 10182.796344072929, 10365.689029329133, 10389.220808439246, 10400.791984160425], "value": 7490.726973173345, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1525.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 112.0, 104.0, 110.0, 110.0, 112.0, 113.0, 116.0, 112.0, 112.0], "value": 110.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 116.0, 142.0, 189.0, 120.0, 152.0, 144.0, 120.0, 171.0, 123.0], "value": 142.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 162.0, 163.0, 160.0, 168.0, 165.0, 175.0, 163.0, 161.0, 164.0], "value": 164.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 81.0, 157.0, 76.0, 76.0, 76.0, 76.0, 174.0, 76.0], "value": 94.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 158.0, 84.0, 84.0, 84.0, 141.0, 83.0, 83.0, 153.0], "value": 104.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 117.0, 118.0, 118.0, 117.0, 118.0, 119.0, 117.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 147.0, 147.0, 146.0, 147.0, 147.0, 147.0, 146.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 96.0, 95.0, 96.0, 95.0, 101.0, 101.0, 95.0, 96.0], "value": 96.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 52.0, 53.0, 52.0, 53.0, 52.0, 52.0, 53.0, 52.0, 58.0], "value": 53.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 62.0, 62.0, 62.0, 62.0, 61.0, 62.0, 65.0, 63.0], "value": 62.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 83.0, 84.0, 81.0, 80.0, 77.0, 76.0, 84.0, 76.0], "value": 79.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 140.0, 134.0, 128.0, 134.0, 125.0, 123.0, 121.0, 156.0, 121.0], "value": 130.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 160.0, 160.0, 160.0, 159.0, 160.0, 161.0, 161.0, 164.0, 159.0], "value": 160.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 64.0, 63.0, 64.0, 62.0, 63.0, 63.0, 63.0, 62.0], "value": 63.4, "unit": "score"}]}]} 21:49:17 INFO - Return code: 0 21:49:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:49:17 ERROR - # TBPL SUCCESS # 21:49:17 INFO - Running post-action listener: _resource_record_post_action 21:49:17 INFO - ##### 21:49:17 INFO - ##### Finished run-tests step (success) 21:49:17 INFO - ##### 21:49:17 INFO - Running post-run listener: _resource_record_post_run 21:49:17 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 570687488; Read time: 12; Write time: 442180 21:49:17 INFO - TinderboxPrint: CPU usage
13.2% 21:49:17 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 21:49:17 INFO - TinderboxPrint: I/O write bytes / time
570,687,488 / 442,180 21:49:17 INFO - TinderboxPrint: CPU idle
8,243.7 (86.7%) 21:49:17 INFO - TinderboxPrint: CPU user
1,205.9 (12.7%) 21:49:17 INFO - TinderboxPrint: Swap in / out
0 / 0 21:49:17 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 0; Write bytes: 272904192; Read time: 0; Write time: 238604 21:49:17 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 4096; Write bytes: 297783296; Read time: 12; Write time: 203576 21:49:18 INFO - Running post-run listener: _upload_blobber_files 21:49:18 INFO - Blob upload gear active. 21:49:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:49:18 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 21:49:18 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 21:49:18 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 21:49:18 INFO - (blobuploader) - INFO - Open directory for files ... 21:49:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:49:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:49:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:49:27 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:49:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:49:27 INFO - (blobuploader) - INFO - Done attempting. 21:49:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 21:49:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:49:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:49:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 21:49:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:49:29 INFO - (blobuploader) - INFO - Done attempting. 21:49:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 21:49:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:49:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:49:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 21:49:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:49:29 INFO - (blobuploader) - INFO - Done attempting. 21:49:29 INFO - (blobuploader) - INFO - Iteration through files over. 21:49:29 INFO - Return code: 0 21:49:29 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:49:29 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:49:29 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/8ade1d2c5e5da59fd76b6f5e76f282ab74de51497eeafb7234c7a69de7f9a6f1c8c30d7dacb1b6271dce2c1dc4de2979aeb6f1dc5f7d1f78663540f7d0fefbe2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/f9c23319661fa59832f0c871192549ef7c8608cc4b098f63e40fc30880cd9168283405cf55f7eb3766d9cf7bff54e2bec02b0484abfc24f691a3cbae89da0e16", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/755c4ef4927fec079eb293de564d06a183414d8489bbab4068e52d48689b3772e3f948d3b50030797f369c91633c40403aa4f38bfab166668dae9e08f268a488"} 21:49:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:49:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:49:29 INFO - Contents: 21:49:29 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/8ade1d2c5e5da59fd76b6f5e76f282ab74de51497eeafb7234c7a69de7f9a6f1c8c30d7dacb1b6271dce2c1dc4de2979aeb6f1dc5f7d1f78663540f7d0fefbe2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/f9c23319661fa59832f0c871192549ef7c8608cc4b098f63e40fc30880cd9168283405cf55f7eb3766d9cf7bff54e2bec02b0484abfc24f691a3cbae89da0e16", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/755c4ef4927fec079eb293de564d06a183414d8489bbab4068e52d48689b3772e3f948d3b50030797f369c91633c40403aa4f38bfab166668dae9e08f268a488"} 21:49:29 INFO - Running post-run listener: copy_logs_to_upload_dir 21:49:29 INFO - Copying logs to upload dir... 21:49:29 INFO - mkdir: /builds/slave/test/build/upload/logs 21:49:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.430192 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-07-18 21:49:29.751862) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-18 21:49:29.755426) ========= 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=8887e36bb8e381bfd44124ac000001a8-1468902532.252852-13128552 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/sha512/8ade1d2c5e5da59fd76b6f5e76f282ab74de51497eeafb7234c7a69de7f9a6f1c8c30d7dacb1b6271dce2c1dc4de2979aeb6f1dc5f7d1f78663540f7d0fefbe2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/f9c23319661fa59832f0c871192549ef7c8608cc4b098f63e40fc30880cd9168283405cf55f7eb3766d9cf7bff54e2bec02b0484abfc24f691a3cbae89da0e16", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/755c4ef4927fec079eb293de564d06a183414d8489bbab4068e52d48689b3772e3f948d3b50030797f369c91633c40403aa4f38bfab166668dae9e08f268a488"} build_url:https://queue.taskcluster.net/v1/task/TZsXsryWQjaUWglIXBpiAQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011405 build_url: 'https://queue.taskcluster.net/v1/task/TZsXsryWQjaUWglIXBpiAQ/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/sha512/8ade1d2c5e5da59fd76b6f5e76f282ab74de51497eeafb7234c7a69de7f9a6f1c8c30d7dacb1b6271dce2c1dc4de2979aeb6f1dc5f7d1f78663540f7d0fefbe2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/f9c23319661fa59832f0c871192549ef7c8608cc4b098f63e40fc30880cd9168283405cf55f7eb3766d9cf7bff54e2bec02b0484abfc24f691a3cbae89da0e16", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/755c4ef4927fec079eb293de564d06a183414d8489bbab4068e52d48689b3772e3f948d3b50030797f369c91633c40403aa4f38bfab166668dae9e08f268a488"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-18 21:49:29.781472) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 21:49:29.781859) ========= 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=8887e36bb8e381bfd44124ac000001a8-1468902532.252852-13128552 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004445 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 21:49:29.867870) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-18 21:49:29.868238) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-18 21:49:29.868588) ========= ========= Total master_lag: 0.19 =========