builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-022 starttime: 1471523958.54 results: success (0) buildid: 20160817193029 builduid: a9d60d6febdf42ec92e8e6940018cd28 revision: 97a52326b06a07930216ebefa5af333271578904 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-18 05:39:18.536947) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-18 05:39:18.537445) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-18 05:39:18.537737) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-18 05:39:18.552760) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 05:39:18.553052) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1471523957.227924-708218960 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-18 05:39:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 226M=0s 2016-08-18 05:39:18 (226 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.179392 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 05:39:18.768683) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 05:39:18.769013) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1471523957.227924-708218960 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.081134 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 05:39:18.859219) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-18 05:39:18.859566) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 97a52326b06a07930216ebefa5af333271578904 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 97a52326b06a07930216ebefa5af333271578904 --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=9c43b49b387003dc8f5b4e5c000001c4-1471523957.227924-708218960 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-18 05:39:18,918 truncating revision to first 12 chars 2016-08-18 05:39:18,918 Setting DEBUG logging. 2016-08-18 05:39:18,918 attempt 1/10 2016-08-18 05:39:18,919 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/97a52326b06a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-18 05:39:20,249 unpacking tar archive at: mozilla-central-97a52326b06a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.753352 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-18 05:39:20.629547) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-18 05:39:20.629880) ========= script_repo_revision: 97a52326b06a07930216ebefa5af333271578904 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-18 05:39:20.630275) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-18 05:39:20.630540) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-18 05:39:20.641214) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 40 secs) (at 2016-08-18 05:39:20.641506) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=9c43b49b387003dc8f5b4e5c000001c4-1471523957.227924-708218960 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:39:20 INFO - MultiFileLogger online at 20160818 05:39:20 in /builds/slave/test 05:39:20 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:39:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:39:20 INFO - {'append_to_log': False, 05:39:20 INFO - 'base_work_dir': '/builds/slave/test', 05:39:20 INFO - 'blob_upload_branch': 'Firefox', 05:39:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:39:20 INFO - 'branch': 'Firefox', 05:39:20 INFO - 'buildbot_json_path': 'buildprops.json', 05:39:20 INFO - 'config_files': ('talos/linux_config.py',), 05:39:20 INFO - 'default_actions': ('clobber', 05:39:20 INFO - 'read-buildbot-config', 05:39:20 INFO - 'download-and-extract', 05:39:20 INFO - 'populate-webroot', 05:39:20 INFO - 'create-virtualenv', 05:39:20 INFO - 'install', 05:39:20 INFO - 'run-tests'), 05:39:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:39:20 INFO - 'download_minidump_stackwalk': True, 05:39:20 INFO - 'download_symbols': 'ondemand', 05:39:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:39:20 INFO - 'tooltool.py': '/tools/tooltool.py', 05:39:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:39:20 INFO - '/tools/misc-python/virtualenv.py')}, 05:39:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:39:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:39:20 INFO - 'installer_path': 'installer.exe', 05:39:20 INFO - 'log_level': 'info', 05:39:20 INFO - 'log_name': 'talos', 05:39:20 INFO - 'log_to_console': True, 05:39:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:39:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:39:20 INFO - 'opt_config_files': (), 05:39:20 INFO - 'pip_index': False, 05:39:20 INFO - 'sps_profile': False, 05:39:20 INFO - 'sps_profile_interval': 0, 05:39:20 INFO - 'suite': 'dromaeojs-e10s', 05:39:20 INFO - 'system_bits': '32', 05:39:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:39:20 INFO - 'title': 'talos-linux64-ix-022', 05:39:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:39:20 INFO - 'use_talos_json': True, 05:39:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:39:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:39:20 INFO - 'work_dir': 'build'} 05:39:20 INFO - [mozharness: 2016-08-18 12:39:20.887575Z] Running clobber step. 05:39:20 INFO - Running pre-action listener: _resource_record_pre_action 05:39:20 INFO - Running main action method: clobber 05:39:20 INFO - rmtree: /builds/slave/test/build 05:39:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:39:26 INFO - Running post-action listener: _resource_record_post_action 05:39:26 INFO - [mozharness: 2016-08-18 12:39:26.205390Z] Finished clobber step (success) 05:39:26 INFO - [mozharness: 2016-08-18 12:39:26.205489Z] Running read-buildbot-config step. 05:39:26 INFO - Running pre-action listener: _resource_record_pre_action 05:39:26 INFO - Running main action method: read_buildbot_config 05:39:26 INFO - Using buildbot properties: 05:39:26 INFO - { 05:39:26 INFO - "project": "", 05:39:26 INFO - "product": "firefox", 05:39:26 INFO - "script_repo_revision": "production", 05:39:26 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 05:39:26 INFO - "repository": "", 05:39:26 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 05:39:26 INFO - "buildid": "20160817193029", 05:39:26 INFO - "pgo_build": "True", 05:39:26 INFO - "basedir": "/builds/slave/test", 05:39:26 INFO - "buildnumber": 39, 05:39:26 INFO - "slavename": "talos-linux64-ix-022", 05:39:26 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:39:26 INFO - "platform": "ubuntu64_hw", 05:39:26 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:39:26 INFO - "branch": "mozilla-central", 05:39:26 INFO - "repo_path": "mozilla-central", 05:39:26 INFO - "revision": "97a52326b06a07930216ebefa5af333271578904", 05:39:26 INFO - "stage_platform": "linux64-pgo", 05:39:26 INFO - "builduid": "a9d60d6febdf42ec92e8e6940018cd28", 05:39:26 INFO - "slavebuilddir": "test" 05:39:26 INFO - } 05:39:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/VFD6jNPgSjOJan7lGhS3XQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 05:39:26 INFO - Running post-action listener: _resource_record_post_action 05:39:26 INFO - [mozharness: 2016-08-18 12:39:26.207938Z] Finished read-buildbot-config step (success) 05:39:26 INFO - [mozharness: 2016-08-18 12:39:26.208027Z] Running download-and-extract step. 05:39:26 INFO - Running pre-action listener: _resource_record_pre_action 05:39:26 INFO - Running main action method: download_and_extract 05:39:26 INFO - mkdir: /builds/slave/test/build/tests 05:39: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:39:26 INFO - trying https://queue.taskcluster.net/v1/task/VFD6jNPgSjOJan7lGhS3XQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 05:39:26 INFO - Downloading https://queue.taskcluster.net/v1/task/VFD6jNPgSjOJan7lGhS3XQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 05:39:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VFD6jNPgSjOJan7lGhS3XQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:39:26 INFO - Downloaded 1361 bytes. 05:39:26 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 05:39:26 INFO - Using the following test package requirements: 05:39:26 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 05:39:26 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:39:26 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:39:26 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:39:26 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:39:26 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:39:26 INFO - u'jsshell-linux-x86_64.zip'], 05:39:26 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:39:26 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:39:26 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 05:39:26 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:39:26 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:39:26 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:39:26 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:39:26 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:39:26 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:39:26 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:39:26 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:39:26 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:39: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:39:26 INFO - trying https://queue.taskcluster.net/v1/task/VFD6jNPgSjOJan7lGhS3XQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 05:39:26 INFO - Downloading https://queue.taskcluster.net/v1/task/VFD6jNPgSjOJan7lGhS3XQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 05:39:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VFD6jNPgSjOJan7lGhS3XQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:39:27 INFO - Downloaded 21907829 bytes. 05:39:27 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 05:39:31 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:39:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:39:31 INFO - trying https://queue.taskcluster.net/v1/task/VFD6jNPgSjOJan7lGhS3XQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 05:39:31 INFO - Downloading https://queue.taskcluster.net/v1/task/VFD6jNPgSjOJan7lGhS3XQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 05:39:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VFD6jNPgSjOJan7lGhS3XQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:39:32 INFO - Downloaded 21907829 bytes. 05:39:32 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 05:39:37 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:39:37 INFO - trying https://queue.taskcluster.net/v1/task/VFD6jNPgSjOJan7lGhS3XQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 05:39:37 INFO - Downloading https://queue.taskcluster.net/v1/task/VFD6jNPgSjOJan7lGhS3XQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 05:39:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VFD6jNPgSjOJan7lGhS3XQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:39:38 INFO - Downloaded 14413981 bytes. 05:39:38 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 05:39:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:39:38 INFO - trying https://queue.taskcluster.net/v1/task/VFD6jNPgSjOJan7lGhS3XQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 05:39:38 INFO - Downloading https://queue.taskcluster.net/v1/task/VFD6jNPgSjOJan7lGhS3XQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 05:39:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VFD6jNPgSjOJan7lGhS3XQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:39:40 INFO - Downloaded 59599188 bytes. 05:39:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VFD6jNPgSjOJan7lGhS3XQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 05:39:40 INFO - mkdir: /builds/slave/test/properties 05:39:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:39:40 INFO - Writing to file /builds/slave/test/properties/build_url 05:39:40 INFO - Contents: 05:39:40 INFO - build_url:https://queue.taskcluster.net/v1/task/VFD6jNPgSjOJan7lGhS3XQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 05:39:40 INFO - Running post-action listener: _resource_record_post_action 05:39:40 INFO - Running post-action listener: set_extra_try_arguments 05:39:40 INFO - [mozharness: 2016-08-18 12:39:40.816203Z] Finished download-and-extract step (success) 05:39:40 INFO - [mozharness: 2016-08-18 12:39:40.816428Z] Running populate-webroot step. 05:39:40 INFO - Running pre-action listener: _resource_record_pre_action 05:39:40 INFO - Running main action method: populate_webroot 05:39:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:39:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:39:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:39:40 INFO - '--tppagecycles', 05:39:40 INFO - '7'], 05:39:40 INFO - 'tests': ['tsvgm']}}, 05:39:40 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:39:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:39:40 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:39:40 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:39:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:39:40 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:39:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:39:40 INFO - 'talos_options': ['--disable-e10s'], 05:39:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:39:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:39:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:39:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:39:40 INFO - 'talos_options': ['--disable-e10s'], 05:39:40 INFO - 'tests': ['damp', 'tps']}, 05:39:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:39:40 INFO - 'tests': ['damp', 'tps']}, 05:39:40 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:39:40 INFO - 'tests': ['dromaeo_dom']}, 05:39:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:39:40 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:39:40 INFO - 'tests': ['basic_compositor_video']}, 05:39:40 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:39:40 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:39:40 INFO - 'tests': ['a11yr', 05:39:40 INFO - 'ts_paint', 05:39:40 INFO - 'tpaint', 05:39:40 INFO - 'sessionrestore', 05:39:40 INFO - 'sessionrestore_no_auto_restore', 05:39:40 INFO - 'tabpaint']}, 05:39:40 INFO - 'other-e10s': {'tests': ['a11yr', 05:39:40 INFO - 'ts_paint', 05:39:40 INFO - 'tpaint', 05:39:40 INFO - 'sessionrestore', 05:39:40 INFO - 'sessionrestore_no_auto_restore', 05:39:40 INFO - 'tabpaint']}, 05:39:40 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:39:40 INFO - 'ts_paint', 05:39:40 INFO - 'tpaint', 05:39:40 INFO - 'sessionrestore', 05:39:40 INFO - 'sessionrestore_no_auto_restore', 05:39:40 INFO - 'tabpaint']}, 05:39:40 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:39:40 INFO - 'ts_paint', 05:39:40 INFO - 'tpaint', 05:39:40 INFO - 'sessionrestore', 05:39:40 INFO - 'sessionrestore_no_auto_restore', 05:39:40 INFO - 'tabpaint']}, 05:39:40 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:39:40 INFO - 'tests': ['a11yr', 05:39:40 INFO - 'ts_paint', 05:39:40 INFO - 'tpaint', 05:39:40 INFO - 'sessionrestore', 05:39:40 INFO - 'sessionrestore_no_auto_restore', 05:39:40 INFO - 'tabpaint']}, 05:39:40 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:39:40 INFO - 'tests': ['a11yr', 05:39:40 INFO - 'ts_paint', 05:39:40 INFO - 'tpaint', 05:39:40 INFO - 'sessionrestore', 05:39:40 INFO - 'sessionrestore_no_auto_restore', 05:39:40 INFO - 'tabpaint']}, 05:39:40 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:39:40 INFO - 'tests': ['tsvgx', 05:39:40 INFO - 'tsvgr_opacity', 05:39:40 INFO - 'tart', 05:39:40 INFO - 'tscrollx', 05:39:40 INFO - 'cart']}, 05:39:40 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:39:40 INFO - 'tsvgr_opacity', 05:39:40 INFO - 'tart', 05:39:40 INFO - 'tscrollx', 05:39:40 INFO - 'cart']}, 05:39:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:39:40 INFO - 'talos_options': ['--disable-e10s'], 05:39:40 INFO - 'tests': ['tp5o']}, 05:39:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:39:40 INFO - 'tests': ['tp5o']}, 05:39:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:39:40 INFO - 'talos_options': ['--disable-e10s', 05:39:40 INFO - '--xperf_path', 05:39:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:39:40 INFO - 'tests': ['tp5n']}, 05:39:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:39:40 INFO - 'talos_options': ['--xperf_path', 05:39:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:39:40 INFO - 'tests': ['tp5n']}}, 05:39:40 INFO - 'talos.zip': {'path': '', 05:39:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:39:40 INFO - Running post-action listener: _resource_record_post_action 05:39:40 INFO - [mozharness: 2016-08-18 12:39:40.832813Z] Finished populate-webroot step (success) 05:39:40 INFO - [mozharness: 2016-08-18 12:39:40.832901Z] Running create-virtualenv step. 05:39:40 INFO - Running pre-action listener: _resource_record_pre_action 05:39:40 INFO - Running main action method: create_virtualenv 05:39:40 INFO - Creating virtualenv /builds/slave/test/build/venv 05:39:40 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 05:39:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:39:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:39:41 INFO - Using real prefix '/usr' 05:39:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:39:41 INFO - Installing distribute.............................................................................................................................................................................................done. 05:39:43 INFO - Installing pip.................done. 05:39:43 INFO - Return code: 0 05:39:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:39:43 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:39:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:39:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:43 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:39:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:39:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:43 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 0x7fc2caf8df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18cb850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c6370>, '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 0x18c98f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c9d80>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1471523957.227924-708218960', '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 05:39:43 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 05:39:43 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 05:39:43 INFO - Using env: {'DISPLAY': ':0', 05:39:43 INFO - 'HOME': '/home/cltbld', 05:39:43 INFO - 'LANG': 'en_US.UTF-8', 05:39:43 INFO - 'LANGUAGE': 'en_US:en', 05:39:43 INFO - 'LOGNAME': 'cltbld', 05:39:43 INFO - 'MAIL': '/var/mail/cltbld', 05:39:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:43 INFO - 'MOZ_NO_REMOTE': '1', 05:39:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:39:43 INFO - 'NO_EM_RESTART': '1', 05:39:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:39:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:39:43 INFO - 'PWD': '/builds/slave/test', 05:39:43 INFO - 'SHELL': '/bin/bash', 05:39:43 INFO - 'SHLVL': '1', 05:39:43 INFO - 'TERM': 'linux', 05:39:43 INFO - 'TMOUT': '86400', 05:39:43 INFO - 'USER': 'cltbld', 05:39:43 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1471523957.227924-708218960', 05:39:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:43 INFO - '_': '/tools/buildbot/bin/python'} 05:39:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:39:44 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 05:39:44 INFO - Cleaning up... 05:39:44 INFO - Return code: 0 05:39:44 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:39: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:39:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:39:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:39:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:39:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:44 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 0x7fc2caf8df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18cb850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c6370>, '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 0x18c98f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c9d80>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1471523957.227924-708218960', '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 05:39:44 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 05:39:44 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 05:39:44 INFO - Using env: {'DISPLAY': ':0', 05:39:44 INFO - 'HOME': '/home/cltbld', 05:39:44 INFO - 'LANG': 'en_US.UTF-8', 05:39:44 INFO - 'LANGUAGE': 'en_US:en', 05:39:44 INFO - 'LOGNAME': 'cltbld', 05:39:44 INFO - 'MAIL': '/var/mail/cltbld', 05:39:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:44 INFO - 'MOZ_NO_REMOTE': '1', 05:39:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:39:44 INFO - 'NO_EM_RESTART': '1', 05:39:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:39:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:39:44 INFO - 'PWD': '/builds/slave/test', 05:39:44 INFO - 'SHELL': '/bin/bash', 05:39:44 INFO - 'SHLVL': '1', 05:39:44 INFO - 'TERM': 'linux', 05:39:44 INFO - 'TMOUT': '86400', 05:39:44 INFO - 'USER': 'cltbld', 05:39:44 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1471523957.227924-708218960', 05:39:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:44 INFO - '_': '/tools/buildbot/bin/python'} 05:39:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:39:44 INFO - Downloading/unpacking psutil>=3.1.1 05:39:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:39:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:39:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:39:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:39:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:39:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:39:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:39:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:39:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:39:46 INFO - Installing collected packages: psutil 05:39:46 INFO - Running setup.py install for psutil 05:39:46 INFO - building 'psutil._psutil_linux' extension 05:39:46 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 05:39:48 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 05:39:48 INFO - building 'psutil._psutil_posix' extension 05:39:48 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 05:39:48 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 05:39:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:39:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:39:49 INFO - Successfully installed psutil 05:39:49 INFO - Cleaning up... 05:39:49 INFO - Return code: 0 05:39:49 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:39:49 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:39:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:39:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:49 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:39:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:39:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:49 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 0x7fc2caf8df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18cb850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c6370>, '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 0x18c98f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c9d80>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1471523957.227924-708218960', '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 05:39:49 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 05:39:49 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 05:39:49 INFO - Using env: {'DISPLAY': ':0', 05:39:49 INFO - 'HOME': '/home/cltbld', 05:39:49 INFO - 'LANG': 'en_US.UTF-8', 05:39:49 INFO - 'LANGUAGE': 'en_US:en', 05:39:49 INFO - 'LOGNAME': 'cltbld', 05:39:49 INFO - 'MAIL': '/var/mail/cltbld', 05:39:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:49 INFO - 'MOZ_NO_REMOTE': '1', 05:39:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:39:49 INFO - 'NO_EM_RESTART': '1', 05:39:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:39:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:39:49 INFO - 'PWD': '/builds/slave/test', 05:39:49 INFO - 'SHELL': '/bin/bash', 05:39:49 INFO - 'SHLVL': '1', 05:39:49 INFO - 'TERM': 'linux', 05:39:49 INFO - 'TMOUT': '86400', 05:39:49 INFO - 'USER': 'cltbld', 05:39:49 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1471523957.227924-708218960', 05:39:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:49 INFO - '_': '/tools/buildbot/bin/python'} 05:39:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:39:49 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:39:49 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 05:39:49 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 05:39:49 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 05:39:49 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 05:39:49 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 05:39:49 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 05:39:51 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:39:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:39:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:39:51 INFO - Installing collected packages: mozsystemmonitor 05:39:51 INFO - Running setup.py install for mozsystemmonitor 05:39:51 INFO - Successfully installed mozsystemmonitor 05:39:51 INFO - Cleaning up... 05:39:51 INFO - Return code: 0 05:39:51 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:39:51 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:39:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:39:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:51 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:39:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:39:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:51 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 0x7fc2caf8df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18cb850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c6370>, '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 0x18c98f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c9d80>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1471523957.227924-708218960', '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 05:39:51 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 05:39:51 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 05:39:51 INFO - Using env: {'DISPLAY': ':0', 05:39:51 INFO - 'HOME': '/home/cltbld', 05:39:51 INFO - 'LANG': 'en_US.UTF-8', 05:39:51 INFO - 'LANGUAGE': 'en_US:en', 05:39:51 INFO - 'LOGNAME': 'cltbld', 05:39:51 INFO - 'MAIL': '/var/mail/cltbld', 05:39:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:51 INFO - 'MOZ_NO_REMOTE': '1', 05:39:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:39:51 INFO - 'NO_EM_RESTART': '1', 05:39:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:39:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:39:51 INFO - 'PWD': '/builds/slave/test', 05:39:51 INFO - 'SHELL': '/bin/bash', 05:39:51 INFO - 'SHLVL': '1', 05:39:51 INFO - 'TERM': 'linux', 05:39:51 INFO - 'TMOUT': '86400', 05:39:51 INFO - 'USER': 'cltbld', 05:39:51 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1471523957.227924-708218960', 05:39:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:51 INFO - '_': '/tools/buildbot/bin/python'} 05:39:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:39:51 INFO - Downloading/unpacking jsonschema==2.5.1 05:39:51 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 05:39:51 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 05:39:51 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 05:39:51 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 05:39:51 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 05:39:51 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 05:39:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:39:53 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:39:53 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 05:39:53 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 05:39:53 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 05:39:53 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 05:39:53 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 05:39:53 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 05:39:53 INFO - Downloading functools32-3.2.3-2.tar.gz 05:39:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:39:53 INFO - warning: no files found matching '*.txt' 05:39:53 INFO - no previously-included directories found matching 'build' 05:39:53 INFO - no previously-included directories found matching 'dist' 05:39:53 INFO - no previously-included directories found matching '.git*' 05:39:53 INFO - Installing collected packages: jsonschema, functools32 05:39:54 INFO - Running setup.py install for functools32 05:39:54 INFO - warning: no files found matching '*.txt' 05:39:54 INFO - no previously-included directories found matching 'build' 05:39:54 INFO - no previously-included directories found matching 'dist' 05:39:54 INFO - no previously-included directories found matching '.git*' 05:39:54 INFO - Successfully installed jsonschema functools32 05:39:54 INFO - Cleaning up... 05:39:54 INFO - Return code: 0 05:39:54 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:39:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:39:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:39:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:39:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:39:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:54 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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc2caf8df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18cb850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c6370>, '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 0x18c98f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c9d80>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1471523957.227924-708218960', '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 05:39:54 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', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:39:54 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 functools32==3.2.3-2 05:39:54 INFO - Using env: {'DISPLAY': ':0', 05:39:54 INFO - 'HOME': '/home/cltbld', 05:39:54 INFO - 'LANG': 'en_US.UTF-8', 05:39:54 INFO - 'LANGUAGE': 'en_US:en', 05:39:54 INFO - 'LOGNAME': 'cltbld', 05:39:54 INFO - 'MAIL': '/var/mail/cltbld', 05:39:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:54 INFO - 'MOZ_NO_REMOTE': '1', 05:39:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:39:54 INFO - 'NO_EM_RESTART': '1', 05:39:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:39:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:39:54 INFO - 'PWD': '/builds/slave/test', 05:39:54 INFO - 'SHELL': '/bin/bash', 05:39:54 INFO - 'SHLVL': '1', 05:39:54 INFO - 'TERM': 'linux', 05:39:54 INFO - 'TMOUT': '86400', 05:39:54 INFO - 'USER': 'cltbld', 05:39:54 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1471523957.227924-708218960', 05:39:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:54 INFO - '_': '/tools/buildbot/bin/python'} 05:39:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:39:54 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:39:54 INFO - Cleaning up... 05:39:54 INFO - Return code: 0 05:39:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:39:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:39:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:39:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:39:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:39:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:54 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 0x7fc2caf8df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18cb850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c6370>, '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 0x18c98f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c9d80>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1471523957.227924-708218960', '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 05:39:54 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 05:39:54 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 05:39:54 INFO - Using env: {'DISPLAY': ':0', 05:39:54 INFO - 'HOME': '/home/cltbld', 05:39:54 INFO - 'LANG': 'en_US.UTF-8', 05:39:54 INFO - 'LANGUAGE': 'en_US:en', 05:39:54 INFO - 'LOGNAME': 'cltbld', 05:39:54 INFO - 'MAIL': '/var/mail/cltbld', 05:39:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:54 INFO - 'MOZ_NO_REMOTE': '1', 05:39:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:39:54 INFO - 'NO_EM_RESTART': '1', 05:39:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:39:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:39:54 INFO - 'PWD': '/builds/slave/test', 05:39:54 INFO - 'SHELL': '/bin/bash', 05:39:54 INFO - 'SHLVL': '1', 05:39:54 INFO - 'TERM': 'linux', 05:39:54 INFO - 'TMOUT': '86400', 05:39:54 INFO - 'USER': 'cltbld', 05:39:54 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1471523957.227924-708218960', 05:39:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:54 INFO - '_': '/tools/buildbot/bin/python'} 05:39:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:39:54 INFO - Downloading/unpacking blobuploader==1.2.4 05:39:54 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 05:39:54 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 05:39:54 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 05:39:54 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 05:39:54 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 05:39:54 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 05:39:56 INFO - Downloading blobuploader-1.2.4.tar.gz 05:39:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:39:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:39:56 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 05:39:56 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 05:39:56 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 05:39:56 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 05:39:56 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 05:39:56 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 05:39:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:39:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:39:56 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 05:39:56 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 05:39:56 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 05:39:56 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 05:39:56 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 05:39:56 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 05:39:57 INFO - Downloading docopt-0.6.1.tar.gz 05:39:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:39:57 INFO - Installing collected packages: blobuploader, requests, docopt 05:39:57 INFO - Running setup.py install for blobuploader 05:39:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:39:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:39:57 INFO - Running setup.py install for requests 05:39:57 INFO - Running setup.py install for docopt 05:39:57 INFO - Successfully installed blobuploader requests docopt 05:39:57 INFO - Cleaning up... 05:39:57 INFO - Return code: 0 05:39:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:39:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:39:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:39:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:39:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:39:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:57 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 0x7fc2caf8df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18cb850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c6370>, '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 0x18c98f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c9d80>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1471523957.227924-708218960', '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 05:39:57 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 05:39:57 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 05:39:57 INFO - Using env: {'DISPLAY': ':0', 05:39:57 INFO - 'HOME': '/home/cltbld', 05:39:57 INFO - 'LANG': 'en_US.UTF-8', 05:39:57 INFO - 'LANGUAGE': 'en_US:en', 05:39:57 INFO - 'LOGNAME': 'cltbld', 05:39:57 INFO - 'MAIL': '/var/mail/cltbld', 05:39:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:57 INFO - 'MOZ_NO_REMOTE': '1', 05:39:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:39:57 INFO - 'NO_EM_RESTART': '1', 05:39:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:39:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:39:57 INFO - 'PWD': '/builds/slave/test', 05:39:57 INFO - 'SHELL': '/bin/bash', 05:39:57 INFO - 'SHLVL': '1', 05:39:57 INFO - 'TERM': 'linux', 05:39:57 INFO - 'TMOUT': '86400', 05:39:57 INFO - 'USER': 'cltbld', 05:39:57 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1471523957.227924-708218960', 05:39:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:57 INFO - '_': '/tools/buildbot/bin/python'} 05:39:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:39:58 INFO - Running setup.py (path:/tmp/pip-R24qVW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:39:58 INFO - Running setup.py (path:/tmp/pip-yA8tEE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:39:58 INFO - Running setup.py (path:/tmp/pip-n0vLa1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:39:58 INFO - Running setup.py (path:/tmp/pip-UrMbag-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:39:58 INFO - Running setup.py (path:/tmp/pip-zyBlXa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:39:58 INFO - Running setup.py (path:/tmp/pip-_oX3Uq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:39:58 INFO - Running setup.py (path:/tmp/pip-82xh6M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:39:58 INFO - Running setup.py (path:/tmp/pip-uYVTwY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:39:58 INFO - Running setup.py (path:/tmp/pip-5JFY1y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:39:58 INFO - Running setup.py (path:/tmp/pip-WrmfeS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:39:58 INFO - Running setup.py (path:/tmp/pip-AcP_1C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:39:58 INFO - Running setup.py (path:/tmp/pip-7H7kmf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:39:58 INFO - Running setup.py (path:/tmp/pip-Msuzsa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:39:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:39:59 INFO - Running setup.py (path:/tmp/pip-hkrpeY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:39:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:39:59 INFO - Running setup.py (path:/tmp/pip-JRqPuq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:39:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:39:59 INFO - Running setup.py (path:/tmp/pip-4Fb3xw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:39:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:39:59 INFO - Running setup.py (path:/tmp/pip-8R0gy4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:39:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:39:59 INFO - Running setup.py install for manifestparser 05:39:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:39:59 INFO - Running setup.py install for mozcrash 05:39:59 INFO - Running setup.py install for mozdebug 05:39:59 INFO - Running setup.py install for mozdevice 05:39:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:39:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:39:59 INFO - Running setup.py install for mozfile 05:39:59 INFO - Running setup.py install for mozhttpd 05:39:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:39:59 INFO - Running setup.py install for mozinfo 05:39:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:40:00 INFO - Running setup.py install for mozInstall 05:40:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:40:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:40:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:40:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:40:00 INFO - Running setup.py install for mozleak 05:40:00 INFO - Running setup.py install for mozlog 05:40:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:40:00 INFO - Running setup.py install for moznetwork 05:40:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:40:00 INFO - Running setup.py install for mozprocess 05:40:00 INFO - Running setup.py install for mozprofile 05:40:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:40:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:40:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:40:00 INFO - Running setup.py install for mozrunner 05:40:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:40:00 INFO - Running setup.py install for mozscreenshot 05:40:00 INFO - Running setup.py install for moztest 05:40:00 INFO - Running setup.py install for mozversion 05:40:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:40:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:40:01 INFO - Cleaning up... 05:40:01 INFO - Return code: 0 05:40:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:40: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:40:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:40:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:40:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:40:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:01 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 0x7fc2caf8df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18cb850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c6370>, '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 0x18c98f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c9d80>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1471523957.227924-708218960', '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 05:40:01 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 05:40:01 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 05:40:01 INFO - Using env: {'DISPLAY': ':0', 05:40:01 INFO - 'HOME': '/home/cltbld', 05:40:01 INFO - 'LANG': 'en_US.UTF-8', 05:40:01 INFO - 'LANGUAGE': 'en_US:en', 05:40:01 INFO - 'LOGNAME': 'cltbld', 05:40:01 INFO - 'MAIL': '/var/mail/cltbld', 05:40:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:01 INFO - 'MOZ_NO_REMOTE': '1', 05:40:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:40:01 INFO - 'NO_EM_RESTART': '1', 05:40:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:40:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:40:01 INFO - 'PWD': '/builds/slave/test', 05:40:01 INFO - 'SHELL': '/bin/bash', 05:40:01 INFO - 'SHLVL': '1', 05:40:01 INFO - 'TERM': 'linux', 05:40:01 INFO - 'TMOUT': '86400', 05:40:01 INFO - 'USER': 'cltbld', 05:40:01 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1471523957.227924-708218960', 05:40:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:01 INFO - '_': '/tools/buildbot/bin/python'} 05:40:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:40:01 INFO - Running setup.py (path:/tmp/pip-MQJLHZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:40:01 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)) 05:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:40:01 INFO - Running setup.py (path:/tmp/pip-KwXG35-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:40:01 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)) 05:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:40:01 INFO - Running setup.py (path:/tmp/pip-eU6iKc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:40:01 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)) 05:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:40:01 INFO - Running setup.py (path:/tmp/pip-nzWZQc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:40:01 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)) 05:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:40:01 INFO - Running setup.py (path:/tmp/pip-B3W96I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:40:01 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)) 05:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:40:01 INFO - Running setup.py (path:/tmp/pip-f3QTQz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:40:01 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)) 05:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:40:01 INFO - Running setup.py (path:/tmp/pip-Ac14CD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:40:01 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)) 05:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:40:01 INFO - Running setup.py (path:/tmp/pip-qbf2Fr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:40:01 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)) 05:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:40:01 INFO - Running setup.py (path:/tmp/pip-ExcIDo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:40:01 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)) 05:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:40:01 INFO - Running setup.py (path:/tmp/pip-wGWTvF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:40:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 05:40:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:40:02 INFO - Running setup.py (path:/tmp/pip-MNAjyq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:40:02 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)) 05:40:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:40:02 INFO - Running setup.py (path:/tmp/pip-lKu075-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:40:02 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)) 05:40:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:40:02 INFO - Running setup.py (path:/tmp/pip-vGWgLR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:40:02 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)) 05:40:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:40:02 INFO - Running setup.py (path:/tmp/pip-Iw1zI9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:40:02 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)) 05:40:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:40:02 INFO - Running setup.py (path:/tmp/pip-ul0ASp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:40:02 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)) 05:40:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:40:02 INFO - Running setup.py (path:/tmp/pip-1tiroy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:40:02 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)) 05:40:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:40:02 INFO - Running setup.py (path:/tmp/pip-rkLXH2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:40:02 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)) 05:40:02 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)) 05:40:02 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)) 05:40:02 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)) 05:40:02 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)) 05:40:02 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)) 05:40:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:40:02 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 05:40:02 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 05:40:02 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 05:40:02 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 05:40:02 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 05:40:02 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 05:40:04 INFO - Downloading blessings-1.6.tar.gz 05:40:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:40:04 INFO - Installing collected packages: blessings 05:40:04 INFO - Running setup.py install for blessings 05:40:04 INFO - Successfully installed blessings 05:40:04 INFO - Cleaning up... 05:40:04 INFO - Return code: 0 05:40:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:40:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:40:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:40:04 INFO - Reading from file tmpfile_stdout 05:40:04 INFO - Current package versions: 05:40:04 INFO - argparse == 1.2.1 05:40:04 INFO - blessings == 1.6 05:40:04 INFO - blobuploader == 1.2.4 05:40:04 INFO - docopt == 0.6.1 05:40:04 INFO - functools32 == 3.2.3-2 05:40:04 INFO - jsonschema == 2.5.1 05:40:04 INFO - manifestparser == 1.1 05:40:04 INFO - mozInstall == 1.12 05:40:04 INFO - mozcrash == 0.17 05:40:04 INFO - mozdebug == 0.1 05:40:04 INFO - mozdevice == 0.48 05:40:04 INFO - mozfile == 1.2 05:40:04 INFO - mozhttpd == 0.7 05:40:04 INFO - mozinfo == 0.9 05:40:04 INFO - mozleak == 0.1 05:40:04 INFO - mozlog == 3.3 05:40:04 INFO - moznetwork == 0.27 05:40:04 INFO - mozprocess == 0.23 05:40:04 INFO - mozprofile == 0.28 05:40:04 INFO - mozrunner == 6.12 05:40:04 INFO - mozscreenshot == 0.1 05:40:04 INFO - mozsystemmonitor == 0.3 05:40:04 INFO - moztest == 0.7 05:40:04 INFO - mozversion == 1.4 05:40:04 INFO - psutil == 3.1.1 05:40:04 INFO - requests == 1.2.3 05:40:04 INFO - wsgiref == 0.1.2 05:40:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:40:04 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:40:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:40:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:04 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:40:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:40:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:04 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 0x7fc2caf8df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18cb850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c6370>, '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 0x18c98f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c9d80>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1471523957.227924-708218960', '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 05:40:04 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 05:40:04 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 05:40:04 INFO - Using env: {'DISPLAY': ':0', 05:40:04 INFO - 'HOME': '/home/cltbld', 05:40:04 INFO - 'LANG': 'en_US.UTF-8', 05:40:04 INFO - 'LANGUAGE': 'en_US:en', 05:40:04 INFO - 'LOGNAME': 'cltbld', 05:40:04 INFO - 'MAIL': '/var/mail/cltbld', 05:40:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:04 INFO - 'MOZ_NO_REMOTE': '1', 05:40:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:40:04 INFO - 'NO_EM_RESTART': '1', 05:40:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:40:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:40:04 INFO - 'PWD': '/builds/slave/test', 05:40:04 INFO - 'SHELL': '/bin/bash', 05:40:04 INFO - 'SHLVL': '1', 05:40:04 INFO - 'TERM': 'linux', 05:40:04 INFO - 'TMOUT': '86400', 05:40:04 INFO - 'USER': 'cltbld', 05:40:04 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1471523957.227924-708218960', 05:40:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:04 INFO - '_': '/tools/buildbot/bin/python'} 05:40:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:40:05 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)) 05:40:05 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)) 05:40:05 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)) 05:40:05 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)) 05:40:05 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)) 05:40:05 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)) 05:40:05 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)) 05:40:05 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)) 05:40:05 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)) 05:40:05 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)) 05:40:05 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)) 05:40:05 INFO - Cleaning up... 05:40:05 INFO - Return code: 0 05:40:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:40:05 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:40:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:40:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:05 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:40:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:40:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:05 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 0x7fc2caf8df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18cb850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c6370>, '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 0x18c98f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c9d80>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1471523957.227924-708218960', '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 05:40:05 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 05:40:05 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 05:40:05 INFO - Using env: {'DISPLAY': ':0', 05:40:05 INFO - 'HOME': '/home/cltbld', 05:40:05 INFO - 'LANG': 'en_US.UTF-8', 05:40:05 INFO - 'LANGUAGE': 'en_US:en', 05:40:05 INFO - 'LOGNAME': 'cltbld', 05:40:05 INFO - 'MAIL': '/var/mail/cltbld', 05:40:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:05 INFO - 'MOZ_NO_REMOTE': '1', 05:40:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:40:05 INFO - 'NO_EM_RESTART': '1', 05:40:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:40:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:40:05 INFO - 'PWD': '/builds/slave/test', 05:40:05 INFO - 'SHELL': '/bin/bash', 05:40:05 INFO - 'SHLVL': '1', 05:40:05 INFO - 'TERM': 'linux', 05:40:05 INFO - 'TMOUT': '86400', 05:40:05 INFO - 'USER': 'cltbld', 05:40:05 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1471523957.227924-708218960', 05:40:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:05 INFO - '_': '/tools/buildbot/bin/python'} 05:40:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:40:05 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:40:05 INFO - Cleaning up... 05:40:05 INFO - Return code: 0 05:40:05 INFO - Running post-action listener: _resource_record_post_action 05:40:05 INFO - Running post-action listener: _start_resource_monitoring 05:40:05 INFO - Starting resource monitoring. 05:40:05 INFO - [mozharness: 2016-08-18 12:40:05.401316Z] Finished create-virtualenv step (success) 05:40:05 INFO - [mozharness: 2016-08-18 12:40:05.402308Z] Running install step. 05:40:05 INFO - Running pre-action listener: _resource_record_pre_action 05:40:05 INFO - Running main action method: install 05:40:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:40:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:40:05 INFO - Reading from file tmpfile_stdout 05:40:05 INFO - Detecting whether we're running mozinstall >=1.0... 05:40:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:40:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:40:05 INFO - Reading from file tmpfile_stdout 05:40:05 INFO - Output received: 05:40:05 INFO - Usage: mozinstall [options] installer 05:40:05 INFO - Options: 05:40:05 INFO - -h, --help show this help message and exit 05:40:05 INFO - -d DEST, --destination=DEST 05:40:05 INFO - Directory to install application into. [default: 05:40:05 INFO - "/builds/slave/test"] 05:40:05 INFO - --app=APP Application being installed. [default: firefox] 05:40:05 INFO - mkdir: /builds/slave/test/build/application 05:40:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:40:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:40:22 INFO - Reading from file tmpfile_stdout 05:40:22 INFO - Output received: 05:40:22 INFO - /builds/slave/test/build/application/firefox/firefox 05:40:22 INFO - Running post-action listener: _resource_record_post_action 05:40:22 INFO - [mozharness: 2016-08-18 12:40:22.648651Z] Finished install step (success) 05:40:22 INFO - [mozharness: 2016-08-18 12:40:22.648903Z] Running run-tests step. 05:40:22 INFO - Running pre-action listener: _resource_record_pre_action 05:40:22 INFO - Running main action method: run_tests 05:40:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:40:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:40:22 INFO - Python 2.7.3 05:40:22 INFO - Return code: 0 05:40:22 INFO - grabbing minidump binary from tooltool 05:40: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:40:22 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 0x18c6370>, '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 0x18c98f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c9d80>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:40:22 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 05:40:22 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 05:40:22 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 05:40:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:40:22 INFO - Return code: 0 05:40:22 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:40:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:40:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:40:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:40:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:40:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VFD6jNPgSjOJan7lGhS3XQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--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 05:40:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/VFD6jNPgSjOJan7lGhS3XQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-022 --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 05:40:22 INFO - Using env: {'DISPLAY': ':0', 05:40:22 INFO - 'HOME': '/home/cltbld', 05:40:22 INFO - 'LANG': 'en_US.UTF-8', 05:40:22 INFO - 'LANGUAGE': 'en_US:en', 05:40:22 INFO - 'LOGNAME': 'cltbld', 05:40:22 INFO - 'MAIL': '/var/mail/cltbld', 05:40:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:40:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:40:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:22 INFO - 'MOZ_NO_REMOTE': '1', 05:40:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:40:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:40:22 INFO - 'NO_EM_RESTART': '1', 05:40:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:40:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:40:22 INFO - 'PWD': '/builds/slave/test', 05:40:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:40:22 INFO - 'SHELL': '/bin/bash', 05:40:22 INFO - 'SHLVL': '1', 05:40:22 INFO - 'TERM': 'linux', 05:40:22 INFO - 'TMOUT': '86400', 05:40:22 INFO - 'USER': 'cltbld', 05:40:22 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1471523957.227924-708218960', 05:40:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:22 INFO - '_': '/tools/buildbot/bin/python'} 05:40:22 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VFD6jNPgSjOJan7lGhS3XQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--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 05:40:23 INFO - mozversion application_buildid: 20160817193029 05:40:23 INFO - mozversion application_changeset: 97a52326b06a07930216ebefa5af333271578904 05:40:23 INFO - mozversion application_display_name: Nightly 05:40:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:40:23 INFO - mozversion application_name: Firefox 05:40:23 INFO - mozversion application_remotingname: firefox 05:40:23 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:40:23 INFO - mozversion application_vendor: Mozilla 05:40:23 INFO - mozversion application_version: 51.0a1 05:40:23 INFO - mozversion platform_buildid: 20160817193029 05:40:23 INFO - mozversion platform_changeset: 97a52326b06a07930216ebefa5af333271578904 05:40:23 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:40:23 INFO - mozversion platform_version: 51.0a1 05:40:23 INFO - using testdate: 1471524023 05:40:23 INFO - actual date: 1471524023 05:40:23 INFO - starting webserver on 'localhost:38911' 05:40:23 INFO - SUITE-START | Running 2 tests 05:40:23 INFO - TEST-START | dromaeo_css 05:40:23 INFO - operating with platform_type : linux_ 05:40:23 INFO - Initialising browser for dromaeo_css test... 05:40:23 INFO - TEST-INFO | started process 3313 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqZcYNu/profile http://localhost:38911/getInfo.html) 05:40:31 INFO - PROCESS | 3313 | __metrics Screen width/height:1600/1200 05:40:31 INFO - PROCESS | 3313 | colorDepth:24 05:40:31 INFO - PROCESS | 3313 | Browser inner width/height: 1024/697 05:40:31 INFO - PROCESS | 3313 | __metrics 05:40:31 ERROR - PROCESS | 3313 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 05:40:32 INFO - TEST-INFO | 3313: exit 0 05:40:32 INFO - Browser initialized. 05:40:32 INFO - Running cycle 1/1 for dromaeo_css test... 05:40:32 INFO - TEST-INFO | started process 3433 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqZcYNu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:40:44 INFO - PROCESS | 3433 | RSS: Main: 163012608 05:40:44 INFO - PROCESS | 3433 | 05:41:33 INFO - PROCESS | 3433 | 1471524093876 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] 05:43:43 INFO - PROCESS | 3433 | Cycle 1(1): loaded http://localhost:38911/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38911/tests/dromaeo/cssquery-ext.html) 05:43:45 INFO - PROCESS | 3433 | RSS: Main: 165371904 05:43:45 INFO - PROCESS | 3433 | 05:46:47 INFO - PROCESS | 3433 | Cycle 1(1): loaded http://localhost:38911/tests/dromaeo/cssquery-ext.html (next: http://localhost:38911/tests/dromaeo/cssquery-jquery.html) 05:46:47 INFO - PROCESS | 3433 | RSS: Main: 165330944 05:46:47 INFO - PROCESS | 3433 | 05:49:49 INFO - PROCESS | 3433 | Cycle 1(1): loaded http://localhost:38911/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38911/tests/dromaeo/cssquery-mootools.html) 05:49:50 INFO - PROCESS | 3433 | RSS: Main: 166731776 05:49:50 INFO - PROCESS | 3433 | 05:52:52 INFO - PROCESS | 3433 | Cycle 1(1): loaded http://localhost:38911/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38911/tests/dromaeo/cssquery-prototype.html) 05:52:52 INFO - PROCESS | 3433 | RSS: Main: 164048896 05:52:52 INFO - PROCESS | 3433 | 05:55:55 INFO - PROCESS | 3433 | Cycle 1(1): loaded http://localhost:38911/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38911/tests/dromaeo/cssquery-yui.html) 05:55:56 INFO - PROCESS | 3433 | RSS: Main: 166588416 05:55:56 INFO - PROCESS | 3433 | 05:58:59 INFO - PROCESS | 3433 | Cycle 1(1): loaded http://localhost:38911/tests/dromaeo/cssquery-yui.html (next: http://localhost:38911/tests/dromaeo/cssquery-dojo.html) 05:58:59 INFO - PROCESS | 3433 | RSS: Main: 166842368 05:58:59 INFO - PROCESS | 3433 | 05:58:59 INFO - PROCESS | 3433 | __start_tp_report 05:58:59 INFO - PROCESS | 3433 | _x_x_mozilla_page_load 05:58:59 INFO - PROCESS | 3433 | _x_x_mozilla_page_load_details 05:58:59 INFO - PROCESS | 3433 | |i|pagename|runs| 05:58:59 INFO - PROCESS | 3433 | |0;dojo.html;3005.368872536767;3039.331347103637;3040.6351237851463;3043.7108474694896;3055.6944305569446;5169.508896654812;5290.576753859692;5316.388615309241;5332.626716129863;5373.382061062979;5332.92000619991;5355.08963476209;5366.597505187107;5377.193420986854;5477.534409575181;4790.089882922242;4850.951490485085;4913.484084171164;4913.82801601944;5108.182690769478;5030.346055012843;5050.595952323823;5054.418741844698;5080.288759573663;5089.083964886319;4683.765811709435;4774.9522504775205;4844.63665225106;4901.362822833009;4957.157283261836;4840.128776820171;4858.1012512685265;4893.535114164149;4941.950580494221;4960.503949605047;4865.489123642002;4916.606671466274;4932.136876046713;4943.406791185045;4986.650934434591;5271.551918086967;5326.493983071602;5332.360116786011;5438.83683489496;5482.588805839578;5703.885922281573;5739.253896993406;5747.59766816323;5757.740901659436;5771.942280577183;5785.971070144665;5791.797287094932;5800.709964501801;5805.535557155417;5814.3604203538;5204.609654275944;5370.677759334452;5416.322959630046;5443.346798384219;5492.423295553989;5942.108683697394;5984.551158663031;5985.880282394328;5994.190784244159;6002.279726432856;5708.029634962067;5711.143328500675;5729.226554415184;5732.942670573324;5735.2257445245195;5485.890282194414;5727.398623144593;5750.971245143831;5810.070388737781;5894.498967587803;5543.584231182677;5667.319921609351;5716.742746576414;5745.1382292656435;5770.653760774367;5784.132380143013;5784.219130417424;5799.94200057994;5804.245448091721;5804.361520232771;4294.141171765659;4364.672649551297;4402.075564131568;4406.735595864258;4457.3091170868565;3930.9213815724097;3943.645071943539;3947;3975.0658595230097;3977.960220397759;5522.282103326542;5560.944390556043;5575.191597218381;5582.441755824385;5586.469285417878;5551.972240138854;5690.9146362804595;5829.650220986754;5834.5624078194305;5869.178315035899;5555.77776888928;5575.386707462176;5593.244911936918;5599.244102046172;5605.243292155588;5048.59611231108;5057.772400241998;5062.594992400599;5065.290859279704;5091.0581542414775;5828.009238429478;6009.609375390585;6013.037913933749;6046.002409602366;6061.605995610271;5818.389069147678;5875.6474611523445;5906.911396329145;5941.049432090845;5949.2266005419015;6057.242844644419;6057.57596968208;6068.302145253352;6070.2412198475195;6080.48315893154;5523.364813046551;5673.74468148926;5724.313082430135;5795.855103622274;5808.912866306924;5791.739371728198;5853.502452291603;5858;5886.175935368966;5894.263217097863;5578.414266501959;5720.599558031065;5726.770929162787;5738.196652468741;5752.7698892043845;5465.07093794048;5583.050881350099;5713;5728.341240757366;5734.799282025276;5596.692181930033;5608.130739735348;5648.293963254593;5675.659460432387;5692.1461780733225;5647.068233741386;5729.427057294404;5729.598928075162;5732.197492351158;5752.050911599539;5366;5542.916856247079;5543.3902270751;5553.361363443094;5640.943590564042 05:58:59 INFO - PROCESS | 3433 | |1;ext.html;561.2955740545615;581.5057201378828;582.1209972940858;584.5586582130491;628.2900322635421;38769.61230387695;41955;42103;42107.99999999996;42199;42952.785236073854;43248;43664.3450348245;43713.34429983553;43809;8825.293976481882;8999.595018224196;9007.279417646572;9014.68448604299;9030.548472576378;8855.070217627153;8882.022977472472;8931.776705582348;8940.19538241558;8951.865722014176;8983.775405614846;9011.369204155711;9048.366614337;9059.547022648874;9071;8921.063288354695;8960.596773145224;8970.102989701043;8978;9007.819843603156;8912.153345432174;8952.418092823946;8958.955205223932;8963.327750418744;8979.506127163004;42095;42488.15023699509;42529.787351063045;42680.57319426828;42709;2649.218480548243;3278.262910094914;3442.913927151816;3619.1856832212807;3632.527771389729;30185.547216791765;30412.239694007607;31237.687623123933;31259.84370078135;32546.511802322984;4129.690273229489;4203.159368126387;4219.810108545123;4256.063665993476;4356.4336636237085;317711;320094;320438;321014;321451;34569.48145777815;35837.64162358395;36136.63863361385;36370.8181459091;36450;35819.4627080594;37470.62529374726;37570.62429375726;37609.81195094007;37668;13905.235212063231;14056.43774249039;14106.788398174036;14161.85838141626;14188.219647919463;11526.88473115258;11749.060075193964;11791.469383877575;11882.584109556125;11911.166218364631;8469.449485783405;8507.191816777397;8566.957165214259;8598.011228708654;8668.393212475192;3259.7718159728593;3371.8651253949565;3378.527006219131;3379.374815659111;3390.5761779777526;1035.2856528994969;1047.9004494573003;1057;1159.7970355187808;1167.311286341063;33755.156121096676;33928.49107263393;34111.31777364439;34275.314493709986;34580;1054.9789004219872;1129;1163.313644949484;1199.2504684572143;1267.790814515613;16206;17239.31042758301;17371.957682538836;17428.302867885144;17603.34045911338;584702;587725;589718;589772;591852;59035.704821475614;59111.704441477516;59379.40620593825;59572.40427595669;59767.70116149391;1315.8881495072835;1358.8980826438058;1369.8835598974;1379.9862001380059;1387.486629946926;30796;31777.364452710353;32652.673473265913;32716.83641581777;33326.500102497994;49973.500264998336;50080.248796267355;50202;50644.24033639424;50697;452277;452696;453165;454486;455109;28890.711092888803;29125.7087429123;29212.853935730185;29341.559876602296;29546.409071818875;48558;49191.754041229564;50411.49588504068;50509.747451262505;50610.74694626503;40715;42704;42907.7854610725;43204.95529247165;43242.56757432385;42689;42823;42836;42880.35679464873;43389.349159761994;42874.57125428706;43324.56675433331;43763.343549847414;44734.328985064596;47533.28700069571;32780.1804954878;38422.23155536818;39543;39848.82343236687;39941.80029099836;29068.56397154002;29375.85312073426;29812.850935745184;29859.104495426676;30298 05:58:59 INFO - PROCESS | 3433 | |2;jquery.html;369.59577945464764;380.10485307101777;381.5936028130041;392.79182033522244;404.14321638127177;15227.847721522809;17376.565585860342;19228.61542769144;20410.387688369356;20760.27339043134;19165.32921347753;19716.30992915248;19768.505787355323;19813.801861981377;19981.900090499563;5356.812511562096;5710.257666503348;5717.171010203518;5740.1102829061565;5755;5522.779088836442;5666.206731057655;5727.140928860684;5742.885142297151;5780.046292361776;5848.649081055129;5896.292444906596;5904.586678932476;5904.940950590503;5906.409359064102;5841.422815839721;5899.557533185007;6455.4835613150835;6524.478041756648;6558.114654521626;5822.475977162034;5838.766449342022;5840.211571437844;5842.24050873388;5867.178594996704;12986.28575428351;12991.675208119777;13163.539276125386;13318.334083295797;13357.33213339329;2316.9652455213186;2385.1413491143176;2424.6726691896542;2607.4263661994332;2844.630198074258;10133.39199648016;10353.378797272113;10872.891271087266;10934.398608076554;15247.847521524754;1921.2123029557815;1921.8174273444001;1943.2712732725229;1951.5121219695077;1973.506623344164;83642;86441.56779216127;86848.56575717144;87820.56089719574;89326;11123;11270.380129092979;11335.263207891625;11406.087512999105;11476.139289553317;13379.866201338056;14391.496297629532;15743.606409839846;15771.132587707556;15803.13082780435;7327.194008659043;7520.360769334558;7536.660850261751;7764.84470310602;7810.062792464827;6996.755113571001;7097.225693576605;7264.854702905912;7298.051253337032;7321.816954576178;4596.195665758479;4680.063987202573;4705.364775755298;4794.448638406628;4903.092927808367;1998.660227761284;2024.7975202479633;2067.1111422088347;2087.2381580722927;2133.5306232628795;878.2490970220497;971.9854202186973;979.9657012004545;1040.490159821697;1060.2419270221828;19314.71027934582;19354.41936741872;19367.903160484108;19415.4175374739;19856;971.9951400243095;1010.5806090472372;1030.6701855406197;1069.3904474449644;1073.3559864081644;10243.231757618209;11086.390248536247;11091.057260132979;11197.776044479066;11209.887901121048;451271;460395;466172;470692;472156;75492.62253688696;77873.61063194647;87239.56380218058;90049.99999999869;90626.54686726524;982.5283863745442;1007.5214273220308;1038.7299302181486;1046.398320965448;1052.0899421999916;16854.41009564659;16908.66182676364;17371.305147793948;17825.643487130445;18001.729974050137;32246.516302255015;42500.5749942509;43137.56862431335;43419.9145021377;44237.55762442463;57961.13058304213;58879;59061;59156.40843591509;59624.105638416324;8247.21651443112;8464.195901389357;8483.660653573788;8483.660653573788;8493.575321234037;11850.881491184979;12670.746585068431;12870.935645321713;12886.226826390446;13060.281684507063;11033.503492342703;11169.497372618414;11327.376994265394;11609.245399049034;11617;10961;11156.274842135235;11260.536130303008;11549.942250288696;11821.527138914347;11670.533178672758;11676.824847627462;11845.52617895309;11897.46461409256;12011.11733184047;8455.619497122521;8495.617697203517;8511.914880851113;8828.823423531365;8834;8803.383763136519;10989.505472253928;11352.54589816398;11709;11845.46695398692 05:58:59 INFO - PROCESS | 3433 | |3;mootools.html;1445.790360397742;1460.9707805843884;1575.88968772186;1689.5944973206433;1705.266735303819;7359.852802943938;8350.248477637011;8470.91529084709;9037.457752534852;9041.547922603868;8502.192291732275;8695.86956195656;8736.825263494726;8770.780730481742;8782.16569425905;2346.389938615959;2386.0217310902535;2387.2480168746874;2394.341556072077;2396.1254142238045;2326.906923723049;2339.1929784224417;2345.8240631952585;2349.0603758496654;2374.608189648706;2350.7296660883962;2354.799842013431;2369.3839601703507;2375.833691641577;2387.9761202388013;2259.085070546423;2261.8190544756544;2270.818334533233;2273.181654604349;2331.0326214620914;2207.404000919743;2246.1576908659254;2249.4488850231796;2264.54709058189;2271.2391348897972;8228;8288.129746376604;8295.502269863828;8303.792405189859;8342;5061.6962982221185;5182.404023537266;5186.533212010937;5186.922196167023;5191.480851914816;3191.69678880506;3194.5847039884666;3317.319949410365;3355.932881342384;3370.79775213488;1149.1151813103863;1162.8662703789003;2087.937361879146;2100.2754049852774;2179.69484272202;11418.31490110596;11427.942860285646;11437.370944598044;11529.077673786078;11534.365609891536;4085.611866872642;4212.789360531961;4267.466566679165;4366.541513141075;4391.3193455014525;9075.863862042075;9077.409968352036;9100.362974591715;9113.407628504126;9127.543622818832;4910.656254062182;5001.774920128603;5002.57478114357;5017.247412888096;5017.3226614406585;4049.7165198436414;4482.193205223091;4559.475660299108;4595.885102872455;4710.858674239778;3560.394732895414;3606.8016259106003;3642.9253370255838;3692.2061756722433;3702.148505843671;1114.9944250278697;1125.6848082536903;1137.0505627800878;1137.2380505061628;1141.058626633031;964.7588102974256;999.5102399824179;1002.5438425516519;1018.1193267823279;1049.7060822969581;5769.769209231667;5854.2096816930025;5939.346671866091;6072.089186621954;6149.66176860268;463.29579039859226;464.8791314258317;472.84396149270657;487.99024019519413;491.04001676721924;4227.42929704486;4319.503257125471;4407.889802754957;4515.096980603892;4554.521775213621;10644.414557199429;10930.180236482296;11107.111431085494;11131;11165.944170279097;10872.18458615607;10927.453627318602;10973.23187376876;11015.394153321484;11043.83434248487;7608.885866712004;7927.088384835818;7963.4027447941635;8050.31572316348;8132.2680958714;5868.735906884286;5932.614380065282;5973.432523910222;6028.517718582415;6104.359042300672;9834.75413114678;9885.308028437941;9895.851562226717;9921.206303495848;10075.496225188564;9740.464274464972;10237.795244094927;10308.742281443025;10315.432651204255;10317.123044541298;6783.559068660521;7515.6242187891485;7649.196834332538;7858.174891636524;8077.1115177329275;8183.181681831769;8421.452605580618;8451.873221901553;8465.703700370457;8466.449680770731;7187.2453392393045;7272.200057993511;7486.737964171228;7504.249575042671;7606.087269527692;7108.395786358217;7223.205447400676;7291.4166866649475;7337.926620733938;7458.589777562286;6976.4767642426;6981.965090174516;7039.472039596948;7040.718371265092;7041.049458323061;5272.815451459181;5425.511703946664;5467.371252305877;5512.641678290898;5624.184493248538;5240.240165176105;5301.946980530145;5350.250964864844;5409.161579955114;5447.1829225616475 05:58:59 INFO - PROCESS | 3433 | |4;prototype.html;314.9574807401001;317.992050198745;323.5389569862945;324.3027490894576;325.778470639965;5462;5479.4520547945185;5494.697791621465;5503.889922201563;5505.889882202354;5366.436524164965;5384.926803180774;5390.757415916283;5410.810621628244;5477;3999.600039995999;4108.198901214264;4176.519700234481;4237.788110594458;4240.300350442173;4197.958020419803;4225.7887105644595;4229.196452673998;4231.830726770941;4232.6613870890405;4204.222218889515;4258.382534532491;4270.402143699885;4270.423492828475;4281.850135245267;4124.195781822561;4236.343366778124;4252.936205956913;4274.952636604021;4283.700140990117;3749.362608356586;3769.3968964965475;3769.6994536885004;3769.792661403622;3775.9433608495897;5308.787648494055;5309.362876454811;5327.455038038964;5356.1697936819855;5369.81205657804;4751.64362672801;4850.53919877611;4900.191468407708;4912.312276281324;4929.359183306147;5645.8588535286535;5653.180288858133;5653.349864765522;5675.659460432387;5690.5447564194765;4147.958520414787;4153.501579810442;4161.583841615845;4166.145940082306;4168.103857670585;5621.156826476021;5885.529157667376;5901;5911.55663325248;6000.229932169977;4088.979555102265;4103.199876024147;4113.239050775616;4121.083696081337;4122.134351786159;4145.046639272924;4167.2082304362075;4177;4186.81159347824;4196.853110141192;4681;4826.975865120722;4828;4871.464138944713;4925.605951523869;5779.393163717749;5791.478766910998;5801.53587712982;5805.970970145207;5816.709164541756;1491.5599898030107;1507.2539093148741;1513.4702854001011;1514;1523.8704710099544;928.6007016982762;964.6479035152119;979.1383582447543;988.8170688422665;998.9250806189565;5490.231367608538;5515;5516.9448305517235;5532.474414930575;5550.888982220414;5827.4172582741385;5866.70666466675;5881.676737688589;5933.762649494059;5936.970315148396;5373.328333958255;5450.3732070811575;5493.258410114663;5495.6153069285565;5549.667019978814;3088.382323535302;3117;3121.877123556004;3125.4374212641487;3140.2306434923134;5856.502197313276;6045.848853778691;6107.144999700045;6109.20580324555;6124.234470691164;6036.969815150984;6060.181875446759;6076.726547305382;6095.664738439428;6099.420555047263;6130.773845230882;6133.478654314344;6177.752889884444;6186.185285694998;6187.3912782675925;5594.748236329294;5923.437273459014;5944.405559444194;5976.103584462366;6012.8797424052145;5899.557533184942;5923.170756094064;5979.282486101695;5982.371850955761;6008.459238668541;5858.736356863866;6120.632762034292;6186.226721659793;6241.658043520665;6283.183186185766;4107.342825147962;4108.281050816155;4131.256373852735;4136.793160341911;4141.6065473779945;5880.588358814842;5934.821955341346;5947.702614869153;5987.940120598738;5990.281166260077;5584.246126772834;5658.688772117408;5720.598453378949;5724.914126288192;5776.249087618583;5692.48767610917;5697.81210810046;5703.543716502587;5703.74517606126;5723.828285151452;5182.429932707475;5643.238162848127;5660.37735849048;5686.943130568641;5688.943110568841;5724.914126288026;5728.455796699307;5751.5398768099285;5756.769729210952;5770.192173095854;5621.634593751393;5635.802746903839;5642.210090587403;5703.714814259353;5704 05:58:59 INFO - PROCESS | 3433 | |5;yui.html;746.7125156814628;762.9122650895147;767.2442643995666;806.4475834053671;831.7557798083092;16690.16549172541;17540.736888946674;17612.11939403028;17613.207405666744;17729.847559908598;15648.061116333029;15889.44386946457;15893.125878076702;15910.443134490295;15927.124008179575;646.0761111610395;775.3138472451892;801.9599020049003;803.1446509467428;808.5108509351817;806.7378102116807;812.597764106768;820.0774129104757;821.4537332673765;821.6549049399237;862.06465984407;862.3360012790148;875.2691502595341;875.3128793896792;876.6186708781669;864.844328020956;867.1242045533993;867.2758246863908;869.9130086991313;873.2097451806126;636.0649844728242;637.0221709675671;637.2289529669106;637.6461064109418;638.0142679560091;15750.291236894367;15751.763723544156;15759;15766.211689415484;15778.053316801028;13683.452661893512;14030.368633411521;16027.51917442467;16040.11779352135;16050.518484445369;13486.001285519955;13693.315334233248;13746;13898.16611003343;14885;4467.7542735149555;4526.366308716782;4579.496255411902;4626.421697287839;4829.275608658694;93577.53211233969;94276.52861735717;94392;94763.52618236865;95007.52496237475;10940.179486538382;11311.660650180507;11370.829437558443;11402.429878506207;11416.088897331127;20058.598828023358;21081.578368432547;21127.26054588082;21184.682229766568;21359.893200533897;8682.826343473222;8883.911160888309;8970.327225457986;8996.901742396245;9285.396449230779;4844.491328410537;4903.338049363361;4973.278874563168;5087.898242035212;5098.923516147261;3566.7681600695873;3668.779873207616;3676.889693309205;3688.6864616507896;3692.0585250760882;648.844277373427;652.5627829354344;663.190907093355;665.2582370656683;666.6799936030635;669.7454967112466;713.6697493235039;730.9963450182715;731.5683746589432;748.7603966730703;10040.69877903664;10298.742531436774;10316.845247321296;10399.584016639401;10477.9476102619;734.2620666230404;742.4468770765814;746.4550877859085;750.1897950213756;760.5968836516655;4801.423829140525;5039.496050395004;5068.949310506921;5070.974645126751;5076.543111119943;72807;90232.5488372554;134816.32591837173;135459;136426;68969.3103068973;69275.30724692688;71776;111680;115613.843861562;60254.37201907787;100854;101037;103848;104322.47838760758;9367.156955873732;9570.377925434825;9819.9018009819;9844.409335439897;9948.701538953843;58309.4169058321;58921.70539147448;59097.40902590919;60109.39890601213;61577;78572.60713696624;80801.59599201966;88385.55807220923;90815.54592226997;92925.5353723227;12896.097273190786;12938.805917911428;12952.546660867201;12970.35148242603;13487.595372138852;15514.37942482288;15771.526854194393;16296.837031630006;16317.719836502927;16415.589610259838;14511;15076.547703568911;15091.320890559731;15164.24178791034;15226.390944362101;14288.427323430922;14693.779593305895;14882.10707357562;15023.849761502244;15512.612184695472;12637.620871373874;12659.240445573296;12800.487980480677;12833.230006199658;12934.676633084247;11564.357621645322;12180.473519630645;12217.877821221675;12315.384230788604;12326.383680816103;10293.794124117625;10707.464626768786;12304.200226985216;12334.136610437183;12453.750924981268 05:58:59 INFO - PROCESS | 3433 | __end_tp_report 05:58:59 INFO - PROCESS | 3433 | __start_cc_report 05:58:59 INFO - PROCESS | 3433 | _x_x_mozilla_cycle_collect,311 05:58:59 INFO - PROCESS | 3433 | __end_cc_report 05:58:59 INFO - PROCESS | 3433 | __startTimestamp1471525139528__endTimestamp 05:58:59 INFO - PROCESS | 3433 | 05:58:59 INFO - PROCESS | 3433 | ------- Summary: start ------- 05:58:59 INFO - PROCESS | 3433 | Number of tests: 6 05:58:59 INFO - PROCESS | 3433 | 05:58:59 INFO - PROCESS | 3433 | [#0] dojo.html Cycles:165 Average:5383.15 Median:5586.47 stddev:630.46 (11.3%) stddev-sans-first:604.17 05:58:59 INFO - PROCESS | 3433 | Values: 3005.4 3039.3 3040.6 3043.7 3055.7 5169.5 5290.6 5316.4 5332.6 5373.4 5332.9 5355.1 5366.6 5377.2 5477.5 4790.1 4851.0 4913.5 4913.8 5108.2 5030.3 5050.6 5054.4 5080.3 5089.1 4683.8 4775.0 4844.6 4901.4 4957.2 4840.1 4858.1 4893.5 4942.0 4960.5 4865.5 4916.6 4932.1 4943.4 4986.7 5271.6 5326.5 5332.4 5438.8 5482.6 5703.9 5739.3 5747.6 5757.7 5771.9 5786.0 5791.8 5800.7 5805.5 5814.4 5204.6 5370.7 5416.3 5443.3 5492.4 5942.1 5984.6 5985.9 5994.2 6002.3 5708.0 5711.1 5729.2 5732.9 5735.2 5485.9 5727.4 5751.0 5810.1 5894.5 5543.6 5667.3 5716.7 5745.1 5770.7 5784.1 5784.2 5799.9 5804.2 5804.4 4294.1 4364.7 4402.1 4406.7 4457.3 3930.9 3943.6 3947.0 3975.1 3978.0 5522.3 5560.9 5575.2 5582.4 5586.5 5552.0 5690.9 5829.7 5834.6 5869.2 5555.8 5575.4 5593.2 5599.2 5605.2 5048.6 5057.8 5062.6 5065.3 5091.1 5828.0 6009.6 6013.0 6046.0 6061.6 5818.4 5875.6 5906.9 5941.0 5949.2 6057.2 6057.6 6068.3 6070.2 6080.5 5523.4 5673.7 5724.3 5795.9 5808.9 5791.7 5853.5 5858.0 5886.2 5894.3 5578.4 5720.6 5726.8 5738.2 5752.8 5465.1 5583.1 5713.0 5728.3 5734.8 5596.7 5608.1 5648.3 5675.7 5692.1 5647.1 5729.4 5729.6 5732.2 5752.1 5366.0 5542.9 5543.4 5553.4 5640.9 05:58:59 INFO - PROCESS | 3433 | 05:58:59 INFO - PROCESS | 3433 | [#1] ext.html Cycles:180 Average:59958.27 Median:42099.00 stddev:124532.98 (295.8%) stddev-sans-first:124802.48 05:58:59 INFO - PROCESS | 3433 | Values: 561.3 581.5 582.1 584.6 628.3 38769.6 41955.0 42103.0 42108.0 42199.0 42952.8 43248.0 43664.3 43713.3 43809.0 8825.3 8999.6 9007.3 9014.7 9030.5 8855.1 8882.0 8931.8 8940.2 8951.9 8983.8 9011.4 9048.4 9059.5 9071.0 8921.1 8960.6 8970.1 8978.0 9007.8 8912.2 8952.4 8959.0 8963.3 8979.5 42095.0 42488.2 42529.8 42680.6 42709.0 2649.2 3278.3 3442.9 3619.2 3632.5 30185.5 30412.2 31237.7 31259.8 32546.5 4129.7 4203.2 4219.8 4256.1 4356.4 317711.0 320094.0 320438.0 321014.0 321451.0 34569.5 35837.6 36136.6 36370.8 36450.0 35819.5 37470.6 37570.6 37609.8 37668.0 13905.2 14056.4 14106.8 14161.9 14188.2 11526.9 11749.1 11791.5 11882.6 11911.2 8469.4 8507.2 8567.0 8598.0 8668.4 3259.8 3371.9 3378.5 3379.4 3390.6 1035.3 1047.9 1057.0 1159.8 1167.3 33755.2 33928.5 34111.3 34275.3 34580.0 1055.0 1129.0 1163.3 1199.3 1267.8 16206.0 17239.3 17372.0 17428.3 17603.3 584702.0 587725.0 589718.0 589772.0 591852.0 59035.7 59111.7 59379.4 59572.4 59767.7 1315.9 1358.9 1369.9 1380.0 1387.5 30796.0 31777.4 32652.7 32716.8 33326.5 49973.5 50080.2 50202.0 50644.2 50697.0 452277.0 452696.0 453165.0 454486.0 455109.0 28890.7 29125.7 29212.9 29341.6 29546.4 48558.0 49191.8 50411.5 50509.7 50610.7 40715.0 42704.0 42907.8 43205.0 43242.6 42689.0 42823.0 42836.0 42880.4 43389.3 42874.6 43324.6 43763.3 44734.3 47533.3 32780.2 38422.2 39543.0 39848.8 39941.8 29068.6 29375.9 29812.9 29859.1 30298.0 05:58:59 INFO - PROCESS | 3433 | 05:58:59 INFO - PROCESS | 3433 | [#2] jquery.html Cycles:180 Average:27954.74 Median:2404.91 stddev:76691.84 (3189.0%) stddev-sans-first:76879.01 05:58:59 INFO - PROCESS | 3433 | Values: 369.6 380.1 381.6 392.8 404.1 15227.8 17376.6 19228.6 20410.4 20760.3 19165.3 19716.3 19768.5 19813.8 19981.9 5356.8 5710.3 5717.2 5740.1 5755.0 5522.8 5666.2 5727.1 5742.9 5780.0 5848.6 5896.3 5904.6 5904.9 5906.4 5841.4 5899.6 6455.5 6524.5 6558.1 5822.5 5838.8 5840.2 5842.2 5867.2 12986.3 12991.7 13163.5 13318.3 13357.3 2317.0 2385.1 2424.7 2607.4 2844.6 10133.4 10353.4 10872.9 10934.4 15247.8 1921.2 1921.8 1943.3 1951.5 1973.5 83642.0 86441.6 86848.6 87820.6 89326.0 11123.0 11270.4 11335.3 11406.1 11476.1 13379.9 14391.5 15743.6 15771.1 15803.1 7327.2 7520.4 7536.7 7764.8 7810.1 6996.8 7097.2 7264.9 7298.1 7321.8 4596.2 4680.1 4705.4 4794.4 4903.1 1998.7 2024.8 2067.1 2087.2 2133.5 878.2 972.0 980.0 1040.5 1060.2 19314.7 19354.4 19367.9 19415.4 19856.0 972.0 1010.6 1030.7 1069.4 1073.4 10243.2 11086.4 11091.1 11197.8 11209.9 451271.0 460395.0 466172.0 470692.0 472156.0 75492.6 77873.6 87239.6 90050.0 90626.5 982.5 1007.5 1038.7 1046.4 1052.1 16854.4 16908.7 17371.3 17825.6 18001.7 32246.5 42500.6 43137.6 43419.9 44237.6 57961.1 58879.0 59061.0 59156.4 59624.1 8247.2 8464.2 8483.7 8483.7 8493.6 11850.9 12670.7 12870.9 12886.2 13060.3 11033.5 11169.5 11327.4 11609.2 11617.0 10961.0 11156.3 11260.5 11549.9 11821.5 11670.5 11676.8 11845.5 11897.5 12011.1 8455.6 8495.6 8511.9 8828.8 8834.0 8803.4 10989.5 11352.5 11709.0 11845.5 05:58:59 INFO - PROCESS | 3433 | 05:58:59 INFO - PROCESS | 3433 | [#3] mootools.html Cycles:180 Average:5672.95 Median:480.42 stddev:3180.85 (662.1%) stddev-sans-first:3173.91 05:58:59 INFO - PROCESS | 3433 | Values: 1445.8 1461.0 1575.9 1689.6 1705.3 7359.9 8350.2 8470.9 9037.5 9041.5 8502.2 8695.9 8736.8 8770.8 8782.2 2346.4 2386.0 2387.2 2394.3 2396.1 2326.9 2339.2 2345.8 2349.1 2374.6 2350.7 2354.8 2369.4 2375.8 2388.0 2259.1 2261.8 2270.8 2273.2 2331.0 2207.4 2246.2 2249.4 2264.5 2271.2 8228.0 8288.1 8295.5 8303.8 8342.0 5061.7 5182.4 5186.5 5186.9 5191.5 3191.7 3194.6 3317.3 3355.9 3370.8 1149.1 1162.9 2087.9 2100.3 2179.7 11418.3 11427.9 11437.4 11529.1 11534.4 4085.6 4212.8 4267.5 4366.5 4391.3 9075.9 9077.4 9100.4 9113.4 9127.5 4910.7 5001.8 5002.6 5017.2 5017.3 4049.7 4482.2 4559.5 4595.9 4710.9 3560.4 3606.8 3642.9 3692.2 3702.1 1115.0 1125.7 1137.1 1137.2 1141.1 964.8 999.5 1002.5 1018.1 1049.7 5769.8 5854.2 5939.3 6072.1 6149.7 463.3 464.9 472.8 488.0 491.0 4227.4 4319.5 4407.9 4515.1 4554.5 10644.4 10930.2 11107.1 11131.0 11165.9 10872.2 10927.5 10973.2 11015.4 11043.8 7608.9 7927.1 7963.4 8050.3 8132.3 5868.7 5932.6 5973.4 6028.5 6104.4 9834.8 9885.3 9895.9 9921.2 10075.5 9740.5 10237.8 10308.7 10315.4 10317.1 6783.6 7515.6 7649.2 7858.2 8077.1 8183.2 8421.5 8451.9 8465.7 8466.4 7187.2 7272.2 7486.7 7504.2 7606.1 7108.4 7223.2 7291.4 7337.9 7458.6 6976.5 6982.0 7039.5 7040.7 7041.0 5272.8 5425.5 5467.4 5512.6 5624.2 5240.2 5301.9 5350.3 5409.2 5447.2 05:58:59 INFO - PROCESS | 3433 | 05:58:59 INFO - PROCESS | 3433 | [#4] prototype.html Cycles:180 Average:4829.38 Median:5510.44 stddev:1431.39 (26.0%) stddev-sans-first:1394.72 05:58:59 INFO - PROCESS | 3433 | Values: 315.0 318.0 323.5 324.3 325.8 5462.0 5479.5 5494.7 5503.9 5505.9 5366.4 5384.9 5390.8 5410.8 5477.0 3999.6 4108.2 4176.5 4237.8 4240.3 4198.0 4225.8 4229.2 4231.8 4232.7 4204.2 4258.4 4270.4 4270.4 4281.9 4124.2 4236.3 4252.9 4275.0 4283.7 3749.4 3769.4 3769.7 3769.8 3775.9 5308.8 5309.4 5327.5 5356.2 5369.8 4751.6 4850.5 4900.2 4912.3 4929.4 5645.9 5653.2 5653.3 5675.7 5690.5 4148.0 4153.5 4161.6 4166.1 4168.1 5621.2 5885.5 5901.0 5911.6 6000.2 4089.0 4103.2 4113.2 4121.1 4122.1 4145.0 4167.2 4177.0 4186.8 4196.9 4681.0 4827.0 4828.0 4871.5 4925.6 5779.4 5791.5 5801.5 5806.0 5816.7 1491.6 1507.3 1513.5 1514.0 1523.9 928.6 964.6 979.1 988.8 998.9 5490.2 5515.0 5516.9 5532.5 5550.9 5827.4 5866.7 5881.7 5933.8 5937.0 5373.3 5450.4 5493.3 5495.6 5549.7 3088.4 3117.0 3121.9 3125.4 3140.2 5856.5 6045.8 6107.1 6109.2 6124.2 6037.0 6060.2 6076.7 6095.7 6099.4 6130.8 6133.5 6177.8 6186.2 6187.4 5594.7 5923.4 5944.4 5976.1 6012.9 5899.6 5923.2 5979.3 5982.4 6008.5 5858.7 6120.6 6186.2 6241.7 6283.2 4107.3 4108.3 4131.3 4136.8 4141.6 5880.6 5934.8 5947.7 5987.9 5990.3 5584.2 5658.7 5720.6 5724.9 5776.2 5692.5 5697.8 5703.5 5703.7 5723.8 5182.4 5643.2 5660.4 5686.9 5688.9 5724.9 5728.5 5751.5 5756.8 5770.2 5621.6 5635.8 5642.2 5703.7 5704.0 05:58:59 INFO - PROCESS | 3433 | 05:58:59 INFO - PROCESS | 3433 | [#5] yui.html Cycles:180 Average:22106.01 Median:4552.93 stddev:32062.81 (704.2%) stddev-sans-first:32112.64 05:58:59 INFO - PROCESS | 3433 | Values: 746.7 762.9 767.2 806.4 831.8 16690.2 17540.7 17612.1 17613.2 17729.8 15648.1 15889.4 15893.1 15910.4 15927.1 646.1 775.3 802.0 803.1 808.5 806.7 812.6 820.1 821.5 821.7 862.1 862.3 875.3 875.3 876.6 864.8 867.1 867.3 869.9 873.2 636.1 637.0 637.2 637.6 638.0 15750.3 15751.8 15759.0 15766.2 15778.1 13683.5 14030.4 16027.5 16040.1 16050.5 13486.0 13693.3 13746.0 13898.2 14885.0 4467.8 4526.4 4579.5 4626.4 4829.3 93577.5 94276.5 94392.0 94763.5 95007.5 10940.2 11311.7 11370.8 11402.4 11416.1 20058.6 21081.6 21127.3 21184.7 21359.9 8682.8 8883.9 8970.3 8996.9 9285.4 4844.5 4903.3 4973.3 5087.9 5098.9 3566.8 3668.8 3676.9 3688.7 3692.1 648.8 652.6 663.2 665.3 666.7 669.7 713.7 731.0 731.6 748.8 10040.7 10298.7 10316.8 10399.6 10477.9 734.3 742.4 746.5 750.2 760.6 4801.4 5039.5 5068.9 5071.0 5076.5 72807.0 90232.5 134816.3 135459.0 136426.0 68969.3 69275.3 71776.0 111680.0 115613.8 60254.4 100854.0 101037.0 103848.0 104322.5 9367.2 9570.4 9819.9 9844.4 9948.7 58309.4 58921.7 59097.4 60109.4 61577.0 78572.6 80801.6 88385.6 90815.5 92925.5 12896.1 12938.8 12952.5 12970.4 13487.6 15514.4 15771.5 16296.8 16317.7 16415.6 14511.0 15076.5 15091.3 15164.2 15226.4 14288.4 14693.8 14882.1 15023.8 15512.6 12637.6 12659.2 12800.5 12833.2 12934.7 11564.4 12180.5 12217.9 12315.4 12326.4 10293.8 10707.5 12304.2 12334.1 12453.8 05:58:59 INFO - PROCESS | 3433 | -------- Summary: end -------- 05:58:59 INFO - PROCESS | 3433 | 05:59:00 INFO - TEST-INFO | 3433: exit 0 05:59:00 INFO - TEST-OK | dromaeo_css | took 1116821ms 05:59:00 INFO - TEST-START | kraken 05:59:00 INFO - operating with platform_type : linux_ 05:59:00 INFO - Initialising browser for kraken test... 05:59:00 INFO - TEST-INFO | started process 3817 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp86lwiU/profile http://localhost:38911/getInfo.html) 05:59:04 INFO - PROCESS | 3817 | __metrics Screen width/height:1600/1200 05:59:04 INFO - PROCESS | 3817 | colorDepth:24 05:59:04 INFO - PROCESS | 3817 | Browser inner width/height: 1024/697 05:59:04 INFO - PROCESS | 3817 | __metrics 05:59:05 ERROR - PROCESS | 3817 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 05:59:06 INFO - TEST-INFO | 3817: exit 0 05:59:06 INFO - Browser initialized. 05:59:06 INFO - Running cycle 1/1 for kraken test... 05:59:06 INFO - TEST-INFO | started process 3938 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp86lwiU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:59:17 INFO - PROCESS | 3938 | RSS: Main: 163024896 05:59:17 INFO - PROCESS | 3938 | 05:59:20 INFO - PROCESS | 3938 | Cycle 1(1): loaded http://localhost:38911/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38911/tests/kraken/driver.html?testName=audio-beat-detection) 05:59:21 INFO - PROCESS | 3938 | RSS: Main: 168325120 05:59:21 INFO - PROCESS | 3938 | 05:59:24 INFO - PROCESS | 3938 | Cycle 1(1): loaded http://localhost:38911/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38911/tests/kraken/driver.html?testName=audio-dft) 05:59:24 INFO - PROCESS | 3938 | RSS: Main: 167051264 05:59:24 INFO - PROCESS | 3938 | 05:59:27 INFO - PROCESS | 3938 | Cycle 1(1): loaded http://localhost:38911/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38911/tests/kraken/driver.html?testName=audio-fft) 05:59:28 INFO - PROCESS | 3938 | RSS: Main: 162971648 05:59:28 INFO - PROCESS | 3938 | 05:59:30 INFO - PROCESS | 3938 | Cycle 1(1): loaded http://localhost:38911/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38911/tests/kraken/driver.html?testName=audio-oscillator) 05:59:30 INFO - PROCESS | 3938 | RSS: Main: 164151296 05:59:30 INFO - PROCESS | 3938 | 05:59:33 INFO - PROCESS | 3938 | Cycle 1(1): loaded http://localhost:38911/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38911/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:59:33 INFO - PROCESS | 3938 | RSS: Main: 164700160 05:59:33 INFO - PROCESS | 3938 | 05:59:36 INFO - PROCESS | 3938 | Cycle 1(1): loaded http://localhost:38911/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38911/tests/kraken/driver.html?testName=imaging-darkroom) 05:59:37 INFO - PROCESS | 3938 | RSS: Main: 164646912 05:59:37 INFO - PROCESS | 3938 | 05:59:40 INFO - PROCESS | 3938 | Cycle 1(1): loaded http://localhost:38911/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38911/tests/kraken/driver.html?testName=imaging-desaturate) 05:59:41 INFO - PROCESS | 3938 | RSS: Main: 162344960 05:59:41 INFO - PROCESS | 3938 | 05:59:44 INFO - PROCESS | 3938 | Cycle 1(1): loaded http://localhost:38911/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38911/tests/kraken/driver.html?testName=json-parse-financial) 05:59:45 INFO - PROCESS | 3938 | RSS: Main: 164126720 05:59:45 INFO - PROCESS | 3938 | 05:59:46 INFO - PROCESS | 3938 | Cycle 1(1): loaded http://localhost:38911/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38911/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:59:47 INFO - PROCESS | 3938 | RSS: Main: 164028416 05:59:47 INFO - PROCESS | 3938 | 05:59:49 INFO - PROCESS | 3938 | Cycle 1(1): loaded http://localhost:38911/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38911/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:59:49 INFO - PROCESS | 3938 | RSS: Main: 164139008 05:59:49 INFO - PROCESS | 3938 | 05:59:51 INFO - PROCESS | 3938 | Cycle 1(1): loaded http://localhost:38911/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38911/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:59:52 INFO - PROCESS | 3938 | RSS: Main: 165040128 05:59:52 INFO - PROCESS | 3938 | 05:59:55 INFO - PROCESS | 3938 | Cycle 1(1): loaded http://localhost:38911/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38911/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:59:55 INFO - PROCESS | 3938 | RSS: Main: 164589568 05:59:55 INFO - PROCESS | 3938 | 05:59:58 INFO - PROCESS | 3938 | Cycle 1(1): loaded http://localhost:38911/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38911/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:59:59 INFO - PROCESS | 3938 | RSS: Main: 164757504 05:59:59 INFO - PROCESS | 3938 | 06:00:00 INFO - PROCESS | 3938 | Cycle 1(1): loaded http://localhost:38911/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38911/tests/kraken/driver.html?testName=ai-astar) 06:00:01 INFO - PROCESS | 3938 | RSS: Main: 165400576 06:00:01 INFO - PROCESS | 3938 | 06:00:01 INFO - PROCESS | 3938 | __start_tp_report 06:00:01 INFO - PROCESS | 3938 | _x_x_mozilla_page_load 06:00:01 INFO - PROCESS | 3938 | _x_x_mozilla_page_load_details 06:00:01 INFO - PROCESS | 3938 | |i|pagename|runs| 06:00:01 INFO - PROCESS | 3938 | |0;ai-astar;106;114;109;113;113;111;118;111;112;111 06:00:01 INFO - PROCESS | 3938 | |1;audio-beat-detection;148;118;151;181;120;152;153;121;178;117 06:00:01 INFO - PROCESS | 3938 | |2;audio-dft;164;162;163;167;167;177;162;161;164;164 06:00:01 INFO - PROCESS | 3938 | |3;audio-fft;74;79;76;177;76;74;75;76;169;76 06:00:01 INFO - PROCESS | 3938 | |4;audio-oscillator;86;86;139;86;85;86;149;85;86;158 06:00:01 INFO - PROCESS | 3938 | |5;imaging-gaussian-blur;117;117;117;118;117;117;118;118;117;117 06:00:01 INFO - PROCESS | 3938 | |6;imaging-darkroom;148;147;148;148;147;147;147;148;146;149 06:00:01 INFO - PROCESS | 3938 | |7;imaging-desaturate;97;96;96;96;97;96;96;96;96;96 06:00:01 INFO - PROCESS | 3938 | |8;json-parse-financial;52;52;56;52;52;56;57;52;52;57 06:00:01 INFO - PROCESS | 3938 | |9;json-stringify-tinderbox;62;62;63;63;63;62;62;62;62;66 06:00:01 INFO - PROCESS | 3938 | |10;stanford-crypto-aes;92;85;81;81;80;78;82;84;80;81 06:00:01 INFO - PROCESS | 3938 | |11;stanford-crypto-ccm;134;121;127;136;131;135;138;125;149;124 06:00:01 INFO - PROCESS | 3938 | |12;stanford-crypto-pbkdf2;169;166;167;163;165;165;166;167;168;166 06:00:01 INFO - PROCESS | 3938 | |13;stanford-crypto-sha256-iterative;70;67;65;67;64;67;64;64;66;68 06:00:01 INFO - PROCESS | 3938 | __end_tp_report 06:00:01 INFO - PROCESS | 3938 | __start_cc_report 06:00:01 INFO - PROCESS | 3938 | _x_x_mozilla_cycle_collect,861 06:00:01 INFO - PROCESS | 3938 | __end_cc_report 06:00:01 INFO - PROCESS | 3938 | __startTimestamp1471525201144__endTimestamp 06:00:01 INFO - PROCESS | 3938 | 06:00:01 INFO - PROCESS | 3938 | ------- Summary: start ------- 06:00:01 INFO - PROCESS | 3938 | Number of tests: 14 06:00:01 INFO - PROCESS | 3938 | 06:00:01 INFO - PROCESS | 3938 | [#0] ai-astar Cycles:10 Average:111.80 Median:112.50 stddev:3.16 (2.8%) stddev-sans-first:2.55 06:00:01 INFO - PROCESS | 3938 | Values: 106.0 114.0 109.0 113.0 113.0 111.0 118.0 111.0 112.0 111.0 06:00:01 INFO - PROCESS | 3938 | 06:00:01 INFO - PROCESS | 3938 | [#1] audio-beat-detection Cycles:10 Average:143.90 Median:151.50 stddev:24.14 (15.9%) stddev-sans-first:25.56 06:00:01 INFO - PROCESS | 3938 | Values: 148.0 118.0 151.0 181.0 120.0 152.0 153.0 121.0 178.0 117.0 06:00:01 INFO - PROCESS | 3938 | 06:00:01 INFO - PROCESS | 3938 | [#2] audio-dft Cycles:10 Average:165.10 Median:164.00 stddev:4.63 (2.8%) stddev-sans-first:4.89 06:00:01 INFO - PROCESS | 3938 | Values: 164.0 162.0 163.0 167.0 167.0 177.0 162.0 161.0 164.0 164.0 06:00:01 INFO - PROCESS | 3938 | 06:00:01 INFO - PROCESS | 3938 | [#3] audio-fft Cycles:10 Average:95.20 Median:76.00 stddev:41.07 (54.0%) stddev-sans-first:42.84 06:00:01 INFO - PROCESS | 3938 | Values: 74.0 79.0 76.0 177.0 76.0 74.0 75.0 76.0 169.0 76.0 06:00:01 INFO - PROCESS | 3938 | 06:00:01 INFO - PROCESS | 3938 | [#4] audio-oscillator Cycles:10 Average:104.60 Median:86.00 stddev:30.74 (35.7%) stddev-sans-first:31.86 06:00:01 INFO - PROCESS | 3938 | Values: 86.0 86.0 139.0 86.0 85.0 86.0 149.0 85.0 86.0 158.0 06:00:01 INFO - PROCESS | 3938 | 06:00:01 INFO - PROCESS | 3938 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 06:00:01 INFO - PROCESS | 3938 | Values: 117.0 117.0 117.0 118.0 117.0 117.0 118.0 118.0 117.0 117.0 06:00:01 INFO - PROCESS | 3938 | 06:00:01 INFO - PROCESS | 3938 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:148.00 stddev:0.85 (0.6%) stddev-sans-first:0.88 06:00:01 INFO - PROCESS | 3938 | Values: 148.0 147.0 148.0 148.0 147.0 147.0 147.0 148.0 146.0 149.0 06:00:01 INFO - PROCESS | 3938 | 06:00:01 INFO - PROCESS | 3938 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 06:00:01 INFO - PROCESS | 3938 | Values: 97.0 96.0 96.0 96.0 97.0 96.0 96.0 96.0 96.0 96.0 06:00:01 INFO - PROCESS | 3938 | 06:00:01 INFO - PROCESS | 3938 | [#8] json-parse-financial Cycles:10 Average:53.80 Median:54.00 stddev:2.35 (4.3%) stddev-sans-first:2.40 06:00:01 INFO - PROCESS | 3938 | Values: 52.0 52.0 56.0 52.0 52.0 56.0 57.0 52.0 52.0 57.0 06:00:01 INFO - PROCESS | 3938 | 06:00:01 INFO - PROCESS | 3938 | [#9] json-stringify-tinderbox Cycles:10 Average:62.70 Median:62.50 stddev:1.25 (2.0%) stddev-sans-first:1.30 06:00:01 INFO - PROCESS | 3938 | Values: 62.0 62.0 63.0 63.0 63.0 62.0 62.0 62.0 62.0 66.0 06:00:01 INFO - PROCESS | 3938 | 06:00:01 INFO - PROCESS | 3938 | [#10] stanford-crypto-aes Cycles:10 Average:82.40 Median:81.50 stddev:3.92 (4.8%) stddev-sans-first:2.12 06:00:01 INFO - PROCESS | 3938 | Values: 92.0 85.0 81.0 81.0 80.0 78.0 82.0 84.0 80.0 81.0 06:00:01 INFO - PROCESS | 3938 | 06:00:01 INFO - PROCESS | 3938 | [#11] stanford-crypto-ccm Cycles:10 Average:132.00 Median:134.50 stddev:8.26 (6.1%) stddev-sans-first:8.73 06:00:01 INFO - PROCESS | 3938 | Values: 134.0 121.0 127.0 136.0 131.0 135.0 138.0 125.0 149.0 124.0 06:00:01 INFO - PROCESS | 3938 | 06:00:01 INFO - PROCESS | 3938 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.20 Median:166.50 stddev:1.69 (1.0%) stddev-sans-first:1.45 06:00:01 INFO - PROCESS | 3938 | Values: 169.0 166.0 167.0 163.0 165.0 165.0 166.0 167.0 168.0 166.0 06:00:01 INFO - PROCESS | 3938 | 06:00:01 INFO - PROCESS | 3938 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.20 Median:67.00 stddev:1.99 (3.0%) stddev-sans-first:1.56 06:00:01 INFO - PROCESS | 3938 | Values: 70.0 67.0 65.0 67.0 64.0 67.0 64.0 64.0 66.0 68.0 06:00:01 INFO - PROCESS | 3938 | -------- Summary: end -------- 06:00:01 INFO - PROCESS | 3938 | 06:00:02 INFO - TEST-INFO | 3938: exit 0 06:00:02 INFO - TEST-OK | kraken | took 61890ms 06:00:02 INFO - SUITE-END | took 1178s 06:00:02 INFO - Completed test suite (00:19:38) 06:00:02 INFO - javascript benchmark 06:00:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7239.309502898323, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3005.368872536767, 3039.331347103637, 3040.6351237851463, 3043.7108474694896, 3055.6944305569446, 5169.508896654812, 5290.576753859692, 5316.388615309241, 5332.626716129863, 5373.382061062979, 5332.92000619991, 5355.08963476209, 5366.597505187107, 5377.193420986854, 5477.534409575181, 4790.089882922242, 4850.951490485085, 4913.484084171164, 4913.82801601944, 5108.182690769478, 5030.346055012843, 5050.595952323823, 5054.418741844698, 5080.288759573663, 5089.083964886319, 4683.765811709435, 4774.9522504775205, 4844.63665225106, 4901.362822833009, 4957.157283261836, 4840.128776820171, 4858.1012512685265, 4893.535114164149, 4941.950580494221, 4960.503949605047, 4865.489123642002, 4916.606671466274, 4932.136876046713, 4943.406791185045, 4986.650934434591, 5271.551918086967, 5326.493983071602, 5332.360116786011, 5438.83683489496, 5482.588805839578, 5703.885922281573, 5739.253896993406, 5747.59766816323, 5757.740901659436, 5771.942280577183, 5785.971070144665, 5791.797287094932, 5800.709964501801, 5805.535557155417, 5814.3604203538, 5204.609654275944, 5370.677759334452, 5416.322959630046, 5443.346798384219, 5492.423295553989, 5942.108683697394, 5984.551158663031, 5985.880282394328, 5994.190784244159, 6002.279726432856, 5708.029634962067, 5711.143328500675, 5729.226554415184, 5732.942670573324, 5735.2257445245195, 5485.890282194414, 5727.398623144593, 5750.971245143831, 5810.070388737781, 5894.498967587803, 5543.584231182677, 5667.319921609351, 5716.742746576414, 5745.1382292656435, 5770.653760774367, 5784.132380143013, 5784.219130417424, 5799.94200057994, 5804.245448091721, 5804.361520232771, 4294.141171765659, 4364.672649551297, 4402.075564131568, 4406.735595864258, 4457.3091170868565, 3930.9213815724097, 3943.645071943539, 3947.0, 3975.0658595230097, 3977.960220397759, 5522.282103326542, 5560.944390556043, 5575.191597218381, 5582.441755824385, 5586.469285417878, 5551.972240138854, 5690.9146362804595, 5829.650220986754, 5834.5624078194305, 5869.178315035899, 5555.77776888928, 5575.386707462176, 5593.244911936918, 5599.244102046172, 5605.243292155588, 5048.59611231108, 5057.772400241998, 5062.594992400599, 5065.290859279704, 5091.0581542414775, 5828.009238429478, 6009.609375390585, 6013.037913933749, 6046.002409602366, 6061.605995610271, 5818.389069147678, 5875.6474611523445, 5906.911396329145, 5941.049432090845, 5949.2266005419015, 6057.242844644419, 6057.57596968208, 6068.302145253352, 6070.2412198475195, 6080.48315893154, 5523.364813046551, 5673.74468148926, 5724.313082430135, 5795.855103622274, 5808.912866306924, 5791.739371728198, 5853.502452291603, 5858.0, 5886.175935368966, 5894.263217097863, 5578.414266501959, 5720.599558031065, 5726.770929162787, 5738.196652468741, 5752.7698892043845, 5465.07093794048, 5583.050881350099, 5713.0, 5728.341240757366, 5734.799282025276, 5596.692181930033, 5608.130739735348, 5648.293963254593, 5675.659460432387, 5692.1461780733225, 5647.068233741386, 5729.427057294404, 5729.598928075162, 5732.197492351158, 5752.050911599539, 5366.0, 5542.916856247079, 5543.3902270751, 5553.361363443094, 5640.943590564042], "value": 5338.873555759078, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [561.2955740545615, 581.5057201378828, 582.1209972940858, 584.5586582130491, 628.2900322635421, 38769.61230387695, 41955.0, 42103.0, 42107.99999999996, 42199.0, 42952.785236073854, 43248.0, 43664.3450348245, 43713.34429983553, 43809.0, 8825.293976481882, 8999.595018224196, 9007.279417646572, 9014.68448604299, 9030.548472576378, 8855.070217627153, 8882.022977472472, 8931.776705582348, 8940.19538241558, 8951.865722014176, 8983.775405614846, 9011.369204155711, 9048.366614337, 9059.547022648874, 9071.0, 8921.063288354695, 8960.596773145224, 8970.102989701043, 8978.0, 9007.819843603156, 8912.153345432174, 8952.418092823946, 8958.955205223932, 8963.327750418744, 8979.506127163004, 42095.0, 42488.15023699509, 42529.787351063045, 42680.57319426828, 42709.0, 2649.218480548243, 3278.262910094914, 3442.913927151816, 3619.1856832212807, 3632.527771389729, 30185.547216791765, 30412.239694007607, 31237.687623123933, 31259.84370078135, 32546.511802322984, 4129.690273229489, 4203.159368126387, 4219.810108545123, 4256.063665993476, 4356.4336636237085, 317711.0, 320094.0, 320438.0, 321014.0, 321451.0, 34569.48145777815, 35837.64162358395, 36136.63863361385, 36370.8181459091, 36450.0, 35819.4627080594, 37470.62529374726, 37570.62429375726, 37609.81195094007, 37668.0, 13905.235212063231, 14056.43774249039, 14106.788398174036, 14161.85838141626, 14188.219647919463, 11526.88473115258, 11749.060075193964, 11791.469383877575, 11882.584109556125, 11911.166218364631, 8469.449485783405, 8507.191816777397, 8566.957165214259, 8598.011228708654, 8668.393212475192, 3259.7718159728593, 3371.8651253949565, 3378.527006219131, 3379.374815659111, 3390.5761779777526, 1035.2856528994969, 1047.9004494573003, 1057.0, 1159.7970355187808, 1167.311286341063, 33755.156121096676, 33928.49107263393, 34111.31777364439, 34275.314493709986, 34580.0, 1054.9789004219872, 1129.0, 1163.313644949484, 1199.2504684572143, 1267.790814515613, 16206.0, 17239.31042758301, 17371.957682538836, 17428.302867885144, 17603.34045911338, 584702.0, 587725.0, 589718.0, 589772.0, 591852.0, 59035.704821475614, 59111.704441477516, 59379.40620593825, 59572.40427595669, 59767.70116149391, 1315.8881495072835, 1358.8980826438058, 1369.8835598974, 1379.9862001380059, 1387.486629946926, 30796.0, 31777.364452710353, 32652.673473265913, 32716.83641581777, 33326.500102497994, 49973.500264998336, 50080.248796267355, 50202.0, 50644.24033639424, 50697.0, 452277.0, 452696.0, 453165.0, 454486.0, 455109.0, 28890.711092888803, 29125.7087429123, 29212.853935730185, 29341.559876602296, 29546.409071818875, 48558.0, 49191.754041229564, 50411.49588504068, 50509.747451262505, 50610.74694626503, 40715.0, 42704.0, 42907.7854610725, 43204.95529247165, 43242.56757432385, 42689.0, 42823.0, 42836.0, 42880.35679464873, 43389.349159761994, 42874.57125428706, 43324.56675433331, 43763.343549847414, 44734.328985064596, 47533.28700069571, 32780.1804954878, 38422.23155536818, 39543.0, 39848.82343236687, 39941.80029099836, 29068.56397154002, 29375.85312073426, 29812.850935745184, 29859.104495426676, 30298.0], "value": 18851.526008573514, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [369.59577945464764, 380.10485307101777, 381.5936028130041, 392.79182033522244, 404.14321638127177, 15227.847721522809, 17376.565585860342, 19228.61542769144, 20410.387688369356, 20760.27339043134, 19165.32921347753, 19716.30992915248, 19768.505787355323, 19813.801861981377, 19981.900090499563, 5356.812511562096, 5710.257666503348, 5717.171010203518, 5740.1102829061565, 5755.0, 5522.779088836442, 5666.206731057655, 5727.140928860684, 5742.885142297151, 5780.046292361776, 5848.649081055129, 5896.292444906596, 5904.586678932476, 5904.940950590503, 5906.409359064102, 5841.422815839721, 5899.557533185007, 6455.4835613150835, 6524.478041756648, 6558.114654521626, 5822.475977162034, 5838.766449342022, 5840.211571437844, 5842.24050873388, 5867.178594996704, 12986.28575428351, 12991.675208119777, 13163.539276125386, 13318.334083295797, 13357.33213339329, 2316.9652455213186, 2385.1413491143176, 2424.6726691896542, 2607.4263661994332, 2844.630198074258, 10133.39199648016, 10353.378797272113, 10872.891271087266, 10934.398608076554, 15247.847521524754, 1921.2123029557815, 1921.8174273444001, 1943.2712732725229, 1951.5121219695077, 1973.506623344164, 83642.0, 86441.56779216127, 86848.56575717144, 87820.56089719574, 89326.0, 11123.0, 11270.380129092979, 11335.263207891625, 11406.087512999105, 11476.139289553317, 13379.866201338056, 14391.496297629532, 15743.606409839846, 15771.132587707556, 15803.13082780435, 7327.194008659043, 7520.360769334558, 7536.660850261751, 7764.84470310602, 7810.062792464827, 6996.755113571001, 7097.225693576605, 7264.854702905912, 7298.051253337032, 7321.816954576178, 4596.195665758479, 4680.063987202573, 4705.364775755298, 4794.448638406628, 4903.092927808367, 1998.660227761284, 2024.7975202479633, 2067.1111422088347, 2087.2381580722927, 2133.5306232628795, 878.2490970220497, 971.9854202186973, 979.9657012004545, 1040.490159821697, 1060.2419270221828, 19314.71027934582, 19354.41936741872, 19367.903160484108, 19415.4175374739, 19856.0, 971.9951400243095, 1010.5806090472372, 1030.6701855406197, 1069.3904474449644, 1073.3559864081644, 10243.231757618209, 11086.390248536247, 11091.057260132979, 11197.776044479066, 11209.887901121048, 451271.0, 460395.0, 466172.0, 470692.0, 472156.0, 75492.62253688696, 77873.61063194647, 87239.56380218058, 90049.99999999869, 90626.54686726524, 982.5283863745442, 1007.5214273220308, 1038.7299302181486, 1046.398320965448, 1052.0899421999916, 16854.41009564659, 16908.66182676364, 17371.305147793948, 17825.643487130445, 18001.729974050137, 32246.516302255015, 42500.5749942509, 43137.56862431335, 43419.9145021377, 44237.55762442463, 57961.13058304213, 58879.0, 59061.0, 59156.40843591509, 59624.105638416324, 8247.21651443112, 8464.195901389357, 8483.660653573788, 8483.660653573788, 8493.575321234037, 11850.881491184979, 12670.746585068431, 12870.935645321713, 12886.226826390446, 13060.281684507063, 11033.503492342703, 11169.497372618414, 11327.376994265394, 11609.245399049034, 11617.0, 10961.0, 11156.274842135235, 11260.536130303008, 11549.942250288696, 11821.527138914347, 11670.533178672758, 11676.824847627462, 11845.52617895309, 11897.46461409256, 12011.11733184047, 8455.619497122521, 8495.617697203517, 8511.914880851113, 8828.823423531365, 8834.0, 8803.383763136519, 10989.505472253928, 11352.54589816398, 11709.0, 11845.46695398692], "value": 9090.531901909437, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1445.790360397742, 1460.9707805843884, 1575.88968772186, 1689.5944973206433, 1705.266735303819, 7359.852802943938, 8350.248477637011, 8470.91529084709, 9037.457752534852, 9041.547922603868, 8502.192291732275, 8695.86956195656, 8736.825263494726, 8770.780730481742, 8782.16569425905, 2346.389938615959, 2386.0217310902535, 2387.2480168746874, 2394.341556072077, 2396.1254142238045, 2326.906923723049, 2339.1929784224417, 2345.8240631952585, 2349.0603758496654, 2374.608189648706, 2350.7296660883962, 2354.799842013431, 2369.3839601703507, 2375.833691641577, 2387.9761202388013, 2259.085070546423, 2261.8190544756544, 2270.818334533233, 2273.181654604349, 2331.0326214620914, 2207.404000919743, 2246.1576908659254, 2249.4488850231796, 2264.54709058189, 2271.2391348897972, 8228.0, 8288.129746376604, 8295.502269863828, 8303.792405189859, 8342.0, 5061.6962982221185, 5182.404023537266, 5186.533212010937, 5186.922196167023, 5191.480851914816, 3191.69678880506, 3194.5847039884666, 3317.319949410365, 3355.932881342384, 3370.79775213488, 1149.1151813103863, 1162.8662703789003, 2087.937361879146, 2100.2754049852774, 2179.69484272202, 11418.31490110596, 11427.942860285646, 11437.370944598044, 11529.077673786078, 11534.365609891536, 4085.611866872642, 4212.789360531961, 4267.466566679165, 4366.541513141075, 4391.3193455014525, 9075.863862042075, 9077.409968352036, 9100.362974591715, 9113.407628504126, 9127.543622818832, 4910.656254062182, 5001.774920128603, 5002.57478114357, 5017.247412888096, 5017.3226614406585, 4049.7165198436414, 4482.193205223091, 4559.475660299108, 4595.885102872455, 4710.858674239778, 3560.394732895414, 3606.8016259106003, 3642.9253370255838, 3692.2061756722433, 3702.148505843671, 1114.9944250278697, 1125.6848082536903, 1137.0505627800878, 1137.2380505061628, 1141.058626633031, 964.7588102974256, 999.5102399824179, 1002.5438425516519, 1018.1193267823279, 1049.7060822969581, 5769.769209231667, 5854.2096816930025, 5939.346671866091, 6072.089186621954, 6149.66176860268, 463.29579039859226, 464.8791314258317, 472.84396149270657, 487.99024019519413, 491.04001676721924, 4227.42929704486, 4319.503257125471, 4407.889802754957, 4515.096980603892, 4554.521775213621, 10644.414557199429, 10930.180236482296, 11107.111431085494, 11131.0, 11165.944170279097, 10872.18458615607, 10927.453627318602, 10973.23187376876, 11015.394153321484, 11043.83434248487, 7608.885866712004, 7927.088384835818, 7963.4027447941635, 8050.31572316348, 8132.2680958714, 5868.735906884286, 5932.614380065282, 5973.432523910222, 6028.517718582415, 6104.359042300672, 9834.75413114678, 9885.308028437941, 9895.851562226717, 9921.206303495848, 10075.496225188564, 9740.464274464972, 10237.795244094927, 10308.742281443025, 10315.432651204255, 10317.123044541298, 6783.559068660521, 7515.6242187891485, 7649.196834332538, 7858.174891636524, 8077.1115177329275, 8183.181681831769, 8421.452605580618, 8451.873221901553, 8465.703700370457, 8466.449680770731, 7187.2453392393045, 7272.200057993511, 7486.737964171228, 7504.249575042671, 7606.087269527692, 7108.395786358217, 7223.205447400676, 7291.4166866649475, 7337.926620733938, 7458.589777562286, 6976.4767642426, 6981.965090174516, 7039.472039596948, 7040.718371265092, 7041.049458323061, 5272.815451459181, 5425.511703946664, 5467.371252305877, 5512.641678290898, 5624.184493248538, 5240.240165176105, 5301.946980530145, 5350.250964864844, 5409.161579955114, 5447.1829225616475], "value": 4526.134241990202, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [314.9574807401001, 317.992050198745, 323.5389569862945, 324.3027490894576, 325.778470639965, 5462.0, 5479.4520547945185, 5494.697791621465, 5503.889922201563, 5505.889882202354, 5366.436524164965, 5384.926803180774, 5390.757415916283, 5410.810621628244, 5477.0, 3999.600039995999, 4108.198901214264, 4176.519700234481, 4237.788110594458, 4240.300350442173, 4197.958020419803, 4225.7887105644595, 4229.196452673998, 4231.830726770941, 4232.6613870890405, 4204.222218889515, 4258.382534532491, 4270.402143699885, 4270.423492828475, 4281.850135245267, 4124.195781822561, 4236.343366778124, 4252.936205956913, 4274.952636604021, 4283.700140990117, 3749.362608356586, 3769.3968964965475, 3769.6994536885004, 3769.792661403622, 3775.9433608495897, 5308.787648494055, 5309.362876454811, 5327.455038038964, 5356.1697936819855, 5369.81205657804, 4751.64362672801, 4850.53919877611, 4900.191468407708, 4912.312276281324, 4929.359183306147, 5645.8588535286535, 5653.180288858133, 5653.349864765522, 5675.659460432387, 5690.5447564194765, 4147.958520414787, 4153.501579810442, 4161.583841615845, 4166.145940082306, 4168.103857670585, 5621.156826476021, 5885.529157667376, 5901.0, 5911.55663325248, 6000.229932169977, 4088.979555102265, 4103.199876024147, 4113.239050775616, 4121.083696081337, 4122.134351786159, 4145.046639272924, 4167.2082304362075, 4177.0, 4186.81159347824, 4196.853110141192, 4681.0, 4826.975865120722, 4828.0, 4871.464138944713, 4925.605951523869, 5779.393163717749, 5791.478766910998, 5801.53587712982, 5805.970970145207, 5816.709164541756, 1491.5599898030107, 1507.2539093148741, 1513.4702854001011, 1514.0, 1523.8704710099544, 928.6007016982762, 964.6479035152119, 979.1383582447543, 988.8170688422665, 998.9250806189565, 5490.231367608538, 5515.0, 5516.9448305517235, 5532.474414930575, 5550.888982220414, 5827.4172582741385, 5866.70666466675, 5881.676737688589, 5933.762649494059, 5936.970315148396, 5373.328333958255, 5450.3732070811575, 5493.258410114663, 5495.6153069285565, 5549.667019978814, 3088.382323535302, 3117.0, 3121.877123556004, 3125.4374212641487, 3140.2306434923134, 5856.502197313276, 6045.848853778691, 6107.144999700045, 6109.20580324555, 6124.234470691164, 6036.969815150984, 6060.181875446759, 6076.726547305382, 6095.664738439428, 6099.420555047263, 6130.773845230882, 6133.478654314344, 6177.752889884444, 6186.185285694998, 6187.3912782675925, 5594.748236329294, 5923.437273459014, 5944.405559444194, 5976.103584462366, 6012.8797424052145, 5899.557533184942, 5923.170756094064, 5979.282486101695, 5982.371850955761, 6008.459238668541, 5858.736356863866, 6120.632762034292, 6186.226721659793, 6241.658043520665, 6283.183186185766, 4107.342825147962, 4108.281050816155, 4131.256373852735, 4136.793160341911, 4141.6065473779945, 5880.588358814842, 5934.821955341346, 5947.702614869153, 5987.940120598738, 5990.281166260077, 5584.246126772834, 5658.688772117408, 5720.598453378949, 5724.914126288192, 5776.249087618583, 5692.48767610917, 5697.81210810046, 5703.543716502587, 5703.74517606126, 5723.828285151452, 5182.429932707475, 5643.238162848127, 5660.37735849048, 5686.943130568641, 5688.943110568841, 5724.914126288026, 5728.455796699307, 5751.5398768099285, 5756.769729210952, 5770.192173095854, 5621.634593751393, 5635.802746903839, 5642.210090587403, 5703.714814259353, 5704.0], "value": 4368.403763638214, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [746.7125156814628, 762.9122650895147, 767.2442643995666, 806.4475834053671, 831.7557798083092, 16690.16549172541, 17540.736888946674, 17612.11939403028, 17613.207405666744, 17729.847559908598, 15648.061116333029, 15889.44386946457, 15893.125878076702, 15910.443134490295, 15927.124008179575, 646.0761111610395, 775.3138472451892, 801.9599020049003, 803.1446509467428, 808.5108509351817, 806.7378102116807, 812.597764106768, 820.0774129104757, 821.4537332673765, 821.6549049399237, 862.06465984407, 862.3360012790148, 875.2691502595341, 875.3128793896792, 876.6186708781669, 864.844328020956, 867.1242045533993, 867.2758246863908, 869.9130086991313, 873.2097451806126, 636.0649844728242, 637.0221709675671, 637.2289529669106, 637.6461064109418, 638.0142679560091, 15750.291236894367, 15751.763723544156, 15759.0, 15766.211689415484, 15778.053316801028, 13683.452661893512, 14030.368633411521, 16027.51917442467, 16040.11779352135, 16050.518484445369, 13486.001285519955, 13693.315334233248, 13746.0, 13898.16611003343, 14885.0, 4467.7542735149555, 4526.366308716782, 4579.496255411902, 4626.421697287839, 4829.275608658694, 93577.53211233969, 94276.52861735717, 94392.0, 94763.52618236865, 95007.52496237475, 10940.179486538382, 11311.660650180507, 11370.829437558443, 11402.429878506207, 11416.088897331127, 20058.598828023358, 21081.578368432547, 21127.26054588082, 21184.682229766568, 21359.893200533897, 8682.826343473222, 8883.911160888309, 8970.327225457986, 8996.901742396245, 9285.396449230779, 4844.491328410537, 4903.338049363361, 4973.278874563168, 5087.898242035212, 5098.923516147261, 3566.7681600695873, 3668.779873207616, 3676.889693309205, 3688.6864616507896, 3692.0585250760882, 648.844277373427, 652.5627829354344, 663.190907093355, 665.2582370656683, 666.6799936030635, 669.7454967112466, 713.6697493235039, 730.9963450182715, 731.5683746589432, 748.7603966730703, 10040.69877903664, 10298.742531436774, 10316.845247321296, 10399.584016639401, 10477.9476102619, 734.2620666230404, 742.4468770765814, 746.4550877859085, 750.1897950213756, 760.5968836516655, 4801.423829140525, 5039.496050395004, 5068.949310506921, 5070.974645126751, 5076.543111119943, 72807.0, 90232.5488372554, 134816.32591837173, 135459.0, 136426.0, 68969.3103068973, 69275.30724692688, 71776.0, 111680.0, 115613.843861562, 60254.37201907787, 100854.0, 101037.0, 103848.0, 104322.47838760758, 9367.156955873732, 9570.377925434825, 9819.9018009819, 9844.409335439897, 9948.701538953843, 58309.4169058321, 58921.70539147448, 59097.40902590919, 60109.39890601213, 61577.0, 78572.60713696624, 80801.59599201966, 88385.55807220923, 90815.54592226997, 92925.5353723227, 12896.097273190786, 12938.805917911428, 12952.546660867201, 12970.35148242603, 13487.595372138852, 15514.37942482288, 15771.526854194393, 16296.837031630006, 16317.719836502927, 16415.589610259838, 14511.0, 15076.547703568911, 15091.320890559731, 15164.24178791034, 15226.390944362101, 14288.427323430922, 14693.779593305895, 14882.10707357562, 15023.849761502244, 15512.612184695472, 12637.620871373874, 12659.240445573296, 12800.487980480677, 12833.230006199658, 12934.676633084247, 11564.357621645322, 12180.473519630645, 12217.877821221675, 12315.384230788604, 12326.383680816103, 10293.794124117625, 10707.464626768786, 12304.200226985216, 12334.136610437183, 12453.750924981268], "value": 7956.188543195727, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1544.9000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 114.0, 109.0, 113.0, 113.0, 111.0, 118.0, 111.0, 112.0, 111.0], "value": 111.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 118.0, 151.0, 181.0, 120.0, 152.0, 153.0, 121.0, 178.0, 117.0], "value": 143.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 162.0, 163.0, 167.0, 167.0, 177.0, 162.0, 161.0, 164.0, 164.0], "value": 165.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 79.0, 76.0, 177.0, 76.0, 74.0, 75.0, 76.0, 169.0, 76.0], "value": 95.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 139.0, 86.0, 85.0, 86.0, 149.0, 85.0, 86.0, 158.0], "value": 104.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 118.0, 118.0, 117.0, 117.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 148.0, 148.0, 147.0, 147.0, 147.0, 148.0, 146.0, 149.0], "value": 147.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 96.0, 96.0, 96.0, 97.0, 96.0, 96.0, 96.0, 96.0, 96.0], "value": 96.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 56.0, 52.0, 52.0, 56.0, 57.0, 52.0, 52.0, 57.0], "value": 53.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 63.0, 63.0, 63.0, 62.0, 62.0, 62.0, 62.0, 66.0], "value": 62.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 85.0, 81.0, 81.0, 80.0, 78.0, 82.0, 84.0, 80.0, 81.0], "value": 82.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 121.0, 127.0, 136.0, 131.0, 135.0, 138.0, 125.0, 149.0, 124.0], "value": 132.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 166.0, 167.0, 163.0, 165.0, 165.0, 166.0, 167.0, 168.0, 166.0], "value": 166.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 67.0, 65.0, 67.0, 64.0, 67.0, 64.0, 64.0, 66.0, 68.0], "value": 66.2, "unit": "score"}]}]} 06:00:02 INFO - Return code: 0 06:00:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:00:02 ERROR - # TBPL SUCCESS # 06:00:02 INFO - Running post-action listener: _resource_record_post_action 06:00:02 INFO - [mozharness: 2016-08-18 13:00:02.447115Z] Finished run-tests step (success) 06:00:02 INFO - Running post-run listener: _resource_record_post_run 06:00:02 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 10117120; Write bytes: 456843264; Read time: 3288; Write time: 473892 06:00:02 INFO - TinderboxPrint: CPU usage
13.4% 06:00:02 INFO - TinderboxPrint: I/O read bytes / time
10,117,120 / 3,288 06:00:02 INFO - TinderboxPrint: I/O write bytes / time
456,843,264 / 473,892 06:00:02 INFO - TinderboxPrint: CPU idle
8,265.6 (86.6%) 06:00:02 INFO - TinderboxPrint: CPU user
1,214.1 (12.7%) 06:00:02 INFO - TinderboxPrint: Swap in / out
0 / 0 06:00:02 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 4644864; Read time: 0; Write time: 284 06:00:02 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 7962624; Write bytes: 415158272; Read time: 2764; Write time: 455804 06:00:03 INFO - Running post-run listener: _upload_blobber_files 06:00:03 INFO - Blob upload gear active. 06:00:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:00:03 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 06:00:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:00:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:00:03 INFO - (blobuploader) - INFO - Open directory for files ... 06:00:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:00:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:00:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:00:09 INFO - (blobuploader) - WARNING - File uploaded to blobserver but failed uploading to Amazon S3. 06:00:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:00:09 INFO - (blobuploader) - INFO - Done attempting. 06:00:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:00:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:00:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:00:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:00:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:00:14 INFO - (blobuploader) - INFO - Done attempting. 06:00:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:00:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:00:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:00:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:00:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:00:14 INFO - (blobuploader) - INFO - Done attempting. 06:00:14 INFO - (blobuploader) - INFO - Iteration through files over. 06:00:14 INFO - Return code: 0 06:00:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:00:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:00:15 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/27dcb3206e46d42d22c1482be69ed7ec1527534da56d086567d0a5a914284f0177cb354fccc027433d74144197c1111666d60a3461c20603ffb0bb257ec1c1fd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6d0572ba2266fac44243fcbc97245c952bc3ac84d670144181ba8e2b9b6e2c9accfec18ee4d2c183e1fa42006ca383c589e9fa1e956d31d076d7640a419aebc3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b3eaeb544c8c2ee82b149b8468f3d52b94de95a15fb15514100d9c2c4e0ff6cfb0bc2184c89a3d69566938e67eb29030cc3ddc2e38ed477f2ce44e8f1ca45480"} 06:00:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:00:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:00:15 INFO - Contents: 06:00:15 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/27dcb3206e46d42d22c1482be69ed7ec1527534da56d086567d0a5a914284f0177cb354fccc027433d74144197c1111666d60a3461c20603ffb0bb257ec1c1fd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6d0572ba2266fac44243fcbc97245c952bc3ac84d670144181ba8e2b9b6e2c9accfec18ee4d2c183e1fa42006ca383c589e9fa1e956d31d076d7640a419aebc3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b3eaeb544c8c2ee82b149b8468f3d52b94de95a15fb15514100d9c2c4e0ff6cfb0bc2184c89a3d69566938e67eb29030cc3ddc2e38ed477f2ce44e8f1ca45480"} 06:00:15 INFO - Running post-run listener: copy_logs_to_upload_dir 06:00:15 INFO - Copying logs to upload dir... 06:00:15 INFO - mkdir: /builds/slave/test/build/upload/logs 06:00:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.378641 ========= master_lag: 45.67 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 40 secs) (at 2016-08-18 06:01:00.687130) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-08-18 06:01:00.691138) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1471523957.227924-708218960 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/Firefox/sha512/27dcb3206e46d42d22c1482be69ed7ec1527534da56d086567d0a5a914284f0177cb354fccc027433d74144197c1111666d60a3461c20603ffb0bb257ec1c1fd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6d0572ba2266fac44243fcbc97245c952bc3ac84d670144181ba8e2b9b6e2c9accfec18ee4d2c183e1fa42006ca383c589e9fa1e956d31d076d7640a419aebc3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b3eaeb544c8c2ee82b149b8468f3d52b94de95a15fb15514100d9c2c4e0ff6cfb0bc2184c89a3d69566938e67eb29030cc3ddc2e38ed477f2ce44e8f1ca45480"} build_url:https://queue.taskcluster.net/v1/task/VFD6jNPgSjOJan7lGhS3XQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.008339 build_url: 'https://queue.taskcluster.net/v1/task/VFD6jNPgSjOJan7lGhS3XQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/27dcb3206e46d42d22c1482be69ed7ec1527534da56d086567d0a5a914284f0177cb354fccc027433d74144197c1111666d60a3461c20603ffb0bb257ec1c1fd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6d0572ba2266fac44243fcbc97245c952bc3ac84d670144181ba8e2b9b6e2c9accfec18ee4d2c183e1fa42006ca383c589e9fa1e956d31d076d7640a419aebc3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b3eaeb544c8c2ee82b149b8468f3d52b94de95a15fb15514100d9c2c4e0ff6cfb0bc2184c89a3d69566938e67eb29030cc3ddc2e38ed477f2ce44e8f1ca45480"}' ========= master_lag: 1.60 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-08-18 06:01:02.296854) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 4 secs) (at 2016-08-18 06:01:02.297198) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1471523957.227924-708218960 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004432 ========= master_lag: 4.59 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 4 secs) (at 2016-08-18 06:01:06.896177) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-18 06:01:06.896567) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-18 06:01:07.199548) ========= ========= Total master_lag: 51.92 =========