builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-018 starttime: 1472167354.64 results: success (0) buildid: 20160825133002 builduid: 0dd7aee4b282479da86499f3ac6bb0a0 revision: 08a8d0921fe32e698df0317e68434e9f7abad6d0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-25 16:22:34.639959) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-25 16:22:34.640495) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-25 16:22:34.640830) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-25 16:22:34.656491) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 16:22:34.656957) ========= 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=62c568580acbfdaac3eec7be000001dc-1472167353.800986-1502237999 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-25 16:22:34-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 47.0M=0s 2016-08-25 16:22:34 (47.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.110910 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 16:22:34.785807) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 16:22:34.786586) ========= 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=62c568580acbfdaac3eec7be000001dc-1472167353.800986-1502237999 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020182 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 16:22:34.839178) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 16:22:34.839768) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 08a8d0921fe32e698df0317e68434e9f7abad6d0 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 08a8d0921fe32e698df0317e68434e9f7abad6d0 --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=62c568580acbfdaac3eec7be000001dc-1472167353.800986-1502237999 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-25 16:22:34,915 truncating revision to first 12 chars 2016-08-25 16:22:34,915 Setting DEBUG logging. 2016-08-25 16:22:34,915 attempt 1/10 2016-08-25 16:22:34,915 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/08a8d0921fe3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-25 16:22:35,193 unpacking tar archive at: mozilla-inbound-08a8d0921fe3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.580867 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 16:22:35.436370) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-25 16:22:35.436811) ========= script_repo_revision: 08a8d0921fe32e698df0317e68434e9f7abad6d0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-25 16:22:35.437303) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-25 16:22:35.437644) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-25 16:22:35.447295) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-08-25 16:22:35.447697) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 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', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=62c568580acbfdaac3eec7be000001dc-1472167353.800986-1502237999 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:22:35 INFO - MultiFileLogger online at 20160825 16:22:35 in /builds/slave/test 16:22:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 16:22:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:22:35 INFO - {'append_to_log': False, 16:22:35 INFO - 'base_work_dir': '/builds/slave/test', 16:22:35 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 16:22:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:22:35 INFO - 'branch': 'Mozilla-Inbound', 16:22:35 INFO - 'buildbot_json_path': 'buildprops.json', 16:22:35 INFO - 'config_files': ('talos/linux_config.py',), 16:22:35 INFO - 'default_actions': ('clobber', 16:22:35 INFO - 'read-buildbot-config', 16:22:35 INFO - 'download-and-extract', 16:22:35 INFO - 'populate-webroot', 16:22:35 INFO - 'create-virtualenv', 16:22:35 INFO - 'install', 16:22:35 INFO - 'run-tests'), 16:22:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:22:35 INFO - 'download_minidump_stackwalk': True, 16:22:35 INFO - 'download_symbols': 'ondemand', 16:22:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:22:35 INFO - 'tooltool.py': '/tools/tooltool.py', 16:22:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:22:35 INFO - '/tools/misc-python/virtualenv.py')}, 16:22:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:22:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:22:35 INFO - 'installer_path': 'installer.exe', 16:22:35 INFO - 'log_level': 'info', 16:22:35 INFO - 'log_name': 'talos', 16:22:35 INFO - 'log_to_console': True, 16:22:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:22:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:22:35 INFO - 'opt_config_files': (), 16:22:35 INFO - 'pip_index': False, 16:22:35 INFO - 'sps_profile': False, 16:22:35 INFO - 'sps_profile_interval': 0, 16:22:35 INFO - 'suite': 'dromaeojs-e10s', 16:22:35 INFO - 'system_bits': '32', 16:22:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:22:35 INFO - 'title': 'talos-linux64-ix-018', 16:22:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:22:35 INFO - 'use_talos_json': True, 16:22:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:22:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:22:35 INFO - 'work_dir': 'build'} 16:22:35 INFO - [mozharness: 2016-08-25 23:22:35.624154Z] Running clobber step. 16:22:35 INFO - Running pre-action listener: _resource_record_pre_action 16:22:35 INFO - Running main action method: clobber 16:22:35 INFO - rmtree: /builds/slave/test/build 16:22:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:22:36 INFO - Running post-action listener: _resource_record_post_action 16:22:36 INFO - [mozharness: 2016-08-25 23:22:36.070894Z] Finished clobber step (success) 16:22:36 INFO - [mozharness: 2016-08-25 23:22:36.070993Z] Running read-buildbot-config step. 16:22:36 INFO - Running pre-action listener: _resource_record_pre_action 16:22:36 INFO - Running main action method: read_buildbot_config 16:22:36 INFO - Using buildbot properties: 16:22:36 INFO - { 16:22:36 INFO - "project": "", 16:22:36 INFO - "product": "firefox", 16:22:36 INFO - "script_repo_revision": "production", 16:22:36 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 16:22:36 INFO - "repository": "", 16:22:36 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 16:22:36 INFO - "buildid": "20160825133002", 16:22:36 INFO - "pgo_build": "True", 16:22:36 INFO - "basedir": "/builds/slave/test", 16:22:36 INFO - "buildnumber": 1518, 16:22:36 INFO - "slavename": "talos-linux64-ix-018", 16:22:36 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 16:22:36 INFO - "platform": "ubuntu64_hw", 16:22:36 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 16:22:36 INFO - "branch": "mozilla-inbound", 16:22:36 INFO - "repo_path": "integration/mozilla-inbound", 16:22:36 INFO - "revision": "08a8d0921fe32e698df0317e68434e9f7abad6d0", 16:22:36 INFO - "stage_platform": "linux64-pgo", 16:22:36 INFO - "builduid": "0dd7aee4b282479da86499f3ac6bb0a0", 16:22:36 INFO - "slavebuilddir": "test" 16:22:36 INFO - } 16:22:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/ai5GivCzSIGE3ygYwpbYqw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 16:22:36 INFO - Running post-action listener: _resource_record_post_action 16:22:36 INFO - [mozharness: 2016-08-25 23:22:36.073392Z] Finished read-buildbot-config step (success) 16:22:36 INFO - [mozharness: 2016-08-25 23:22:36.073480Z] Running download-and-extract step. 16:22:36 INFO - Running pre-action listener: _resource_record_pre_action 16:22:36 INFO - Running main action method: download_and_extract 16:22:36 INFO - mkdir: /builds/slave/test/build/tests 16:22:36 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')]} 16:22:36 INFO - trying https://queue.taskcluster.net/v1/task/ai5GivCzSIGE3ygYwpbYqw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 16:22:36 INFO - Downloading https://queue.taskcluster.net/v1/task/ai5GivCzSIGE3ygYwpbYqw/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 16:22:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ai5GivCzSIGE3ygYwpbYqw/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 16:22:36 INFO - Downloaded 1361 bytes. 16:22:36 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 16:22:36 INFO - Using the following test package requirements: 16:22:36 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 16:22:36 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:22:36 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:22:36 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:22:36 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:22:36 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:22:36 INFO - u'jsshell-linux-x86_64.zip'], 16:22:36 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:22:36 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:22:36 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 16:22:36 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:22:36 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:22:36 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:22:36 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:22:36 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:22:36 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:22:36 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:22:36 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:22:36 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:22:36 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')]} 16:22:36 INFO - trying https://queue.taskcluster.net/v1/task/ai5GivCzSIGE3ygYwpbYqw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 16:22:36 INFO - Downloading https://queue.taskcluster.net/v1/task/ai5GivCzSIGE3ygYwpbYqw/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 16:22:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ai5GivCzSIGE3ygYwpbYqw/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 16:22:37 INFO - Downloaded 21870223 bytes. 16:22:37 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 16:22:41 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 16:22:41 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')]} 16:22:41 INFO - trying https://queue.taskcluster.net/v1/task/ai5GivCzSIGE3ygYwpbYqw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 16:22:41 INFO - Downloading https://queue.taskcluster.net/v1/task/ai5GivCzSIGE3ygYwpbYqw/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 16:22:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ai5GivCzSIGE3ygYwpbYqw/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 16:22:42 INFO - Downloaded 21870223 bytes. 16:22:42 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 16:22:47 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')]} 16:22:47 INFO - trying https://queue.taskcluster.net/v1/task/ai5GivCzSIGE3ygYwpbYqw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 16:22:47 INFO - Downloading https://queue.taskcluster.net/v1/task/ai5GivCzSIGE3ygYwpbYqw/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 16:22:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ai5GivCzSIGE3ygYwpbYqw/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 16:22:48 INFO - Downloaded 14413981 bytes. 16:22:48 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 16:22:48 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')]} 16:22:48 INFO - trying https://queue.taskcluster.net/v1/task/ai5GivCzSIGE3ygYwpbYqw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 16:22:48 INFO - Downloading https://queue.taskcluster.net/v1/task/ai5GivCzSIGE3ygYwpbYqw/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 16:22:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ai5GivCzSIGE3ygYwpbYqw/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 16:22:49 INFO - Downloaded 59709806 bytes. 16:22:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ai5GivCzSIGE3ygYwpbYqw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 16:22:49 INFO - mkdir: /builds/slave/test/properties 16:22:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:22:49 INFO - Writing to file /builds/slave/test/properties/build_url 16:22:49 INFO - Contents: 16:22:49 INFO - build_url:https://queue.taskcluster.net/v1/task/ai5GivCzSIGE3ygYwpbYqw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 16:22:50 INFO - Running post-action listener: _resource_record_post_action 16:22:50 INFO - Running post-action listener: set_extra_try_arguments 16:22:50 INFO - [mozharness: 2016-08-25 23:22:50.170117Z] Finished download-and-extract step (success) 16:22:50 INFO - [mozharness: 2016-08-25 23:22:50.170342Z] Running populate-webroot step. 16:22:50 INFO - Running pre-action listener: _resource_record_pre_action 16:22:50 INFO - Running main action method: populate_webroot 16:22:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:22:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:22:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:22:50 INFO - '--tppagecycles', 16:22:50 INFO - '7'], 16:22:50 INFO - 'tests': ['tsvgm']}}, 16:22:50 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:22:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:22:50 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:22:50 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:22:50 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:22:50 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:22:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:22:50 INFO - 'talos_options': ['--disable-e10s'], 16:22:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:22:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:22:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:22:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:22:50 INFO - 'talos_options': ['--disable-e10s'], 16:22:50 INFO - 'tests': ['damp', 'tps']}, 16:22:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:22:50 INFO - 'tests': ['damp', 'tps']}, 16:22:50 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:22:50 INFO - 'tests': ['dromaeo_dom']}, 16:22:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:22:50 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:22:50 INFO - 'tests': ['basic_compositor_video']}, 16:22:50 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:22:50 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:22:50 INFO - 'tests': ['a11yr', 16:22:50 INFO - 'ts_paint', 16:22:50 INFO - 'tpaint', 16:22:50 INFO - 'sessionrestore', 16:22:50 INFO - 'sessionrestore_no_auto_restore', 16:22:50 INFO - 'tabpaint']}, 16:22:50 INFO - 'other-e10s': {'tests': ['a11yr', 16:22:50 INFO - 'ts_paint', 16:22:50 INFO - 'tpaint', 16:22:50 INFO - 'sessionrestore', 16:22:50 INFO - 'sessionrestore_no_auto_restore', 16:22:50 INFO - 'tabpaint']}, 16:22:50 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:22:50 INFO - 'ts_paint', 16:22:50 INFO - 'tpaint', 16:22:50 INFO - 'sessionrestore', 16:22:50 INFO - 'sessionrestore_no_auto_restore', 16:22:50 INFO - 'tabpaint']}, 16:22:50 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:22:50 INFO - 'ts_paint', 16:22:50 INFO - 'tpaint', 16:22:50 INFO - 'sessionrestore', 16:22:50 INFO - 'sessionrestore_no_auto_restore', 16:22:50 INFO - 'tabpaint']}, 16:22:50 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:22:50 INFO - 'tests': ['a11yr', 16:22:50 INFO - 'ts_paint', 16:22:50 INFO - 'tpaint', 16:22:50 INFO - 'sessionrestore', 16:22:50 INFO - 'sessionrestore_no_auto_restore', 16:22:50 INFO - 'tabpaint']}, 16:22:50 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:22:50 INFO - 'tests': ['a11yr', 16:22:50 INFO - 'ts_paint', 16:22:50 INFO - 'tpaint', 16:22:50 INFO - 'sessionrestore', 16:22:50 INFO - 'sessionrestore_no_auto_restore', 16:22:50 INFO - 'tabpaint']}, 16:22:50 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:22:50 INFO - 'tests': ['tsvgx', 16:22:50 INFO - 'tsvgr_opacity', 16:22:50 INFO - 'tart', 16:22:50 INFO - 'tscrollx', 16:22:50 INFO - 'cart']}, 16:22:50 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:22:50 INFO - 'tsvgr_opacity', 16:22:50 INFO - 'tart', 16:22:50 INFO - 'tscrollx', 16:22:50 INFO - 'cart']}, 16:22:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:22:50 INFO - 'talos_options': ['--disable-e10s'], 16:22:50 INFO - 'tests': ['tp5o']}, 16:22:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:22:50 INFO - 'tests': ['tp5o']}, 16:22:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:22:50 INFO - 'talos_options': ['--disable-e10s', 16:22:50 INFO - '--xperf_path', 16:22:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:22:50 INFO - 'tests': ['tp5n']}, 16:22:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:22:50 INFO - 'talos_options': ['--xperf_path', 16:22:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:22:50 INFO - 'tests': ['tp5n']}}, 16:22:50 INFO - 'talos.zip': {'path': '', 16:22:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:22:50 INFO - Running post-action listener: _resource_record_post_action 16:22:50 INFO - [mozharness: 2016-08-25 23:22:50.188880Z] Finished populate-webroot step (success) 16:22:50 INFO - [mozharness: 2016-08-25 23:22:50.188968Z] Running create-virtualenv step. 16:22:50 INFO - Running pre-action listener: _resource_record_pre_action 16:22:50 INFO - Running main action method: create_virtualenv 16:22:50 INFO - Creating virtualenv /builds/slave/test/build/venv 16:22:50 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 16:22:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:22:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:22:50 INFO - Using real prefix '/usr' 16:22:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:22:50 INFO - Installing distribute.............................................................................................................................................................................................done. 16:22:52 INFO - Installing pip.................done. 16:22:52 INFO - Return code: 0 16:22:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:22:52 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')]} 16:22:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:22:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:22:52 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')]} 16:22:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:22:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:22:52 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 0x7f06dae27f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x141f230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1419090>, '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 0x141c9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x141ce40>, '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': '62c568580acbfdaac3eec7be000001dc-1472167353.800986-1502237999', '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 16:22:52 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 16:22:52 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 16:22:52 INFO - Using env: {'DISPLAY': ':0', 16:22:52 INFO - 'HOME': '/home/cltbld', 16:22:52 INFO - 'LANG': 'en_US.UTF-8', 16:22:52 INFO - 'LANGUAGE': 'en_US:en', 16:22:52 INFO - 'LOGNAME': 'cltbld', 16:22:52 INFO - 'MAIL': '/var/mail/cltbld', 16:22:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:22:52 INFO - 'MOZ_NO_REMOTE': '1', 16:22:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:22:52 INFO - 'NO_EM_RESTART': '1', 16:22:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:22:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:22:52 INFO - 'PWD': '/builds/slave/test', 16:22:52 INFO - 'SHELL': '/bin/bash', 16:22:52 INFO - 'SHLVL': '1', 16:22:52 INFO - 'TERM': 'linux', 16:22:52 INFO - 'TMOUT': '86400', 16:22:52 INFO - 'USER': 'cltbld', 16:22:52 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1472167353.800986-1502237999', 16:22:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:22:52 INFO - '_': '/tools/buildbot/bin/python'} 16:22:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:22:52 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 16:22:52 INFO - Cleaning up... 16:22:52 INFO - Return code: 0 16:22:52 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:22:52 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')]} 16:22:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:22:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:22:52 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')]} 16:22:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:22:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:22:52 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 0x7f06dae27f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x141f230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1419090>, '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 0x141c9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x141ce40>, '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': '62c568580acbfdaac3eec7be000001dc-1472167353.800986-1502237999', '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 16:22:52 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 16:22:52 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 16:22:52 INFO - Using env: {'DISPLAY': ':0', 16:22:52 INFO - 'HOME': '/home/cltbld', 16:22:52 INFO - 'LANG': 'en_US.UTF-8', 16:22:52 INFO - 'LANGUAGE': 'en_US:en', 16:22:52 INFO - 'LOGNAME': 'cltbld', 16:22:52 INFO - 'MAIL': '/var/mail/cltbld', 16:22:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:22:52 INFO - 'MOZ_NO_REMOTE': '1', 16:22:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:22:52 INFO - 'NO_EM_RESTART': '1', 16:22:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:22:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:22:52 INFO - 'PWD': '/builds/slave/test', 16:22:52 INFO - 'SHELL': '/bin/bash', 16:22:52 INFO - 'SHLVL': '1', 16:22:52 INFO - 'TERM': 'linux', 16:22:52 INFO - 'TMOUT': '86400', 16:22:52 INFO - 'USER': 'cltbld', 16:22:52 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1472167353.800986-1502237999', 16:22:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:22:52 INFO - '_': '/tools/buildbot/bin/python'} 16:22:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:22:53 INFO - Downloading/unpacking psutil>=3.1.1 16:22: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 16:22: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 16:22: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 16:22: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 16:22: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 16:22: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 16:22:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:22:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:22:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:22:55 INFO - Installing collected packages: psutil 16:22:55 INFO - Running setup.py install for psutil 16:22:55 INFO - building 'psutil._psutil_linux' extension 16:22:55 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 16:22:55 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 16:22:55 INFO - building 'psutil._psutil_posix' extension 16:22:55 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 16:22:55 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 16:22:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:22:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:22:55 INFO - Successfully installed psutil 16:22:55 INFO - Cleaning up... 16:22:55 INFO - Return code: 0 16:22:55 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:22:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:22:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:22:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:22:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:22:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:22:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:22:55 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 0x7f06dae27f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x141f230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1419090>, '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 0x141c9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x141ce40>, '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': '62c568580acbfdaac3eec7be000001dc-1472167353.800986-1502237999', '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 16:22:55 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 16:22:55 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 16:22:55 INFO - Using env: {'DISPLAY': ':0', 16:22:55 INFO - 'HOME': '/home/cltbld', 16:22:55 INFO - 'LANG': 'en_US.UTF-8', 16:22:55 INFO - 'LANGUAGE': 'en_US:en', 16:22:55 INFO - 'LOGNAME': 'cltbld', 16:22:55 INFO - 'MAIL': '/var/mail/cltbld', 16:22:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:22:55 INFO - 'MOZ_NO_REMOTE': '1', 16:22:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:22:55 INFO - 'NO_EM_RESTART': '1', 16:22:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:22:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:22:55 INFO - 'PWD': '/builds/slave/test', 16:22:55 INFO - 'SHELL': '/bin/bash', 16:22:55 INFO - 'SHLVL': '1', 16:22:55 INFO - 'TERM': 'linux', 16:22:55 INFO - 'TMOUT': '86400', 16:22:55 INFO - 'USER': 'cltbld', 16:22:55 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1472167353.800986-1502237999', 16:22:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:22:55 INFO - '_': '/tools/buildbot/bin/python'} 16:22:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:22:55 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:22:55 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 16:22:55 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 16:22:55 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 16:22:55 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 16:22:55 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 16:22:55 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 16:22:57 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:22:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:22:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:22:57 INFO - Installing collected packages: mozsystemmonitor 16:22:57 INFO - Running setup.py install for mozsystemmonitor 16:22:57 INFO - Successfully installed mozsystemmonitor 16:22:57 INFO - Cleaning up... 16:22:57 INFO - Return code: 0 16:22:57 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:22: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')]} 16:22:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:22:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:22: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')]} 16:22:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:22:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:22:57 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 0x7f06dae27f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x141f230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1419090>, '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 0x141c9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x141ce40>, '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': '62c568580acbfdaac3eec7be000001dc-1472167353.800986-1502237999', '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 16:22:57 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 16:22:57 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 16:22:57 INFO - Using env: {'DISPLAY': ':0', 16:22:57 INFO - 'HOME': '/home/cltbld', 16:22:57 INFO - 'LANG': 'en_US.UTF-8', 16:22:57 INFO - 'LANGUAGE': 'en_US:en', 16:22:57 INFO - 'LOGNAME': 'cltbld', 16:22:57 INFO - 'MAIL': '/var/mail/cltbld', 16:22:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:22:57 INFO - 'MOZ_NO_REMOTE': '1', 16:22:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:22:57 INFO - 'NO_EM_RESTART': '1', 16:22:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:22:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:22:57 INFO - 'PWD': '/builds/slave/test', 16:22:57 INFO - 'SHELL': '/bin/bash', 16:22:57 INFO - 'SHLVL': '1', 16:22:57 INFO - 'TERM': 'linux', 16:22:57 INFO - 'TMOUT': '86400', 16:22:57 INFO - 'USER': 'cltbld', 16:22:57 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1472167353.800986-1502237999', 16:22:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:22:57 INFO - '_': '/tools/buildbot/bin/python'} 16:22:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:22:58 INFO - Downloading/unpacking jsonschema==2.5.1 16:22:58 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 16:22:58 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 16:22:58 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 16:22:58 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 16:22:58 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 16:22:58 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 16:23:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:23:00 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:23:00 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 16:23:00 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 16:23:00 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 16:23:00 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 16:23:00 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 16:23:00 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 16:23:00 INFO - Downloading functools32-3.2.3-2.tar.gz 16:23:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:23:00 INFO - warning: no files found matching '*.txt' 16:23:00 INFO - no previously-included directories found matching 'build' 16:23:00 INFO - no previously-included directories found matching 'dist' 16:23:00 INFO - no previously-included directories found matching '.git*' 16:23:00 INFO - Installing collected packages: jsonschema, functools32 16:23:00 INFO - Running setup.py install for functools32 16:23:00 INFO - warning: no files found matching '*.txt' 16:23:00 INFO - no previously-included directories found matching 'build' 16:23:00 INFO - no previously-included directories found matching 'dist' 16:23:00 INFO - no previously-included directories found matching '.git*' 16:23:00 INFO - Successfully installed jsonschema functools32 16:23:00 INFO - Cleaning up... 16:23:00 INFO - Return code: 0 16:23:00 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:23:00 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')]} 16:23:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:23:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:23:00 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')]} 16:23:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:23:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:23:00 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 0x7f06dae27f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x141f230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1419090>, '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 0x141c9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x141ce40>, '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': '62c568580acbfdaac3eec7be000001dc-1472167353.800986-1502237999', '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 16:23:00 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 16:23:00 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 16:23:00 INFO - Using env: {'DISPLAY': ':0', 16:23:00 INFO - 'HOME': '/home/cltbld', 16:23:00 INFO - 'LANG': 'en_US.UTF-8', 16:23:00 INFO - 'LANGUAGE': 'en_US:en', 16:23:00 INFO - 'LOGNAME': 'cltbld', 16:23:00 INFO - 'MAIL': '/var/mail/cltbld', 16:23:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:23:00 INFO - 'MOZ_NO_REMOTE': '1', 16:23:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:23:00 INFO - 'NO_EM_RESTART': '1', 16:23:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:23:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:23:00 INFO - 'PWD': '/builds/slave/test', 16:23:00 INFO - 'SHELL': '/bin/bash', 16:23:00 INFO - 'SHLVL': '1', 16:23:00 INFO - 'TERM': 'linux', 16:23:00 INFO - 'TMOUT': '86400', 16:23:00 INFO - 'USER': 'cltbld', 16:23:00 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1472167353.800986-1502237999', 16:23:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:23:00 INFO - '_': '/tools/buildbot/bin/python'} 16:23:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:23:00 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:23:00 INFO - Cleaning up... 16:23:00 INFO - Return code: 0 16:23:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:23:00 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')]} 16:23:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:23:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:23:00 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')]} 16:23:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:23:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:23:00 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 0x7f06dae27f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x141f230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1419090>, '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 0x141c9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x141ce40>, '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': '62c568580acbfdaac3eec7be000001dc-1472167353.800986-1502237999', '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 16:23:00 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 16:23:00 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 16:23:00 INFO - Using env: {'DISPLAY': ':0', 16:23:00 INFO - 'HOME': '/home/cltbld', 16:23:00 INFO - 'LANG': 'en_US.UTF-8', 16:23:00 INFO - 'LANGUAGE': 'en_US:en', 16:23:00 INFO - 'LOGNAME': 'cltbld', 16:23:00 INFO - 'MAIL': '/var/mail/cltbld', 16:23:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:23:00 INFO - 'MOZ_NO_REMOTE': '1', 16:23:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:23:00 INFO - 'NO_EM_RESTART': '1', 16:23:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:23:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:23:00 INFO - 'PWD': '/builds/slave/test', 16:23:00 INFO - 'SHELL': '/bin/bash', 16:23:00 INFO - 'SHLVL': '1', 16:23:00 INFO - 'TERM': 'linux', 16:23:00 INFO - 'TMOUT': '86400', 16:23:00 INFO - 'USER': 'cltbld', 16:23:00 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1472167353.800986-1502237999', 16:23:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:23:00 INFO - '_': '/tools/buildbot/bin/python'} 16:23:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:23:00 INFO - Downloading/unpacking blobuploader==1.2.4 16:23:00 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 16:23:00 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 16:23:00 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 16:23:00 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 16:23:00 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 16:23:00 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 16:23:02 INFO - Downloading blobuploader-1.2.4.tar.gz 16:23:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:23:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:23: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 16:23: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 16:23: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 16:23: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 16:23: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 16:23: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 16:23:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:23:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:23:03 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 16:23:03 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 16:23:03 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 16:23:03 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 16:23:03 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 16:23:03 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 16:23:03 INFO - Downloading docopt-0.6.1.tar.gz 16:23:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:23:03 INFO - Installing collected packages: blobuploader, requests, docopt 16:23:03 INFO - Running setup.py install for blobuploader 16:23:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:23:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:23:03 INFO - Running setup.py install for requests 16:23:04 INFO - Running setup.py install for docopt 16:23:04 INFO - Successfully installed blobuploader requests docopt 16:23:04 INFO - Cleaning up... 16:23:04 INFO - Return code: 0 16:23:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:23: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')]} 16:23:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:23:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:23: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')]} 16:23:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:23:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:23:04 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 0x7f06dae27f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x141f230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1419090>, '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 0x141c9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x141ce40>, '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': '62c568580acbfdaac3eec7be000001dc-1472167353.800986-1502237999', '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 16:23:04 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 16:23:04 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 16:23:04 INFO - Using env: {'DISPLAY': ':0', 16:23:04 INFO - 'HOME': '/home/cltbld', 16:23:04 INFO - 'LANG': 'en_US.UTF-8', 16:23:04 INFO - 'LANGUAGE': 'en_US:en', 16:23:04 INFO - 'LOGNAME': 'cltbld', 16:23:04 INFO - 'MAIL': '/var/mail/cltbld', 16:23:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:23:04 INFO - 'MOZ_NO_REMOTE': '1', 16:23:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:23:04 INFO - 'NO_EM_RESTART': '1', 16:23:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:23:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:23:04 INFO - 'PWD': '/builds/slave/test', 16:23:04 INFO - 'SHELL': '/bin/bash', 16:23:04 INFO - 'SHLVL': '1', 16:23:04 INFO - 'TERM': 'linux', 16:23:04 INFO - 'TMOUT': '86400', 16:23:04 INFO - 'USER': 'cltbld', 16:23:04 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1472167353.800986-1502237999', 16:23:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:23:04 INFO - '_': '/tools/buildbot/bin/python'} 16:23:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:23:04 INFO - Running setup.py (path:/tmp/pip-slgYSE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:23:04 INFO - Running setup.py (path:/tmp/pip-iFwUwQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:23:04 INFO - Running setup.py (path:/tmp/pip-j2bIoj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:23:04 INFO - Running setup.py (path:/tmp/pip-a5R8Sn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:23:04 INFO - Running setup.py (path:/tmp/pip-O6bcjM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:23:04 INFO - Running setup.py (path:/tmp/pip-BsVX_h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:23:04 INFO - Running setup.py (path:/tmp/pip-GCi7n7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:23:04 INFO - Running setup.py (path:/tmp/pip-NaImlI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:23:05 INFO - Running setup.py (path:/tmp/pip-Qo5KIf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:23:05 INFO - Running setup.py (path:/tmp/pip-xIrk00-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:23:05 INFO - Running setup.py (path:/tmp/pip-LnA4XY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:23:05 INFO - Running setup.py (path:/tmp/pip-WWyeuj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:23:05 INFO - Running setup.py (path:/tmp/pip-8ypJtp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:23:05 INFO - Running setup.py (path:/tmp/pip-T7h_kC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:23:05 INFO - Running setup.py (path:/tmp/pip-TiTQOd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:23:05 INFO - Running setup.py (path:/tmp/pip-pLBbSI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:23:05 INFO - Running setup.py (path:/tmp/pip-MTtWyH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:23:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:23:05 INFO - Running setup.py install for manifestparser 16:23:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:23:05 INFO - Running setup.py install for mozcrash 16:23:05 INFO - Running setup.py install for mozdebug 16:23:05 INFO - Running setup.py install for mozdevice 16:23:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:23:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:23:06 INFO - Running setup.py install for mozfile 16:23:06 INFO - Running setup.py install for mozhttpd 16:23:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:23:06 INFO - Running setup.py install for mozinfo 16:23:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:23:06 INFO - Running setup.py install for mozInstall 16:23:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:23:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:23:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:23:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:23:06 INFO - Running setup.py install for mozleak 16:23:06 INFO - Running setup.py install for mozlog 16:23:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:23:06 INFO - Running setup.py install for moznetwork 16:23:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:23:06 INFO - Running setup.py install for mozprocess 16:23:06 INFO - Running setup.py install for mozprofile 16:23:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:23:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:23:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:23:06 INFO - Running setup.py install for mozrunner 16:23:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:23:07 INFO - Running setup.py install for mozscreenshot 16:23:07 INFO - Running setup.py install for moztest 16:23:07 INFO - Running setup.py install for mozversion 16:23:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:23:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:23:07 INFO - Cleaning up... 16:23:07 INFO - Return code: 0 16:23:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:23:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:23:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:23:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:23:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:23:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:23:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:23:07 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 0x7f06dae27f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x141f230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1419090>, '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 0x141c9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x141ce40>, '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': '62c568580acbfdaac3eec7be000001dc-1472167353.800986-1502237999', '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 16:23:07 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 16:23:07 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 16:23:07 INFO - Using env: {'DISPLAY': ':0', 16:23:07 INFO - 'HOME': '/home/cltbld', 16:23:07 INFO - 'LANG': 'en_US.UTF-8', 16:23:07 INFO - 'LANGUAGE': 'en_US:en', 16:23:07 INFO - 'LOGNAME': 'cltbld', 16:23:07 INFO - 'MAIL': '/var/mail/cltbld', 16:23:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:23:07 INFO - 'MOZ_NO_REMOTE': '1', 16:23:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:23:07 INFO - 'NO_EM_RESTART': '1', 16:23:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:23:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:23:07 INFO - 'PWD': '/builds/slave/test', 16:23:07 INFO - 'SHELL': '/bin/bash', 16:23:07 INFO - 'SHLVL': '1', 16:23:07 INFO - 'TERM': 'linux', 16:23:07 INFO - 'TMOUT': '86400', 16:23:07 INFO - 'USER': 'cltbld', 16:23:07 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1472167353.800986-1502237999', 16:23:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:23:07 INFO - '_': '/tools/buildbot/bin/python'} 16:23:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:23:07 INFO - Running setup.py (path:/tmp/pip-R9qQLK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:23:07 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)) 16:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:23:07 INFO - Running setup.py (path:/tmp/pip-min1pB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:23:07 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)) 16:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:23:07 INFO - Running setup.py (path:/tmp/pip-KTjeem-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:23:07 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)) 16:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:23:07 INFO - Running setup.py (path:/tmp/pip-lhxdkp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:23:07 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)) 16:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:23:07 INFO - Running setup.py (path:/tmp/pip-Mqn8Os-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:23:08 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)) 16:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:23:08 INFO - Running setup.py (path:/tmp/pip-STNNfe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:23:08 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)) 16:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:23:08 INFO - Running setup.py (path:/tmp/pip-DKyPz2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:23:08 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)) 16:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:23:08 INFO - Running setup.py (path:/tmp/pip-GUDvjo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:23:08 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)) 16:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:23:08 INFO - Running setup.py (path:/tmp/pip-K5fGfE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:23:08 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)) 16:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:23:08 INFO - Running setup.py (path:/tmp/pip-M5brb2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:23:08 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)) 16:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:23:08 INFO - Running setup.py (path:/tmp/pip-w4iUUP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:23:08 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)) 16:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:23:08 INFO - Running setup.py (path:/tmp/pip-yGqD38-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:23:08 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)) 16:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:23:08 INFO - Running setup.py (path:/tmp/pip-x2bEsK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:23:08 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)) 16:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:23:08 INFO - Running setup.py (path:/tmp/pip-ETx5km-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:23:08 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)) 16:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:23:08 INFO - Running setup.py (path:/tmp/pip-1VGJG8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:23:08 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)) 16:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:23:08 INFO - Running setup.py (path:/tmp/pip-Bc0JEY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:23:08 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)) 16:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:23:08 INFO - Running setup.py (path:/tmp/pip-6I7Lxx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:23:08 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)) 16:23:08 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)) 16:23:08 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)) 16:23:08 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)) 16:23:08 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)) 16:23:08 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)) 16:23:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:23:08 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 16:23:08 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 16:23:08 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 16:23:08 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 16:23:08 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 16:23:08 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 16:23:10 INFO - Downloading blessings-1.6.tar.gz 16:23:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:23:10 INFO - Installing collected packages: blessings 16:23:10 INFO - Running setup.py install for blessings 16:23:10 INFO - Successfully installed blessings 16:23:10 INFO - Cleaning up... 16:23:11 INFO - Return code: 0 16:23:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:23:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:23:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:23:11 INFO - Reading from file tmpfile_stdout 16:23:11 INFO - Current package versions: 16:23:11 INFO - argparse == 1.2.1 16:23:11 INFO - blessings == 1.6 16:23:11 INFO - blobuploader == 1.2.4 16:23:11 INFO - docopt == 0.6.1 16:23:11 INFO - functools32 == 3.2.3-2 16:23:11 INFO - jsonschema == 2.5.1 16:23:11 INFO - manifestparser == 1.1 16:23:11 INFO - mozInstall == 1.12 16:23:11 INFO - mozcrash == 0.17 16:23:11 INFO - mozdebug == 0.1 16:23:11 INFO - mozdevice == 0.48 16:23:11 INFO - mozfile == 1.2 16:23:11 INFO - mozhttpd == 0.7 16:23:11 INFO - mozinfo == 0.9 16:23:11 INFO - mozleak == 0.1 16:23:11 INFO - mozlog == 3.3 16:23:11 INFO - moznetwork == 0.27 16:23:11 INFO - mozprocess == 0.23 16:23:11 INFO - mozprofile == 0.28 16:23:11 INFO - mozrunner == 6.12 16:23:11 INFO - mozscreenshot == 0.1 16:23:11 INFO - mozsystemmonitor == 0.3 16:23:11 INFO - moztest == 0.7 16:23:11 INFO - mozversion == 1.4 16:23:11 INFO - psutil == 3.1.1 16:23:11 INFO - requests == 1.2.3 16:23:11 INFO - wsgiref == 0.1.2 16:23:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:23:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:23:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:23:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:23:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:23:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:23:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:23:11 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 0x7f06dae27f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x141f230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1419090>, '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 0x141c9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x141ce40>, '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': '62c568580acbfdaac3eec7be000001dc-1472167353.800986-1502237999', '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 16:23:11 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 16:23:11 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 16:23:11 INFO - Using env: {'DISPLAY': ':0', 16:23:11 INFO - 'HOME': '/home/cltbld', 16:23:11 INFO - 'LANG': 'en_US.UTF-8', 16:23:11 INFO - 'LANGUAGE': 'en_US:en', 16:23:11 INFO - 'LOGNAME': 'cltbld', 16:23:11 INFO - 'MAIL': '/var/mail/cltbld', 16:23:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:23:11 INFO - 'MOZ_NO_REMOTE': '1', 16:23:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:23:11 INFO - 'NO_EM_RESTART': '1', 16:23:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:23:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:23:11 INFO - 'PWD': '/builds/slave/test', 16:23:11 INFO - 'SHELL': '/bin/bash', 16:23:11 INFO - 'SHLVL': '1', 16:23:11 INFO - 'TERM': 'linux', 16:23:11 INFO - 'TMOUT': '86400', 16:23:11 INFO - 'USER': 'cltbld', 16:23:11 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1472167353.800986-1502237999', 16:23:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:23:11 INFO - '_': '/tools/buildbot/bin/python'} 16:23:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:23:11 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)) 16:23:11 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)) 16:23:11 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)) 16:23:11 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)) 16:23:11 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)) 16:23:11 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)) 16:23:11 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)) 16:23:11 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)) 16:23:11 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)) 16:23:11 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)) 16:23:11 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)) 16:23:11 INFO - Cleaning up... 16:23:11 INFO - Return code: 0 16:23:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:23:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:23:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:23:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:23:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:23:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:23:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:23:11 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 0x7f06dae27f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x141f230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1419090>, '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 0x141c9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x141ce40>, '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': '62c568580acbfdaac3eec7be000001dc-1472167353.800986-1502237999', '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 16:23:11 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 16:23:11 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 16:23:11 INFO - Using env: {'DISPLAY': ':0', 16:23:11 INFO - 'HOME': '/home/cltbld', 16:23:11 INFO - 'LANG': 'en_US.UTF-8', 16:23:11 INFO - 'LANGUAGE': 'en_US:en', 16:23:11 INFO - 'LOGNAME': 'cltbld', 16:23:11 INFO - 'MAIL': '/var/mail/cltbld', 16:23:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:23:11 INFO - 'MOZ_NO_REMOTE': '1', 16:23:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:23:11 INFO - 'NO_EM_RESTART': '1', 16:23:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:23:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:23:11 INFO - 'PWD': '/builds/slave/test', 16:23:11 INFO - 'SHELL': '/bin/bash', 16:23:11 INFO - 'SHLVL': '1', 16:23:11 INFO - 'TERM': 'linux', 16:23:11 INFO - 'TMOUT': '86400', 16:23:11 INFO - 'USER': 'cltbld', 16:23:11 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1472167353.800986-1502237999', 16:23:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:23:11 INFO - '_': '/tools/buildbot/bin/python'} 16:23:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:23:11 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:23:11 INFO - Cleaning up... 16:23:11 INFO - Return code: 0 16:23:11 INFO - Running post-action listener: _resource_record_post_action 16:23:11 INFO - Running post-action listener: _start_resource_monitoring 16:23:11 INFO - Starting resource monitoring. 16:23:11 INFO - [mozharness: 2016-08-25 23:23:11.701658Z] Finished create-virtualenv step (success) 16:23:11 INFO - [mozharness: 2016-08-25 23:23:11.702160Z] Running install step. 16:23:11 INFO - Running pre-action listener: _resource_record_pre_action 16:23:11 INFO - Running main action method: install 16:23:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:23:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:23:11 INFO - Reading from file tmpfile_stdout 16:23:11 INFO - Detecting whether we're running mozinstall >=1.0... 16:23:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:23:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:23:11 INFO - Reading from file tmpfile_stdout 16:23:11 INFO - Output received: 16:23:11 INFO - Usage: mozinstall [options] installer 16:23:11 INFO - Options: 16:23:11 INFO - -h, --help show this help message and exit 16:23:11 INFO - -d DEST, --destination=DEST 16:23:11 INFO - Directory to install application into. [default: 16:23:11 INFO - "/builds/slave/test"] 16:23:11 INFO - --app=APP Application being installed. [default: firefox] 16:23:11 INFO - mkdir: /builds/slave/test/build/application 16:23:11 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'] 16:23:11 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 16:23:28 INFO - Reading from file tmpfile_stdout 16:23:28 INFO - Output received: 16:23:28 INFO - /builds/slave/test/build/application/firefox/firefox 16:23:28 INFO - Running post-action listener: _resource_record_post_action 16:23:28 INFO - [mozharness: 2016-08-25 23:23:28.977619Z] Finished install step (success) 16:23:28 INFO - [mozharness: 2016-08-25 23:23:28.977865Z] Running run-tests step. 16:23:28 INFO - Running pre-action listener: _resource_record_pre_action 16:23:28 INFO - Running main action method: run_tests 16:23:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:23:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:23:28 INFO - Python 2.7.3 16:23:28 INFO - Return code: 0 16:23:28 INFO - grabbing minidump binary from tooltool 16:23:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:23:28 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 0x1419090>, '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 0x141c9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x141ce40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:23:28 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 16:23:28 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 16:23:28 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 16:23:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:23:29 INFO - Return code: 0 16:23:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:23:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:23:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:23:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:23:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:23:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ai5GivCzSIGE3ygYwpbYqw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--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 16:23:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ai5GivCzSIGE3ygYwpbYqw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-018 --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 16:23:29 INFO - Using env: {'DISPLAY': ':0', 16:23:29 INFO - 'HOME': '/home/cltbld', 16:23:29 INFO - 'LANG': 'en_US.UTF-8', 16:23:29 INFO - 'LANGUAGE': 'en_US:en', 16:23:29 INFO - 'LOGNAME': 'cltbld', 16:23:29 INFO - 'MAIL': '/var/mail/cltbld', 16:23:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:23:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:23:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:23:29 INFO - 'MOZ_NO_REMOTE': '1', 16:23:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:23:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:23:29 INFO - 'NO_EM_RESTART': '1', 16:23:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:23:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:23:29 INFO - 'PWD': '/builds/slave/test', 16:23:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:23:29 INFO - 'SHELL': '/bin/bash', 16:23:29 INFO - 'SHLVL': '1', 16:23:29 INFO - 'TERM': 'linux', 16:23:29 INFO - 'TMOUT': '86400', 16:23:29 INFO - 'USER': 'cltbld', 16:23:29 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1472167353.800986-1502237999', 16:23:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:23:29 INFO - '_': '/tools/buildbot/bin/python'} 16:23:29 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ai5GivCzSIGE3ygYwpbYqw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--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 16:23:29 INFO - mozversion application_buildid: 20160825133002 16:23:29 INFO - mozversion application_changeset: 08a8d0921fe32e698df0317e68434e9f7abad6d0 16:23:29 INFO - mozversion application_display_name: Nightly 16:23:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:23:29 INFO - mozversion application_name: Firefox 16:23:29 INFO - mozversion application_remotingname: firefox 16:23:29 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 16:23:29 INFO - mozversion application_vendor: Mozilla 16:23:29 INFO - mozversion application_version: 51.0a1 16:23:29 INFO - mozversion platform_buildid: 20160825133002 16:23:29 INFO - mozversion platform_changeset: 08a8d0921fe32e698df0317e68434e9f7abad6d0 16:23:29 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 16:23:29 INFO - mozversion platform_version: 51.0a1 16:23:29 INFO - using testdate: 1472167409 16:23:29 INFO - actual date: 1472167409 16:23:29 INFO - starting webserver on 'localhost:56765' 16:23:29 INFO - SUITE-START | Running 2 tests 16:23:29 INFO - TEST-START | dromaeo_css 16:23:29 INFO - operating with platform_type : linux_ 16:23:29 INFO - Initialising browser for dromaeo_css test... 16:23:29 INFO - TEST-INFO | started process 4793 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOhp6si/profile http://localhost:56765/getInfo.html) 16:23:33 INFO - PROCESS | 4793 | __metrics Screen width/height:1600/1200 16:23:33 INFO - PROCESS | 4793 | colorDepth:24 16:23:33 INFO - PROCESS | 4793 | Browser inner width/height: 1024/697 16:23:33 INFO - PROCESS | 4793 | __metrics 16:23:34 ERROR - PROCESS | 4793 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2991: TypeError: this.tabs is undefined 16:23:34 INFO - TEST-INFO | 4793: exit 0 16:23:34 INFO - Browser initialized. 16:23:34 INFO - Running cycle 1/1 for dromaeo_css test... 16:23:34 INFO - TEST-INFO | started process 4914 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOhp6si/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:23:47 INFO - PROCESS | 4914 | RSS: Main: 191352832 16:23:47 INFO - PROCESS | 4914 | 16:24:36 INFO - PROCESS | 4914 | 1472167476803 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] 16:26:46 INFO - PROCESS | 4914 | Cycle 1(1): loaded http://localhost:56765/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56765/tests/dromaeo/cssquery-ext.html) 16:26:48 INFO - PROCESS | 4914 | RSS: Main: 207437824 16:26:48 INFO - PROCESS | 4914 | 16:29:50 INFO - PROCESS | 4914 | Cycle 1(1): loaded http://localhost:56765/tests/dromaeo/cssquery-ext.html (next: http://localhost:56765/tests/dromaeo/cssquery-jquery.html) 16:29:50 INFO - PROCESS | 4914 | RSS: Main: 200462336 16:29:50 INFO - PROCESS | 4914 | 16:32:52 INFO - PROCESS | 4914 | Cycle 1(1): loaded http://localhost:56765/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56765/tests/dromaeo/cssquery-mootools.html) 16:32:53 INFO - PROCESS | 4914 | RSS: Main: 197611520 16:32:53 INFO - PROCESS | 4914 | 16:35:55 INFO - PROCESS | 4914 | Cycle 1(1): loaded http://localhost:56765/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56765/tests/dromaeo/cssquery-prototype.html) 16:35:55 INFO - PROCESS | 4914 | RSS: Main: 194232320 16:35:55 INFO - PROCESS | 4914 | 16:38:58 INFO - PROCESS | 4914 | Cycle 1(1): loaded http://localhost:56765/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56765/tests/dromaeo/cssquery-yui.html) 16:38:59 INFO - PROCESS | 4914 | RSS: Main: 197664768 16:38:59 INFO - PROCESS | 4914 | 16:42:01 INFO - PROCESS | 4914 | Cycle 1(1): loaded http://localhost:56765/tests/dromaeo/cssquery-yui.html (next: http://localhost:56765/tests/dromaeo/cssquery-dojo.html) 16:42:02 INFO - PROCESS | 4914 | RSS: Main: 198410240 16:42:02 INFO - PROCESS | 4914 | 16:42:02 INFO - PROCESS | 4914 | __start_tp_report 16:42:02 INFO - PROCESS | 4914 | _x_x_mozilla_page_load 16:42:02 INFO - PROCESS | 4914 | _x_x_mozilla_page_load_details 16:42:02 INFO - PROCESS | 4914 | |i|pagename|runs| 16:42:02 INFO - PROCESS | 4914 | |0;dojo.html;3071.9385612287756;3087.0275863103134;3104.053263754554;3114.7663925205607;3127.3588914272577;5288.60335474839;5370.650907691002;5430.809921652743;5446.509814116729;5494.340679118506;5340.092184328664;5350.170723537858;5381.327334083239;5397.487238712326;5435.809746658858;4589.426321709786;4784.9521504785025;4889.828855990041;4947.381577302837;5024.723640199788;4928.359313289267;4940.950590494085;4947.975260123694;4983.725895075788;5000;4768.785404656799;4810.158222311082;4881.072596206709;4943.382077240345;4945.986072855092;4812.061647978646;4827.541383568555;4838.104950584153;4840.467548569654;4926.901461970776;4828.0585285869265;4858.392700912386;4859.246816743411;4874.025194961022;4928.088303663833;5359.705216213107;5364.91952620711;5368.812091576776;5383.892322153535;5430.022595932731;5827.329857066449;5831.446012628793;5836.2996440427;5841.620294680874;5851.063829787214;5797.855053623651;5867.061270196791;5868.149118377854;5869.354371019184;5873.030949893263;5234.0840352938085;5332.520073193393;5387.434319396485;5409.702466364309;5417.918731219035;5893.941060589339;5905.734241959122;5909;5915.08316210988;5930.436608522184;5594.3286805582775;5683.175939488751;5690.971545142248;5693.032184528557;5694.060480020833;5511.58663100261;5741.511971482387;5746.683932383676;5803.158542011384;5814.215080964101;5580.860478487989;5647.576431767634;5650.039493286151;5729.742161602738;5733.254676891977;5721.5136713379825;5722.284714410699;5726.055200891889;5730.025895597759;5732.426757324234;4419.027813880941;4422.159789639958;4435.379046933432;4522.66080043998;4527.071950250191;3988.980055099764;4047.2714911316248;4051.088505086332;4052.1895620875944;4103.179364127186;5253.159494480865;5537.418571050062;5603.35561410443;5639.3232812062815;5677.574181936371;5666.518345940642;5684.459976302244;5696.3449203341315;5742.310922689304;5791.073428251544;5406.08096623575;5448.264484294569;5449.427810079964;5452.91820622691;5454.754536045887;4869.975650121727;4879.975600121977;4913.582345500601;4932.926006109911;4985.800567977313;5878.676672783038;5936.079907614327;5941.376155503783;5963.880722385528;6028.276606807299;5738.512226460798;5759.769609215585;5771.797987070432;5779.826605201851;5781.277340332458;5763.36602973681;5911.940880591139;5914.556408269311;5924.170616113834;5932.080527518242;5561.332640083216;5637.379888212376;5649.152627105803;5659.971700141473;5725.227094342211;5760.308762948305;5769.509591684754;5773.451522105393;5773.509251713652;5777.595568310178;5455.563554915518;5606.551475882001;5622.156676498558;5626.2967129108865;5627.915581266366;5602.523785478117;5608.242887210175;5621.9156712650165;5632.549396048388;5692.203091567267;5648.717564121695;5665.150227465913;5673.262475878109;5679.602427830012;5684.346300175367;5489.862753431196;5592.077307244259;5690.174924635988;5696.772129114955;5703.828885133453;5580.330360356783;5589.888202236014;5634.183043458594;5646.209530665628;5646.520045796154 16:42:02 INFO - PROCESS | 4914 | |1;ext.html;562.8930503204391;571.3829064610221;573.6070791507816;587.4683411512583;593.4895989449076;38698;42481.78759106208;42646.57353426465;42724;42729.35905961413;41483.79258103713;42023.369649455286;42037.57962420375;42091.368629470504;42131.10410031548;8818.86771698425;8910.376273660846;8983.550822458883;8987.910120898772;8993.77515562113;8683.044865064838;8733.825323493526;8771.429857059271;8786;8811.118888111201;8826.382153249275;8904.243139333164;8929.553522323858;8932.196102350787;8932.508712020835;8875.156860098281;8875.28997680184;8892.466452012835;8900.287976961827;8935.597898094602;8777.253933415668;8790.912090879074;8817.955910220471;8877.689280875138;8880.644774209024;40882.79558602218;41164;41343.7932810334;41478.58521414777;41546.58453415488;3482.0598438421484;3717.237966216946;3725.105974566112;3759.981200094009;4280.122574872144;31588.52617210744;31732.682673173433;31757.364852702816;32026.359472810647;32216.033518994467;4368.89077773055;4378.7153835000945;4441.866743997685;4467.776611169428;4576.336431217454;345088.9999999975;348488;348981;349494;350152;54874.45125548773;54874.72562637161;54900.45099548953;54903;55121.44878551163;36298;36945.81527092401;37040.25919481649;38982.220355592726;58406;14305.425023495662;14386.712265754626;14410.42358305656;14411.063280886918;14458.204798736171;10249.077583017564;10270.07569318765;10319.742006449898;10340.586376545005;10365.170786337225;18909.14908829106;18941.715874261896;18953.62092758137;18972;18990.29087382142;6672.799816005528;6920.377166055079;7072.646367681596;7108.786736397917;7140.250273721288;892.6786356911507;1009.8737657792776;1066.1417558865032;1090.8363745438248;1120.9887901121047;30480.84759576188;30953.845230773702;31050.53424198639;31217.53173702351;31812.522812157837;1036.9481525923673;1066.626680661762;1067.2049323254225;1091.1543553745753;1120.7478317378689;16271.349146034263;16397.754033689504;16697.582560435843;16796;16853.494395168163;500652;503150;504802;505844;507634;55804.44195558074;56021.43978560244;56243.43756562464;56245.71877140588;56315;1293.8770816772392;1312.960611181666;1323.589687196972;1325.1121748428384;1348.514534767483;29540.704592954655;30010.54984175283;30414.391712166074;30496.847515762278;30886.69113308928;49586.50413495819;49765.253521197934;49795;49945.75027124987;50096.49903500918;416736.82421285036;420919;422149;422439;423014;27808.44383112367;27927.441451170456;28212.153635390972;28611.71388286174;28716.13851584456;46503.76748116373;46524.30213546732;47060.76469617767;47173.52826471828;47276.29085563788;38950.80524597359;39769.2046159081;39978.80010599928;40743.7962810184;41343;39683.80158099191;40497.1900561993;41461.58538414577;41726.582734173484;42298.78850605727;33790.324193516484;37885.62114378821;38478;38764.6123538761;39884.40173397459;34083;36212.63787362198;36322;36929.63070369369;37134.6286537142;27763.30591735142;27821.16536503908;27859.582106268826;28202.576961346007;28243 16:42:02 INFO - PROCESS | 4914 | |2;jquery.html;374.89690335157843;386.7969316109043;389.73303287248234;402.2377594458503;406.07009947220865;17433.564160895985;20287;20357.898210508927;20548.48628784281;20565.38303850887;18373.7243941341;18511;18761.812381876178;18970.146343414544;19213.711794323062;5522.475364840334;5573.4147914469;5747.482726554609;5750.453706897838;5757.68332741699;5720.056190728525;5763.452472015152;5799.449052340021;5802.419758024206;5805.013147764869;5773.942260577403;5809.302883653967;5809.651420914737;5810.15752715856;5815.563832712563;5878.735456904449;5892.646441213541;5938.287405511323;5985.161827879197;6024.849378765544;5574.1917421973585;5691.264164429847;5712.685802280873;5723.484886360247;5745.253117094792;18643.720344194848;22643;23280.883595582083;23374.181903633293;23445.648315275284;2384.5707772600927;2493.845126436542;2963.199936017263;3003.1591154476564;3063.947155405861;10164.796704065877;10201.897981020169;10680.412577308245;12383.62849114528;14000;1800.7388928605278;1950.7951665075248;1964.980350196494;1982.6431242376366;2006.6989951507392;78331.60834195792;79485.20514794778;80125.59937200334;81182.59408702978;81941.59029204876;10836.133109351233;11023.118150547936;11192.608258710907;11206.38364889939;11245.15661325404;15772.842271577367;15806.68386632261;15820.288087036111;15861.444849430214;15895.125768082866;7310.378617817439;7486.887696684554;7506.662200201004;7657.157712651604;7671.731489397845;6663.900041499382;6712.42944349726;6764.864702705919;6876.69054892531;6919.688614012382;4712.575868171881;4717.150912835654;4746.5490778376;4747.786349614275;4853.344798452164;1887.1507821480388;1960.725498430221;1962.1660794162424;1968.9677896040223;1988.8408927285782;931.2736065868634;938.8591711243369;971.1162841813915;1004.4324956399611;1047.1047254597363;19331.130099145572;19483.610327793365;19550.120244589027;19600.270060962426;19695.11371988264;937.386012162035;965.5220665770348;975.7804493988796;991.0634450444405;991.4745185051934;9524.333296669167;10728.463576821128;10932;11049.116070714485;11058.723531911606;349640;350003;351598;446868;453562;89113;90210;93611;97973.51013244888;99209;986.8519722041751;1015.9187265018633;1036.7149034015556;1037.0459177556666;1037.4034929915329;17318.913405432893;17529.89629335593;17571.648567028333;17777.46667599974;17841.46475605734;42178.789106054275;43254.783726081165;43539.346909797016;43737.34393984029;45469.77265113653;58222;59917.50206244879;61987.38012619816;63245.36754632579;63401.68299158659;8325.666973321;8392.832143356976;8725.47647141148;8793;8800.823983520166;12877.8068328977;13499.73000539964;13518.526851560542;13806.240656763573;13963.16221026701;11964.282143071443;12021.158518903592;12067.939660301643;12316.445759941003;12360.134790564935;11286.435678215892;11738.295702257892;11809.940950295193;11870.169088163746;11990.640280791591;11937.4031298433;12183.20809147438;12304.07719421065;12337.136400451882;12480.438380272728;8693.130686931256;8739.21347078766;8746.30029597618;8752.956235218782;9126.589303481493;10659.147268218368;11227.775444491228;11367.772644547229;11390.772184556097;11887.702807429538 16:42:02 INFO - PROCESS | 4914 | |3;mootools.html;1436.2387934394771;1450.3111022264425;1542.252007776229;1679.664067186563;1684.9831501684987;7312.451566132548;7652.349550288225;7932.6033698315;8259.545724985124;8272.131426200252;7869.252421019994;8071.112177660468;8135;8174.79563010925;8203.056648485426;2226.899789509476;2266.2747920665392;2267.331137314488;2267.5464907018663;2270.296208175471;2215.7008803811523;2245.360072379372;2282.1441959265276;2284.3603790938564;2286.16554957441;2229.4092065602626;2237.9552408951813;2244.9775502245016;2247.2359397804744;2258.8192944564476;2160.8595441296266;2166.685830554569;2179.030331502482;2189.1134090693217;2195.3194509702043;2122.1405330841035;2125.9255926042515;2125.9893700531397;2129.9041543130443;2130.179880745924;8115.229053239933;8118.228768267005;8130.3902207334095;8228.177182281785;8253.95873020631;4774.761261936889;4880.6095512358925;4897.828575999859;4899.461059283476;4902.436219834729;3048.253177971389;3163.889263875776;3163.9707101139793;3263.8368081596063;3264.2002709336125;1139.7435576995192;1147.9024282935877;1151.504852913247;1157.7800217958645;1172.8475298211263;10787.137029037658;10868.402237876913;10872.293300935415;10905.018548330609;10960.725981850437;4140.585941405835;4245.957540424556;4335.154644844288;4387.36383224437;4408.140412619572;9269.629214831466;9321.300902432346;9323.673671421468;9355.111264429868;9356.082003189329;4788.688735232199;4796.640251981115;4802.903941921212;4812.639052071108;4823.962847987699;4037.192561487714;4361.890952726144;4427.557244275611;4438.911221775611;4458.420405347284;3530.8764193253114;3617.2584620152807;3626.220362622049;3644.4715516249994;3672.5592928848173;1133.4276190523733;1137.3573930729112;1138.9829152562718;1139.3847322445952;1141.7944769941491;940.7459985803795;955.5365647660878;968.9031096890254;976.1702552830037;999.8701467341857;5417.756200970965;5630.549556035589;5697.173909783141;5730.111832665943;5750.913736293959;442.7232979387883;443.9689221754446;447.6910931457284;449.9797509112098;456.17887801956346;4076.898077548026;4094;4125.266633696509;4143.6685065194715;4208.684348673862;9887.159591434809;10057.949710251401;10171.135453486388;10192.898071019343;10272.229582781321;10077.143442807443;10082.546285417175;10082.949585252174;10090.69727908164;10099.798004040025;7609.695612175562;7684.193159718261;7687.231276872268;7697.461177717618;7726.072871255486;5607.8878422432135;5633.2395126657375;5741.196232527366;5781.190633311424;5835.591508594358;9206.539673016188;9216.400933939542;9277;9389.671361502315;9398.765030874009;9037.277017838689;9273.536323183678;9355.5789989452;9358.672446464614;9411.952940235255;6585.901211481736;6821.795346139624;6896.379325860496;6998.825029374307;7112.822179445555;7690.307872291521;7730.226977302224;7741;7747.147813740371;7765.7670269892;6972.721091156297;7119.6084215368655;7158.355747982707;7166.856662866609;7271.818204544717;6589.901151482827;6663.466922646274;6669.666516674244;6739.42714869222;6740.662966851736;6269.216347956505;6342.302346741762;6449.097126402401;6486.124373209556;6538.280789113289;4926.605871530197;4986.950130498649;5000.299958005955;5017.071841709296;5027.145385284583;4978.850634480971;4993.425756038102;5015.573676237561;5035.320231768811;5060.165072762953 16:42:02 INFO - PROCESS | 4914 | |4;prototype.html;321.1873958884024;322.74986885164;327.93113446176307;328.18937225054106;330.74863104040924;5435.211894275328;5479.6164268501225;5487.780488780444;5510.071474983763;5515.435322575002;5434.673919564829;5443.510084092431;5477.863053423666;5480.177973304007;5499.807506737265;4014.2372949139644;4130.306574304535;4146.274401979656;4191.622753952143;4216.430781844442;4207.873763787091;4213.30480470722;4216.894577635553;4216.894577635569;4230.344296634026;4173.499180098377;4205.222033923734;4218.599233072853;4220.008298049971;4230.344296634026;4107.178564287155;4189.434426352434;4216.325387937946;4218.873433796991;4251.319788833787;3698.685611723007;3705.5738590061947;3719.2561487702296;3719.479272901796;3722.2183341498317;5332.33345831771;5335.439778823206;5336.653117547347;5345.786168553253;5355.571554275649;4736.5026672199265;4854.174790285625;4886.633502487292;4905.705657660552;4911.600193944709;5633.63381380209;5675.432456754333;5683.54531637468;5687.0900655895275;5712.514746166027;4073.246449406869;4073.796310184479;4084.8978775530554;4088.9386659200136;4114.979425102885;5670.631408958446;5924.437178468039;5977.671228082454;5991.4907232884825;5995.160677505153;4091.447654566655;4123.958760412417;4125.731827431207;4128.566500517462;4129.710920235555;4146.315857883415;4156.547636894186;4165.375193720966;4170.749755014709;4172.165566886635;4574.382458368078;4791.496892826272;4835.178019736653;4849.733264670406;4856.368672072608;5780.132980053026;5784.132380142928;5798.739056742373;5810.1865738796605;5816;1436.1957303909844;1454.6508837878832;1455.2796365798997;1457.9781303280458;1458.8475104667407;918.4168053286211;920.1994264989502;930.432436213909;949.5489642419795;977.8044391121662;5451.1653939951;5483.382402191363;5506.64206826555;5513.476219759116;5550.612346913272;5769.192313076089;5822.82531524055;5837.9124313135335;5865.736041878125;5873.706314684334;5238.92141617876;5384.649997750212;5442.8911421771345;5468.425815289417;5541.473560011793;3042.3154790172475;3082.7225549700634;3102.317490152163;3104.7516198704047;3119.9376012479624;5765.625234359837;6000.969995150083;6001.579889407787;6038.939610603926;6058.697065146813;5911.4975227105315;5944.197533332945;5956.52347812174;5969.432903874125;6009.278886533557;6008.459238668541;6017.0974353846395;6051.213342265565;6077.270727512727;6080.331163572004;5649.350324712546;5764.740586673526;5769.307683078057;5795.507381872588;5910.645361278337;5708.143778433268;5735.225744524602;5753.165790960371;5825.621334613406;5830.679312637845;5934.495567876779;5940.138679891478;6030;6054.879847228277;6093.146959425772;4081.755094694328;4099.651529620016;4102.446169767043;4104.774237416971;4116.4648595682365;5820.216859041657;5858.560607954506;5883.911211519849;5890.823275301748;5892.322382926019;5544.1960915667805;5595.272614560081;5645.108888522391;5759.7040665849845;5764.855878603068;5645.463680950304;5683.8863222736145;5687.9431205687415;5695.686737229326;5704.828855134187;5623.297087864017;5681.659100453986;5713.714314284186;5724.084146536534;5728.856778580569;5790.971045144747;5803.3616302207565;5804.2744656917885;5820.243368362086;5833.095870140135;5710.37185909558;5724.885502290014;5750.6837123958585;5767.250257466502;5777.2200752897825 16:42:02 INFO - PROCESS | 4914 | |5;yui.html;728.1735230513369;772.9613519324032;811.2090711556233;823.8640624296992;839.2153336630249;14417.062890912084;15124.773128403083;15210.391584336614;15322;15526.456574019912;15604.453844115458;15640.84359156408;15767.921160394211;15784.44754433595;15784.44754433595;796.848598766234;799.7360870912585;819.5082950229875;820.9343252539783;821.6056292979373;824.1758241758242;824.5877061469265;824.6083110522513;827.2720006394364;827.896512935883;859.1623167411755;859.9871001934976;862.2670729879615;862.9654813807472;863.4344504349662;842.3682238321259;852.0244320253337;854.3080105114846;855.5551113421049;856.2080075929771;624.6033768556954;627.5230824573312;628.7139351595014;629.9559030867841;630.9337519560472;15263.771043434357;15291.08253504782;15310.157941313224;15324.23378831054;15327.157006364645;13417.32913354338;13551.39018744159;13586.93206533961;13696.726065478735;13755.724885502234;12667.493300267979;12835.358232088452;12904.16122952005;13075.869241307655;13080.803787943189;3915.843366265346;3938.5076865391825;3944.36890097583;3985.5815139410524;4115;85375.5731221346;87148;87536.56231718864;88178.5591072047;88667.55666221693;9973.700788976343;10264.230182736324;10349.74125646865;10419.583216671248;10518.684439466828;21067.262645807325;21240.831754253664;21277.36167914934;21311.573768524544;21357.572848542943;8100.149484304063;8250.133735957757;8360.623771930277;8420.78948026292;8541.14588541141;4370.890727731832;4395.230834603995;4464.4865840428765;4558.156741002925;4563.110193512233;3344.782589131699;3439.8108104054018;3482.2861313431195;3487.75585709003;3503.1767534629344;572.0275531596303;586.524914818998;587.4037851580649;587.4272584230426;606.4360145065043;577.9855503612443;610.7923306075955;619.2537991719967;725.7532438970775;736.6059158350257;8942.239909607626;9600;9602.66390676323;9782;9834.80330393388;611.2634275697774;624.6002558362652;656.3567703650449;694.8228201808506;747.5925620536821;4598.448186217675;4903.117438860968;4916.434610019822;4939;5001.224810154432;123864.38067809603;126486.3675681634;128276.35861820632;129149;130198;110846.44576777064;111295.44352278349;112022.43988780004;112626.43686781514;112795;58322;74124.62937685277;79627.99999999884;93852.53073734588;95111;9438.24494040489;9642.71071867845;9722.284557345922;9753.391245239023;9757.56090975922;35582.288354233286;42006.159876801685;47194.76402617965;49643.25535116904;55048;46251;47796.28305575489;59705;70980;72327.63836180785;12717.427715752629;12764.361781911053;12867.099303048697;13247.271400073088;13314.46742130304;14952.476663316731;14962.775558366415;15029.329176284524;15325.310361033557;15669.843301566838;14000.36998335057;14883.776743348642;15418.845811541742;15603.219839007777;15913.522594322189;14306.785398219243;15491.84508154904;15669.059856408652;15694.9215253923;15706.607334816721;12894.67763305925;14168.433262669378;14316.856831431553;14612.19632920157;14631.707365852837;11188.552457901593;11277.830832537355;11753.647390578297;11904.880951190724;12070.396480176132;10815.188860835311;11422.714432139262;11491.597794077166;11949.522019119138;12661.366931653196 16:42:02 INFO - PROCESS | 4914 | __end_tp_report 16:42:02 INFO - PROCESS | 4914 | __start_cc_report 16:42:02 INFO - PROCESS | 4914 | _x_x_mozilla_cycle_collect,323 16:42:02 INFO - PROCESS | 4914 | __end_cc_report 16:42:02 INFO - PROCESS | 4914 | __startTimestamp1472168522059__endTimestamp 16:42:02 INFO - PROCESS | 4914 | 16:42:02 INFO - PROCESS | 4914 | ------- Summary: start ------- 16:42:02 INFO - PROCESS | 4914 | Number of tests: 6 16:42:02 INFO - PROCESS | 4914 | 16:42:02 INFO - PROCESS | 4914 | [#0] dojo.html Cycles:165 Average:5354.89 Median:5603.36 stddev:602.62 (10.8%) stddev-sans-first:577.24 16:42:02 INFO - PROCESS | 4914 | Values: 3071.9 3087.0 3104.1 3114.8 3127.4 5288.6 5370.7 5430.8 5446.5 5494.3 5340.1 5350.2 5381.3 5397.5 5435.8 4589.4 4785.0 4889.8 4947.4 5024.7 4928.4 4941.0 4948.0 4983.7 5000.0 4768.8 4810.2 4881.1 4943.4 4946.0 4812.1 4827.5 4838.1 4840.5 4926.9 4828.1 4858.4 4859.2 4874.0 4928.1 5359.7 5364.9 5368.8 5383.9 5430.0 5827.3 5831.4 5836.3 5841.6 5851.1 5797.9 5867.1 5868.1 5869.4 5873.0 5234.1 5332.5 5387.4 5409.7 5417.9 5893.9 5905.7 5909.0 5915.1 5930.4 5594.3 5683.2 5691.0 5693.0 5694.1 5511.6 5741.5 5746.7 5803.2 5814.2 5580.9 5647.6 5650.0 5729.7 5733.3 5721.5 5722.3 5726.1 5730.0 5732.4 4419.0 4422.2 4435.4 4522.7 4527.1 3989.0 4047.3 4051.1 4052.2 4103.2 5253.2 5537.4 5603.4 5639.3 5677.6 5666.5 5684.5 5696.3 5742.3 5791.1 5406.1 5448.3 5449.4 5452.9 5454.8 4870.0 4880.0 4913.6 4932.9 4985.8 5878.7 5936.1 5941.4 5963.9 6028.3 5738.5 5759.8 5771.8 5779.8 5781.3 5763.4 5911.9 5914.6 5924.2 5932.1 5561.3 5637.4 5649.2 5660.0 5725.2 5760.3 5769.5 5773.5 5773.5 5777.6 5455.6 5606.6 5622.2 5626.3 5627.9 5602.5 5608.2 5621.9 5632.5 5692.2 5648.7 5665.2 5673.3 5679.6 5684.3 5489.9 5592.1 5690.2 5696.8 5703.8 5580.3 5589.9 5634.2 5646.2 5646.5 16:42:02 INFO - PROCESS | 4914 | 16:42:02 INFO - PROCESS | 4914 | [#1] ext.html Cycles:180 Average:57689.42 Median:41253.50 stddev:113742.31 (275.7%) stddev-sans-first:113980.52 16:42:02 INFO - PROCESS | 4914 | Values: 562.9 571.4 573.6 587.5 593.5 38698.0 42481.8 42646.6 42724.0 42729.4 41483.8 42023.4 42037.6 42091.4 42131.1 8818.9 8910.4 8983.6 8987.9 8993.8 8683.0 8733.8 8771.4 8786.0 8811.1 8826.4 8904.2 8929.6 8932.2 8932.5 8875.2 8875.3 8892.5 8900.3 8935.6 8777.3 8790.9 8818.0 8877.7 8880.6 40882.8 41164.0 41343.8 41478.6 41546.6 3482.1 3717.2 3725.1 3760.0 4280.1 31588.5 31732.7 31757.4 32026.4 32216.0 4368.9 4378.7 4441.9 4467.8 4576.3 345089.0 348488.0 348981.0 349494.0 350152.0 54874.5 54874.7 54900.5 54903.0 55121.4 36298.0 36945.8 37040.3 38982.2 58406.0 14305.4 14386.7 14410.4 14411.1 14458.2 10249.1 10270.1 10319.7 10340.6 10365.2 18909.1 18941.7 18953.6 18972.0 18990.3 6672.8 6920.4 7072.6 7108.8 7140.3 892.7 1009.9 1066.1 1090.8 1121.0 30480.8 30953.8 31050.5 31217.5 31812.5 1036.9 1066.6 1067.2 1091.2 1120.7 16271.3 16397.8 16697.6 16796.0 16853.5 500652.0 503150.0 504802.0 505844.0 507634.0 55804.4 56021.4 56243.4 56245.7 56315.0 1293.9 1313.0 1323.6 1325.1 1348.5 29540.7 30010.5 30414.4 30496.8 30886.7 49586.5 49765.3 49795.0 49945.8 50096.5 416736.8 420919.0 422149.0 422439.0 423014.0 27808.4 27927.4 28212.2 28611.7 28716.1 46503.8 46524.3 47060.8 47173.5 47276.3 38950.8 39769.2 39978.8 40743.8 41343.0 39683.8 40497.2 41461.6 41726.6 42298.8 33790.3 37885.6 38478.0 38764.6 39884.4 34083.0 36212.6 36322.0 36929.6 37134.6 27763.3 27821.2 27859.6 28202.6 28243.0 16:42:02 INFO - PROCESS | 4914 | 16:42:02 INFO - PROCESS | 4914 | [#2] jquery.html Cycles:180 Average:26473.60 Median:349821.50 stddev:65642.82 (18.8%) stddev-sans-first:65797.72 16:42:02 INFO - PROCESS | 4914 | Values: 374.9 386.8 389.7 402.2 406.1 17433.6 20287.0 20357.9 20548.5 20565.4 18373.7 18511.0 18761.8 18970.1 19213.7 5522.5 5573.4 5747.5 5750.5 5757.7 5720.1 5763.5 5799.4 5802.4 5805.0 5773.9 5809.3 5809.7 5810.2 5815.6 5878.7 5892.6 5938.3 5985.2 6024.8 5574.2 5691.3 5712.7 5723.5 5745.3 18643.7 22643.0 23280.9 23374.2 23445.6 2384.6 2493.8 2963.2 3003.2 3063.9 10164.8 10201.9 10680.4 12383.6 14000.0 1800.7 1950.8 1965.0 1982.6 2006.7 78331.6 79485.2 80125.6 81182.6 81941.6 10836.1 11023.1 11192.6 11206.4 11245.2 15772.8 15806.7 15820.3 15861.4 15895.1 7310.4 7486.9 7506.7 7657.2 7671.7 6663.9 6712.4 6764.9 6876.7 6919.7 4712.6 4717.2 4746.5 4747.8 4853.3 1887.2 1960.7 1962.2 1969.0 1988.8 931.3 938.9 971.1 1004.4 1047.1 19331.1 19483.6 19550.1 19600.3 19695.1 937.4 965.5 975.8 991.1 991.5 9524.3 10728.5 10932.0 11049.1 11058.7 349640.0 350003.0 351598.0 446868.0 453562.0 89113.0 90210.0 93611.0 97973.5 99209.0 986.9 1015.9 1036.7 1037.0 1037.4 17318.9 17529.9 17571.6 17777.5 17841.5 42178.8 43254.8 43539.3 43737.3 45469.8 58222.0 59917.5 61987.4 63245.4 63401.7 8325.7 8392.8 8725.5 8793.0 8800.8 12877.8 13499.7 13518.5 13806.2 13963.2 11964.3 12021.2 12067.9 12316.4 12360.1 11286.4 11738.3 11809.9 11870.2 11990.6 11937.4 12183.2 12304.1 12337.1 12480.4 8693.1 8739.2 8746.3 8753.0 9126.6 10659.1 11227.8 11367.8 11390.8 11887.7 16:42:02 INFO - PROCESS | 4914 | 16:42:02 INFO - PROCESS | 4914 | [#3] mootools.html Cycles:180 Average:5351.02 Median:4889.22 stddev:2984.28 (61.0%) stddev-sans-first:2978.15 16:42:02 INFO - PROCESS | 4914 | Values: 1436.2 1450.3 1542.3 1679.7 1685.0 7312.5 7652.3 7932.6 8259.5 8272.1 7869.3 8071.1 8135.0 8174.8 8203.1 2226.9 2266.3 2267.3 2267.5 2270.3 2215.7 2245.4 2282.1 2284.4 2286.2 2229.4 2238.0 2245.0 2247.2 2258.8 2160.9 2166.7 2179.0 2189.1 2195.3 2122.1 2125.9 2126.0 2129.9 2130.2 8115.2 8118.2 8130.4 8228.2 8254.0 4774.8 4880.6 4897.8 4899.5 4902.4 3048.3 3163.9 3164.0 3263.8 3264.2 1139.7 1147.9 1151.5 1157.8 1172.8 10787.1 10868.4 10872.3 10905.0 10960.7 4140.6 4246.0 4335.2 4387.4 4408.1 9269.6 9321.3 9323.7 9355.1 9356.1 4788.7 4796.6 4802.9 4812.6 4824.0 4037.2 4361.9 4427.6 4438.9 4458.4 3530.9 3617.3 3626.2 3644.5 3672.6 1133.4 1137.4 1139.0 1139.4 1141.8 940.7 955.5 968.9 976.2 999.9 5417.8 5630.5 5697.2 5730.1 5750.9 442.7 444.0 447.7 450.0 456.2 4076.9 4094.0 4125.3 4143.7 4208.7 9887.2 10057.9 10171.1 10192.9 10272.2 10077.1 10082.5 10082.9 10090.7 10099.8 7609.7 7684.2 7687.2 7697.5 7726.1 5607.9 5633.2 5741.2 5781.2 5835.6 9206.5 9216.4 9277.0 9389.7 9398.8 9037.3 9273.5 9355.6 9358.7 9412.0 6585.9 6821.8 6896.4 6998.8 7112.8 7690.3 7730.2 7741.0 7747.1 7765.8 6972.7 7119.6 7158.4 7166.9 7271.8 6589.9 6663.5 6669.7 6739.4 6740.7 6269.2 6342.3 6449.1 6486.1 6538.3 4926.6 4987.0 5000.3 5017.1 5027.1 4978.9 4993.4 5015.6 5035.3 5060.2 16:42:02 INFO - PROCESS | 4914 | 16:42:02 INFO - PROCESS | 4914 | [#4] prototype.html Cycles:180 Average:4800.84 Median:5511.77 stddev:1426.51 (25.9%) stddev-sans-first:1390.32 16:42:02 INFO - PROCESS | 4914 | Values: 321.2 322.7 327.9 328.2 330.7 5435.2 5479.6 5487.8 5510.1 5515.4 5434.7 5443.5 5477.9 5480.2 5499.8 4014.2 4130.3 4146.3 4191.6 4216.4 4207.9 4213.3 4216.9 4216.9 4230.3 4173.5 4205.2 4218.6 4220.0 4230.3 4107.2 4189.4 4216.3 4218.9 4251.3 3698.7 3705.6 3719.3 3719.5 3722.2 5332.3 5335.4 5336.7 5345.8 5355.6 4736.5 4854.2 4886.6 4905.7 4911.6 5633.6 5675.4 5683.5 5687.1 5712.5 4073.2 4073.8 4084.9 4088.9 4115.0 5670.6 5924.4 5977.7 5991.5 5995.2 4091.4 4124.0 4125.7 4128.6 4129.7 4146.3 4156.5 4165.4 4170.7 4172.2 4574.4 4791.5 4835.2 4849.7 4856.4 5780.1 5784.1 5798.7 5810.2 5816.0 1436.2 1454.7 1455.3 1458.0 1458.8 918.4 920.2 930.4 949.5 977.8 5451.2 5483.4 5506.6 5513.5 5550.6 5769.2 5822.8 5837.9 5865.7 5873.7 5238.9 5384.6 5442.9 5468.4 5541.5 3042.3 3082.7 3102.3 3104.8 3119.9 5765.6 6001.0 6001.6 6038.9 6058.7 5911.5 5944.2 5956.5 5969.4 6009.3 6008.5 6017.1 6051.2 6077.3 6080.3 5649.4 5764.7 5769.3 5795.5 5910.6 5708.1 5735.2 5753.2 5825.6 5830.7 5934.5 5940.1 6030.0 6054.9 6093.1 4081.8 4099.7 4102.4 4104.8 4116.5 5820.2 5858.6 5883.9 5890.8 5892.3 5544.2 5595.3 5645.1 5759.7 5764.9 5645.5 5683.9 5687.9 5695.7 5704.8 5623.3 5681.7 5713.7 5724.1 5728.9 5791.0 5803.4 5804.3 5820.2 5833.1 5710.4 5724.9 5750.7 5767.3 5777.2 16:42:02 INFO - PROCESS | 4914 | 16:42:02 INFO - PROCESS | 4914 | [#5] yui.html Cycles:180 Average:21215.68 Median:23188.53 stddev:31690.48 (136.7%) stddev-sans-first:31742.05 16:42:02 INFO - PROCESS | 4914 | Values: 728.2 773.0 811.2 823.9 839.2 14417.1 15124.8 15210.4 15322.0 15526.5 15604.5 15640.8 15767.9 15784.4 15784.4 796.8 799.7 819.5 820.9 821.6 824.2 824.6 824.6 827.3 827.9 859.2 860.0 862.3 863.0 863.4 842.4 852.0 854.3 855.6 856.2 624.6 627.5 628.7 630.0 630.9 15263.8 15291.1 15310.2 15324.2 15327.2 13417.3 13551.4 13586.9 13696.7 13755.7 12667.5 12835.4 12904.2 13075.9 13080.8 3915.8 3938.5 3944.4 3985.6 4115.0 85375.6 87148.0 87536.6 88178.6 88667.6 9973.7 10264.2 10349.7 10419.6 10518.7 21067.3 21240.8 21277.4 21311.6 21357.6 8100.1 8250.1 8360.6 8420.8 8541.1 4370.9 4395.2 4464.5 4558.2 4563.1 3344.8 3439.8 3482.3 3487.8 3503.2 572.0 586.5 587.4 587.4 606.4 578.0 610.8 619.3 725.8 736.6 8942.2 9600.0 9602.7 9782.0 9834.8 611.3 624.6 656.4 694.8 747.6 4598.4 4903.1 4916.4 4939.0 5001.2 123864.4 126486.4 128276.4 129149.0 130198.0 110846.4 111295.4 112022.4 112626.4 112795.0 58322.0 74124.6 79628.0 93852.5 95111.0 9438.2 9642.7 9722.3 9753.4 9757.6 35582.3 42006.2 47194.8 49643.3 55048.0 46251.0 47796.3 59705.0 70980.0 72327.6 12717.4 12764.4 12867.1 13247.3 13314.5 14952.5 14962.8 15029.3 15325.3 15669.8 14000.4 14883.8 15418.8 15603.2 15913.5 14306.8 15491.8 15669.1 15694.9 15706.6 12894.7 14168.4 14316.9 14612.2 14631.7 11188.6 11277.8 11753.6 11904.9 12070.4 10815.2 11422.7 11491.6 11949.5 12661.4 16:42:02 INFO - PROCESS | 4914 | -------- Summary: end -------- 16:42:02 INFO - PROCESS | 4914 | 16:42:03 INFO - TEST-INFO | 4914: exit 0 16:42:03 INFO - TEST-OK | dromaeo_css | took 1113802ms 16:42:03 INFO - TEST-START | kraken 16:42:03 INFO - operating with platform_type : linux_ 16:42:03 INFO - Initialising browser for kraken test... 16:42:03 INFO - TEST-INFO | started process 5276 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6w8fay/profile http://localhost:56765/getInfo.html) 16:42:07 INFO - PROCESS | 5276 | __metrics Screen width/height:1600/1200 16:42:07 INFO - PROCESS | 5276 | colorDepth:24 16:42:07 INFO - PROCESS | 5276 | Browser inner width/height: 1024/697 16:42:07 INFO - PROCESS | 5276 | __metrics 16:42:07 ERROR - PROCESS | 5276 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2991: TypeError: this.tabs is undefined 16:42:08 INFO - TEST-INFO | 5276: exit 0 16:42:08 INFO - Browser initialized. 16:42:08 INFO - Running cycle 1/1 for kraken test... 16:42:08 INFO - TEST-INFO | started process 5396 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6w8fay/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:42:20 INFO - PROCESS | 5396 | RSS: Main: 191332352 16:42:20 INFO - PROCESS | 5396 | 16:42:23 INFO - PROCESS | 5396 | Cycle 1(1): loaded http://localhost:56765/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56765/tests/kraken/driver.html?testName=audio-beat-detection) 16:42:24 INFO - PROCESS | 5396 | RSS: Main: 204607488 16:42:24 INFO - PROCESS | 5396 | 16:42:27 INFO - PROCESS | 5396 | Cycle 1(1): loaded http://localhost:56765/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56765/tests/kraken/driver.html?testName=audio-dft) 16:42:27 INFO - PROCESS | 5396 | RSS: Main: 203476992 16:42:27 INFO - PROCESS | 5396 | 16:42:30 INFO - PROCESS | 5396 | Cycle 1(1): loaded http://localhost:56765/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56765/tests/kraken/driver.html?testName=audio-fft) 16:42:31 INFO - PROCESS | 5396 | RSS: Main: 196964352 16:42:31 INFO - PROCESS | 5396 | 16:42:33 INFO - PROCESS | 5396 | Cycle 1(1): loaded http://localhost:56765/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56765/tests/kraken/driver.html?testName=audio-oscillator) 16:42:33 INFO - PROCESS | 5396 | RSS: Main: 198090752 16:42:33 INFO - PROCESS | 5396 | 16:42:36 INFO - PROCESS | 5396 | Cycle 1(1): loaded http://localhost:56765/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56765/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:42:36 INFO - PROCESS | 5396 | RSS: Main: 198295552 16:42:36 INFO - PROCESS | 5396 | 16:42:39 INFO - PROCESS | 5396 | Cycle 1(1): loaded http://localhost:56765/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56765/tests/kraken/driver.html?testName=imaging-darkroom) 16:42:40 INFO - PROCESS | 5396 | RSS: Main: 198868992 16:42:40 INFO - PROCESS | 5396 | 16:42:43 INFO - PROCESS | 5396 | Cycle 1(1): loaded http://localhost:56765/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56765/tests/kraken/driver.html?testName=imaging-desaturate) 16:42:44 INFO - PROCESS | 5396 | RSS: Main: 195813376 16:42:44 INFO - PROCESS | 5396 | 16:42:47 INFO - PROCESS | 5396 | Cycle 1(1): loaded http://localhost:56765/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56765/tests/kraken/driver.html?testName=json-parse-financial) 16:42:48 INFO - PROCESS | 5396 | RSS: Main: 197181440 16:42:48 INFO - PROCESS | 5396 | 16:42:49 INFO - PROCESS | 5396 | Cycle 1(1): loaded http://localhost:56765/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56765/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:42:50 INFO - PROCESS | 5396 | RSS: Main: 197533696 16:42:50 INFO - PROCESS | 5396 | 16:42:52 INFO - PROCESS | 5396 | Cycle 1(1): loaded http://localhost:56765/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56765/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:42:52 INFO - PROCESS | 5396 | RSS: Main: 197578752 16:42:52 INFO - PROCESS | 5396 | 16:42:54 INFO - PROCESS | 5396 | Cycle 1(1): loaded http://localhost:56765/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56765/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:42:55 INFO - PROCESS | 5396 | RSS: Main: 198135808 16:42:55 INFO - PROCESS | 5396 | 16:42:58 INFO - PROCESS | 5396 | Cycle 1(1): loaded http://localhost:56765/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56765/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:42:58 INFO - PROCESS | 5396 | RSS: Main: 197967872 16:42:58 INFO - PROCESS | 5396 | 16:43:01 INFO - PROCESS | 5396 | Cycle 1(1): loaded http://localhost:56765/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56765/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:43:02 INFO - PROCESS | 5396 | RSS: Main: 198381568 16:43:02 INFO - PROCESS | 5396 | 16:43:03 INFO - PROCESS | 5396 | Cycle 1(1): loaded http://localhost:56765/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56765/tests/kraken/driver.html?testName=ai-astar) 16:43:04 INFO - PROCESS | 5396 | RSS: Main: 199815168 16:43:04 INFO - PROCESS | 5396 | 16:43:04 INFO - PROCESS | 5396 | __start_tp_report 16:43:04 INFO - PROCESS | 5396 | _x_x_mozilla_page_load 16:43:04 INFO - PROCESS | 5396 | _x_x_mozilla_page_load_details 16:43:04 INFO - PROCESS | 5396 | |i|pagename|runs| 16:43:04 INFO - PROCESS | 5396 | |0;ai-astar;111;105;113;112;112;100;111;112;111;112 16:43:04 INFO - PROCESS | 5396 | |1;audio-beat-detection;159;125;150;200;124;155;159;119;182;119 16:43:04 INFO - PROCESS | 5396 | |2;audio-dft;163;164;163;166;172;164;164;162;163;162 16:43:04 INFO - PROCESS | 5396 | |3;audio-fft;74;75;76;194;78;75;74;77;161;76 16:43:04 INFO - PROCESS | 5396 | |4;audio-oscillator;83;84;158;83;83;84;147;83;83;143 16:43:04 INFO - PROCESS | 5396 | |5;imaging-gaussian-blur;118;118;117;117;118;117;117;119;117;117 16:43:04 INFO - PROCESS | 5396 | |6;imaging-darkroom;147;147;147;147;148;147;147;147;146;148 16:43:04 INFO - PROCESS | 5396 | |7;imaging-desaturate;97;95;96;96;96;95;96;96;96;95 16:43:04 INFO - PROCESS | 5396 | |8;json-parse-financial;53;54;55;54;55;53;57;53;54;53 16:43:04 INFO - PROCESS | 5396 | |9;json-stringify-tinderbox;62;62;62;62;63;62;63;62;62;61 16:43:04 INFO - PROCESS | 5396 | |10;stanford-crypto-aes;80;88;86;79;81;85;77;80;80;83 16:43:04 INFO - PROCESS | 5396 | |11;stanford-crypto-ccm;129;134;126;126;138;131;132;126;171;126 16:43:04 INFO - PROCESS | 5396 | |12;stanford-crypto-pbkdf2;163;163;161;170;169;160;160;163;166;163 16:43:04 INFO - PROCESS | 5396 | |13;stanford-crypto-sha256-iterative;69;66;66;65;65;66;67;64;65;64 16:43:04 INFO - PROCESS | 5396 | __end_tp_report 16:43:04 INFO - PROCESS | 5396 | __start_cc_report 16:43:04 INFO - PROCESS | 5396 | _x_x_mozilla_cycle_collect,837 16:43:04 INFO - PROCESS | 5396 | __end_cc_report 16:43:04 INFO - PROCESS | 5396 | __startTimestamp1472168584139__endTimestamp 16:43:04 INFO - PROCESS | 5396 | 16:43:04 INFO - PROCESS | 5396 | ------- Summary: start ------- 16:43:04 INFO - PROCESS | 5396 | Number of tests: 14 16:43:04 INFO - PROCESS | 5396 | 16:43:04 INFO - PROCESS | 5396 | [#0] ai-astar Cycles:10 Average:109.90 Median:112.00 stddev:4.12 (3.7%) stddev-sans-first:4.35 16:43:04 INFO - PROCESS | 5396 | Values: 111.0 105.0 113.0 112.0 112.0 100.0 111.0 112.0 111.0 112.0 16:43:04 INFO - PROCESS | 5396 | 16:43:04 INFO - PROCESS | 5396 | [#1] audio-beat-detection Cycles:10 Average:149.20 Median:157.00 stddev:27.74 (17.7%) stddev-sans-first:29.20 16:43:04 INFO - PROCESS | 5396 | Values: 159.0 125.0 150.0 200.0 124.0 155.0 159.0 119.0 182.0 119.0 16:43:04 INFO - PROCESS | 5396 | 16:43:04 INFO - PROCESS | 5396 | [#2] audio-dft Cycles:10 Average:164.30 Median:164.00 stddev:2.95 (1.8%) stddev-sans-first:3.09 16:43:04 INFO - PROCESS | 5396 | Values: 163.0 164.0 163.0 166.0 172.0 164.0 164.0 162.0 163.0 162.0 16:43:04 INFO - PROCESS | 5396 | 16:43:04 INFO - PROCESS | 5396 | [#3] audio-fft Cycles:10 Average:96.00 Median:75.50 stddev:43.67 (57.8%) stddev-sans-first:45.59 16:43:04 INFO - PROCESS | 5396 | Values: 74.0 75.0 76.0 194.0 78.0 75.0 74.0 77.0 161.0 76.0 16:43:04 INFO - PROCESS | 5396 | 16:43:04 INFO - PROCESS | 5396 | [#4] audio-oscillator Cycles:10 Average:103.10 Median:83.00 stddev:32.12 (38.7%) stddev-sans-first:33.23 16:43:04 INFO - PROCESS | 5396 | Values: 83.0 84.0 158.0 83.0 83.0 84.0 147.0 83.0 83.0 143.0 16:43:04 INFO - PROCESS | 5396 | 16:43:04 INFO - PROCESS | 5396 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:117.50 stddev:0.71 (0.6%) stddev-sans-first:0.73 16:43:04 INFO - PROCESS | 5396 | Values: 118.0 118.0 117.0 117.0 118.0 117.0 117.0 119.0 117.0 117.0 16:43:04 INFO - PROCESS | 5396 | 16:43:04 INFO - PROCESS | 5396 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 16:43:04 INFO - PROCESS | 5396 | Values: 147.0 147.0 147.0 147.0 148.0 147.0 147.0 147.0 146.0 148.0 16:43:04 INFO - PROCESS | 5396 | 16:43:04 INFO - PROCESS | 5396 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.50 16:43:04 INFO - PROCESS | 5396 | Values: 97.0 95.0 96.0 96.0 96.0 95.0 96.0 96.0 96.0 95.0 16:43:04 INFO - PROCESS | 5396 | 16:43:04 INFO - PROCESS | 5396 | [#8] json-parse-financial Cycles:10 Average:54.10 Median:54.00 stddev:1.29 (2.4%) stddev-sans-first:1.30 16:43:04 INFO - PROCESS | 5396 | Values: 53.0 54.0 55.0 54.0 55.0 53.0 57.0 53.0 54.0 53.0 16:43:04 INFO - PROCESS | 5396 | 16:43:04 INFO - PROCESS | 5396 | [#9] json-stringify-tinderbox Cycles:10 Average:62.10 Median:62.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 16:43:04 INFO - PROCESS | 5396 | Values: 62.0 62.0 62.0 62.0 63.0 62.0 63.0 62.0 62.0 61.0 16:43:04 INFO - PROCESS | 5396 | 16:43:04 INFO - PROCESS | 5396 | [#10] stanford-crypto-aes Cycles:10 Average:81.90 Median:82.00 stddev:3.48 (4.2%) stddev-sans-first:3.62 16:43:04 INFO - PROCESS | 5396 | Values: 80.0 88.0 86.0 79.0 81.0 85.0 77.0 80.0 80.0 83.0 16:43:04 INFO - PROCESS | 5396 | 16:43:04 INFO - PROCESS | 5396 | [#11] stanford-crypto-ccm Cycles:10 Average:133.90 Median:131.50 stddev:13.66 (10.4%) stddev-sans-first:14.37 16:43:04 INFO - PROCESS | 5396 | Values: 129.0 134.0 126.0 126.0 138.0 131.0 132.0 126.0 171.0 126.0 16:43:04 INFO - PROCESS | 5396 | 16:43:04 INFO - PROCESS | 5396 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.80 Median:163.00 stddev:3.49 (2.1%) stddev-sans-first:3.69 16:43:04 INFO - PROCESS | 5396 | Values: 163.0 163.0 161.0 170.0 169.0 160.0 160.0 163.0 166.0 163.0 16:43:04 INFO - PROCESS | 5396 | 16:43:04 INFO - PROCESS | 5396 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.70 Median:66.00 stddev:1.49 (2.3%) stddev-sans-first:1.00 16:43:04 INFO - PROCESS | 5396 | Values: 69.0 66.0 66.0 65.0 65.0 66.0 67.0 64.0 65.0 64.0 16:43:04 INFO - PROCESS | 5396 | -------- Summary: end -------- 16:43:04 INFO - PROCESS | 5396 | 16:43:05 INFO - TEST-INFO | 5396: exit 0 16:43:05 INFO - TEST-OK | kraken | took 62191ms 16:43:05 INFO - SUITE-END | took 1175s 16:43:05 INFO - Completed test suite (00:19:36) 16:43:05 INFO - javascript benchmark 16:43:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7152.46638771334, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3071.9385612287756, 3087.0275863103134, 3104.053263754554, 3114.7663925205607, 3127.3588914272577, 5288.60335474839, 5370.650907691002, 5430.809921652743, 5446.509814116729, 5494.340679118506, 5340.092184328664, 5350.170723537858, 5381.327334083239, 5397.487238712326, 5435.809746658858, 4589.426321709786, 4784.9521504785025, 4889.828855990041, 4947.381577302837, 5024.723640199788, 4928.359313289267, 4940.950590494085, 4947.975260123694, 4983.725895075788, 5000.0, 4768.785404656799, 4810.158222311082, 4881.072596206709, 4943.382077240345, 4945.986072855092, 4812.061647978646, 4827.541383568555, 4838.104950584153, 4840.467548569654, 4926.901461970776, 4828.0585285869265, 4858.392700912386, 4859.246816743411, 4874.025194961022, 4928.088303663833, 5359.705216213107, 5364.91952620711, 5368.812091576776, 5383.892322153535, 5430.022595932731, 5827.329857066449, 5831.446012628793, 5836.2996440427, 5841.620294680874, 5851.063829787214, 5797.855053623651, 5867.061270196791, 5868.149118377854, 5869.354371019184, 5873.030949893263, 5234.0840352938085, 5332.520073193393, 5387.434319396485, 5409.702466364309, 5417.918731219035, 5893.941060589339, 5905.734241959122, 5909.0, 5915.08316210988, 5930.436608522184, 5594.3286805582775, 5683.175939488751, 5690.971545142248, 5693.032184528557, 5694.060480020833, 5511.58663100261, 5741.511971482387, 5746.683932383676, 5803.158542011384, 5814.215080964101, 5580.860478487989, 5647.576431767634, 5650.039493286151, 5729.742161602738, 5733.254676891977, 5721.5136713379825, 5722.284714410699, 5726.055200891889, 5730.025895597759, 5732.426757324234, 4419.027813880941, 4422.159789639958, 4435.379046933432, 4522.66080043998, 4527.071950250191, 3988.980055099764, 4047.2714911316248, 4051.088505086332, 4052.1895620875944, 4103.179364127186, 5253.159494480865, 5537.418571050062, 5603.35561410443, 5639.3232812062815, 5677.574181936371, 5666.518345940642, 5684.459976302244, 5696.3449203341315, 5742.310922689304, 5791.073428251544, 5406.08096623575, 5448.264484294569, 5449.427810079964, 5452.91820622691, 5454.754536045887, 4869.975650121727, 4879.975600121977, 4913.582345500601, 4932.926006109911, 4985.800567977313, 5878.676672783038, 5936.079907614327, 5941.376155503783, 5963.880722385528, 6028.276606807299, 5738.512226460798, 5759.769609215585, 5771.797987070432, 5779.826605201851, 5781.277340332458, 5763.36602973681, 5911.940880591139, 5914.556408269311, 5924.170616113834, 5932.080527518242, 5561.332640083216, 5637.379888212376, 5649.152627105803, 5659.971700141473, 5725.227094342211, 5760.308762948305, 5769.509591684754, 5773.451522105393, 5773.509251713652, 5777.595568310178, 5455.563554915518, 5606.551475882001, 5622.156676498558, 5626.2967129108865, 5627.915581266366, 5602.523785478117, 5608.242887210175, 5621.9156712650165, 5632.549396048388, 5692.203091567267, 5648.717564121695, 5665.150227465913, 5673.262475878109, 5679.602427830012, 5684.346300175367, 5489.862753431196, 5592.077307244259, 5690.174924635988, 5696.772129114955, 5703.828885133453, 5580.330360356783, 5589.888202236014, 5634.183043458594, 5646.209530665628, 5646.520045796154], "value": 5314.63570123741, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [562.8930503204391, 571.3829064610221, 573.6070791507816, 587.4683411512583, 593.4895989449076, 38698.0, 42481.78759106208, 42646.57353426465, 42724.0, 42729.35905961413, 41483.79258103713, 42023.369649455286, 42037.57962420375, 42091.368629470504, 42131.10410031548, 8818.86771698425, 8910.376273660846, 8983.550822458883, 8987.910120898772, 8993.77515562113, 8683.044865064838, 8733.825323493526, 8771.429857059271, 8786.0, 8811.118888111201, 8826.382153249275, 8904.243139333164, 8929.553522323858, 8932.196102350787, 8932.508712020835, 8875.156860098281, 8875.28997680184, 8892.466452012835, 8900.287976961827, 8935.597898094602, 8777.253933415668, 8790.912090879074, 8817.955910220471, 8877.689280875138, 8880.644774209024, 40882.79558602218, 41164.0, 41343.7932810334, 41478.58521414777, 41546.58453415488, 3482.0598438421484, 3717.237966216946, 3725.105974566112, 3759.981200094009, 4280.122574872144, 31588.52617210744, 31732.682673173433, 31757.364852702816, 32026.359472810647, 32216.033518994467, 4368.89077773055, 4378.7153835000945, 4441.866743997685, 4467.776611169428, 4576.336431217454, 345088.9999999975, 348488.0, 348981.0, 349494.0, 350152.0, 54874.45125548773, 54874.72562637161, 54900.45099548953, 54903.0, 55121.44878551163, 36298.0, 36945.81527092401, 37040.25919481649, 38982.220355592726, 58406.0, 14305.425023495662, 14386.712265754626, 14410.42358305656, 14411.063280886918, 14458.204798736171, 10249.077583017564, 10270.07569318765, 10319.742006449898, 10340.586376545005, 10365.170786337225, 18909.14908829106, 18941.715874261896, 18953.62092758137, 18972.0, 18990.29087382142, 6672.799816005528, 6920.377166055079, 7072.646367681596, 7108.786736397917, 7140.250273721288, 892.6786356911507, 1009.8737657792776, 1066.1417558865032, 1090.8363745438248, 1120.9887901121047, 30480.84759576188, 30953.845230773702, 31050.53424198639, 31217.53173702351, 31812.522812157837, 1036.9481525923673, 1066.626680661762, 1067.2049323254225, 1091.1543553745753, 1120.7478317378689, 16271.349146034263, 16397.754033689504, 16697.582560435843, 16796.0, 16853.494395168163, 500652.0, 503150.0, 504802.0, 505844.0, 507634.0, 55804.44195558074, 56021.43978560244, 56243.43756562464, 56245.71877140588, 56315.0, 1293.8770816772392, 1312.960611181666, 1323.589687196972, 1325.1121748428384, 1348.514534767483, 29540.704592954655, 30010.54984175283, 30414.391712166074, 30496.847515762278, 30886.69113308928, 49586.50413495819, 49765.253521197934, 49795.0, 49945.75027124987, 50096.49903500918, 416736.82421285036, 420919.0, 422149.0, 422439.0, 423014.0, 27808.44383112367, 27927.441451170456, 28212.153635390972, 28611.71388286174, 28716.13851584456, 46503.76748116373, 46524.30213546732, 47060.76469617767, 47173.52826471828, 47276.29085563788, 38950.80524597359, 39769.2046159081, 39978.80010599928, 40743.7962810184, 41343.0, 39683.80158099191, 40497.1900561993, 41461.58538414577, 41726.582734173484, 42298.78850605727, 33790.324193516484, 37885.62114378821, 38478.0, 38764.6123538761, 39884.40173397459, 34083.0, 36212.63787362198, 36322.0, 36929.63070369369, 37134.6286537142, 27763.30591735142, 27821.16536503908, 27859.582106268826, 28202.576961346007, 28243.0], "value": 19379.59245292933, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [374.89690335157843, 386.7969316109043, 389.73303287248234, 402.2377594458503, 406.07009947220865, 17433.564160895985, 20287.0, 20357.898210508927, 20548.48628784281, 20565.38303850887, 18373.7243941341, 18511.0, 18761.812381876178, 18970.146343414544, 19213.711794323062, 5522.475364840334, 5573.4147914469, 5747.482726554609, 5750.453706897838, 5757.68332741699, 5720.056190728525, 5763.452472015152, 5799.449052340021, 5802.419758024206, 5805.013147764869, 5773.942260577403, 5809.302883653967, 5809.651420914737, 5810.15752715856, 5815.563832712563, 5878.735456904449, 5892.646441213541, 5938.287405511323, 5985.161827879197, 6024.849378765544, 5574.1917421973585, 5691.264164429847, 5712.685802280873, 5723.484886360247, 5745.253117094792, 18643.720344194848, 22643.0, 23280.883595582083, 23374.181903633293, 23445.648315275284, 2384.5707772600927, 2493.845126436542, 2963.199936017263, 3003.1591154476564, 3063.947155405861, 10164.796704065877, 10201.897981020169, 10680.412577308245, 12383.62849114528, 14000.0, 1800.7388928605278, 1950.7951665075248, 1964.980350196494, 1982.6431242376366, 2006.6989951507392, 78331.60834195792, 79485.20514794778, 80125.59937200334, 81182.59408702978, 81941.59029204876, 10836.133109351233, 11023.118150547936, 11192.608258710907, 11206.38364889939, 11245.15661325404, 15772.842271577367, 15806.68386632261, 15820.288087036111, 15861.444849430214, 15895.125768082866, 7310.378617817439, 7486.887696684554, 7506.662200201004, 7657.157712651604, 7671.731489397845, 6663.900041499382, 6712.42944349726, 6764.864702705919, 6876.69054892531, 6919.688614012382, 4712.575868171881, 4717.150912835654, 4746.5490778376, 4747.786349614275, 4853.344798452164, 1887.1507821480388, 1960.725498430221, 1962.1660794162424, 1968.9677896040223, 1988.8408927285782, 931.2736065868634, 938.8591711243369, 971.1162841813915, 1004.4324956399611, 1047.1047254597363, 19331.130099145572, 19483.610327793365, 19550.120244589027, 19600.270060962426, 19695.11371988264, 937.386012162035, 965.5220665770348, 975.7804493988796, 991.0634450444405, 991.4745185051934, 9524.333296669167, 10728.463576821128, 10932.0, 11049.116070714485, 11058.723531911606, 349640.0, 350003.0, 351598.0, 446868.0, 453562.0, 89113.0, 90210.0, 93611.0, 97973.51013244888, 99209.0, 986.8519722041751, 1015.9187265018633, 1036.7149034015556, 1037.0459177556666, 1037.4034929915329, 17318.913405432893, 17529.89629335593, 17571.648567028333, 17777.46667599974, 17841.46475605734, 42178.789106054275, 43254.783726081165, 43539.346909797016, 43737.34393984029, 45469.77265113653, 58222.0, 59917.50206244879, 61987.38012619816, 63245.36754632579, 63401.68299158659, 8325.666973321, 8392.832143356976, 8725.47647141148, 8793.0, 8800.823983520166, 12877.8068328977, 13499.73000539964, 13518.526851560542, 13806.240656763573, 13963.16221026701, 11964.282143071443, 12021.158518903592, 12067.939660301643, 12316.445759941003, 12360.134790564935, 11286.435678215892, 11738.295702257892, 11809.940950295193, 11870.169088163746, 11990.640280791591, 11937.4031298433, 12183.20809147438, 12304.07719421065, 12337.136400451882, 12480.438380272728, 8693.130686931256, 8739.21347078766, 8746.30029597618, 8752.956235218782, 9126.589303481493, 10659.147268218368, 11227.775444491228, 11367.772644547229, 11390.772184556097, 11887.702807429538], "value": 9256.55378747796, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1436.2387934394771, 1450.3111022264425, 1542.252007776229, 1679.664067186563, 1684.9831501684987, 7312.451566132548, 7652.349550288225, 7932.6033698315, 8259.545724985124, 8272.131426200252, 7869.252421019994, 8071.112177660468, 8135.0, 8174.79563010925, 8203.056648485426, 2226.899789509476, 2266.2747920665392, 2267.331137314488, 2267.5464907018663, 2270.296208175471, 2215.7008803811523, 2245.360072379372, 2282.1441959265276, 2284.3603790938564, 2286.16554957441, 2229.4092065602626, 2237.9552408951813, 2244.9775502245016, 2247.2359397804744, 2258.8192944564476, 2160.8595441296266, 2166.685830554569, 2179.030331502482, 2189.1134090693217, 2195.3194509702043, 2122.1405330841035, 2125.9255926042515, 2125.9893700531397, 2129.9041543130443, 2130.179880745924, 8115.229053239933, 8118.228768267005, 8130.3902207334095, 8228.177182281785, 8253.95873020631, 4774.761261936889, 4880.6095512358925, 4897.828575999859, 4899.461059283476, 4902.436219834729, 3048.253177971389, 3163.889263875776, 3163.9707101139793, 3263.8368081596063, 3264.2002709336125, 1139.7435576995192, 1147.9024282935877, 1151.504852913247, 1157.7800217958645, 1172.8475298211263, 10787.137029037658, 10868.402237876913, 10872.293300935415, 10905.018548330609, 10960.725981850437, 4140.585941405835, 4245.957540424556, 4335.154644844288, 4387.36383224437, 4408.140412619572, 9269.629214831466, 9321.300902432346, 9323.673671421468, 9355.111264429868, 9356.082003189329, 4788.688735232199, 4796.640251981115, 4802.903941921212, 4812.639052071108, 4823.962847987699, 4037.192561487714, 4361.890952726144, 4427.557244275611, 4438.911221775611, 4458.420405347284, 3530.8764193253114, 3617.2584620152807, 3626.220362622049, 3644.4715516249994, 3672.5592928848173, 1133.4276190523733, 1137.3573930729112, 1138.9829152562718, 1139.3847322445952, 1141.7944769941491, 940.7459985803795, 955.5365647660878, 968.9031096890254, 976.1702552830037, 999.8701467341857, 5417.756200970965, 5630.549556035589, 5697.173909783141, 5730.111832665943, 5750.913736293959, 442.7232979387883, 443.9689221754446, 447.6910931457284, 449.9797509112098, 456.17887801956346, 4076.898077548026, 4094.0, 4125.266633696509, 4143.6685065194715, 4208.684348673862, 9887.159591434809, 10057.949710251401, 10171.135453486388, 10192.898071019343, 10272.229582781321, 10077.143442807443, 10082.546285417175, 10082.949585252174, 10090.69727908164, 10099.798004040025, 7609.695612175562, 7684.193159718261, 7687.231276872268, 7697.461177717618, 7726.072871255486, 5607.8878422432135, 5633.2395126657375, 5741.196232527366, 5781.190633311424, 5835.591508594358, 9206.539673016188, 9216.400933939542, 9277.0, 9389.671361502315, 9398.765030874009, 9037.277017838689, 9273.536323183678, 9355.5789989452, 9358.672446464614, 9411.952940235255, 6585.901211481736, 6821.795346139624, 6896.379325860496, 6998.825029374307, 7112.822179445555, 7690.307872291521, 7730.226977302224, 7741.0, 7747.147813740371, 7765.7670269892, 6972.721091156297, 7119.6084215368655, 7158.355747982707, 7166.856662866609, 7271.818204544717, 6589.901151482827, 6663.466922646274, 6669.666516674244, 6739.42714869222, 6740.662966851736, 6269.216347956505, 6342.302346741762, 6449.097126402401, 6486.124373209556, 6538.280789113289, 4926.605871530197, 4986.950130498649, 5000.299958005955, 5017.071841709296, 5027.145385284583, 4978.850634480971, 4993.425756038102, 5015.573676237561, 5035.320231768811, 5060.165072762953], "value": 4262.268497244636, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [321.1873958884024, 322.74986885164, 327.93113446176307, 328.18937225054106, 330.74863104040924, 5435.211894275328, 5479.6164268501225, 5487.780488780444, 5510.071474983763, 5515.435322575002, 5434.673919564829, 5443.510084092431, 5477.863053423666, 5480.177973304007, 5499.807506737265, 4014.2372949139644, 4130.306574304535, 4146.274401979656, 4191.622753952143, 4216.430781844442, 4207.873763787091, 4213.30480470722, 4216.894577635553, 4216.894577635569, 4230.344296634026, 4173.499180098377, 4205.222033923734, 4218.599233072853, 4220.008298049971, 4230.344296634026, 4107.178564287155, 4189.434426352434, 4216.325387937946, 4218.873433796991, 4251.319788833787, 3698.685611723007, 3705.5738590061947, 3719.2561487702296, 3719.479272901796, 3722.2183341498317, 5332.33345831771, 5335.439778823206, 5336.653117547347, 5345.786168553253, 5355.571554275649, 4736.5026672199265, 4854.174790285625, 4886.633502487292, 4905.705657660552, 4911.600193944709, 5633.63381380209, 5675.432456754333, 5683.54531637468, 5687.0900655895275, 5712.514746166027, 4073.246449406869, 4073.796310184479, 4084.8978775530554, 4088.9386659200136, 4114.979425102885, 5670.631408958446, 5924.437178468039, 5977.671228082454, 5991.4907232884825, 5995.160677505153, 4091.447654566655, 4123.958760412417, 4125.731827431207, 4128.566500517462, 4129.710920235555, 4146.315857883415, 4156.547636894186, 4165.375193720966, 4170.749755014709, 4172.165566886635, 4574.382458368078, 4791.496892826272, 4835.178019736653, 4849.733264670406, 4856.368672072608, 5780.132980053026, 5784.132380142928, 5798.739056742373, 5810.1865738796605, 5816.0, 1436.1957303909844, 1454.6508837878832, 1455.2796365798997, 1457.9781303280458, 1458.8475104667407, 918.4168053286211, 920.1994264989502, 930.432436213909, 949.5489642419795, 977.8044391121662, 5451.1653939951, 5483.382402191363, 5506.64206826555, 5513.476219759116, 5550.612346913272, 5769.192313076089, 5822.82531524055, 5837.9124313135335, 5865.736041878125, 5873.706314684334, 5238.92141617876, 5384.649997750212, 5442.8911421771345, 5468.425815289417, 5541.473560011793, 3042.3154790172475, 3082.7225549700634, 3102.317490152163, 3104.7516198704047, 3119.9376012479624, 5765.625234359837, 6000.969995150083, 6001.579889407787, 6038.939610603926, 6058.697065146813, 5911.4975227105315, 5944.197533332945, 5956.52347812174, 5969.432903874125, 6009.278886533557, 6008.459238668541, 6017.0974353846395, 6051.213342265565, 6077.270727512727, 6080.331163572004, 5649.350324712546, 5764.740586673526, 5769.307683078057, 5795.507381872588, 5910.645361278337, 5708.143778433268, 5735.225744524602, 5753.165790960371, 5825.621334613406, 5830.679312637845, 5934.495567876779, 5940.138679891478, 6030.0, 6054.879847228277, 6093.146959425772, 4081.755094694328, 4099.651529620016, 4102.446169767043, 4104.774237416971, 4116.4648595682365, 5820.216859041657, 5858.560607954506, 5883.911211519849, 5890.823275301748, 5892.322382926019, 5544.1960915667805, 5595.272614560081, 5645.108888522391, 5759.7040665849845, 5764.855878603068, 5645.463680950304, 5683.8863222736145, 5687.9431205687415, 5695.686737229326, 5704.828855134187, 5623.297087864017, 5681.659100453986, 5713.714314284186, 5724.084146536534, 5728.856778580569, 5790.971045144747, 5803.3616302207565, 5804.2744656917885, 5820.243368362086, 5833.095870140135, 5710.37185909558, 5724.885502290014, 5750.6837123958585, 5767.250257466502, 5777.2200752897825], "value": 4339.272922287384, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [728.1735230513369, 772.9613519324032, 811.2090711556233, 823.8640624296992, 839.2153336630249, 14417.062890912084, 15124.773128403083, 15210.391584336614, 15322.0, 15526.456574019912, 15604.453844115458, 15640.84359156408, 15767.921160394211, 15784.44754433595, 15784.44754433595, 796.848598766234, 799.7360870912585, 819.5082950229875, 820.9343252539783, 821.6056292979373, 824.1758241758242, 824.5877061469265, 824.6083110522513, 827.2720006394364, 827.896512935883, 859.1623167411755, 859.9871001934976, 862.2670729879615, 862.9654813807472, 863.4344504349662, 842.3682238321259, 852.0244320253337, 854.3080105114846, 855.5551113421049, 856.2080075929771, 624.6033768556954, 627.5230824573312, 628.7139351595014, 629.9559030867841, 630.9337519560472, 15263.771043434357, 15291.08253504782, 15310.157941313224, 15324.23378831054, 15327.157006364645, 13417.32913354338, 13551.39018744159, 13586.93206533961, 13696.726065478735, 13755.724885502234, 12667.493300267979, 12835.358232088452, 12904.16122952005, 13075.869241307655, 13080.803787943189, 3915.843366265346, 3938.5076865391825, 3944.36890097583, 3985.5815139410524, 4115.0, 85375.5731221346, 87148.0, 87536.56231718864, 88178.5591072047, 88667.55666221693, 9973.700788976343, 10264.230182736324, 10349.74125646865, 10419.583216671248, 10518.684439466828, 21067.262645807325, 21240.831754253664, 21277.36167914934, 21311.573768524544, 21357.572848542943, 8100.149484304063, 8250.133735957757, 8360.623771930277, 8420.78948026292, 8541.14588541141, 4370.890727731832, 4395.230834603995, 4464.4865840428765, 4558.156741002925, 4563.110193512233, 3344.782589131699, 3439.8108104054018, 3482.2861313431195, 3487.75585709003, 3503.1767534629344, 572.0275531596303, 586.524914818998, 587.4037851580649, 587.4272584230426, 606.4360145065043, 577.9855503612443, 610.7923306075955, 619.2537991719967, 725.7532438970775, 736.6059158350257, 8942.239909607626, 9600.0, 9602.66390676323, 9782.0, 9834.80330393388, 611.2634275697774, 624.6002558362652, 656.3567703650449, 694.8228201808506, 747.5925620536821, 4598.448186217675, 4903.117438860968, 4916.434610019822, 4939.0, 5001.224810154432, 123864.38067809603, 126486.3675681634, 128276.35861820632, 129149.0, 130198.0, 110846.44576777064, 111295.44352278349, 112022.43988780004, 112626.43686781514, 112795.0, 58322.0, 74124.62937685277, 79627.99999999884, 93852.53073734588, 95111.0, 9438.24494040489, 9642.71071867845, 9722.284557345922, 9753.391245239023, 9757.56090975922, 35582.288354233286, 42006.159876801685, 47194.76402617965, 49643.25535116904, 55048.0, 46251.0, 47796.28305575489, 59705.0, 70980.0, 72327.63836180785, 12717.427715752629, 12764.361781911053, 12867.099303048697, 13247.271400073088, 13314.46742130304, 14952.476663316731, 14962.775558366415, 15029.329176284524, 15325.310361033557, 15669.843301566838, 14000.36998335057, 14883.776743348642, 15418.845811541742, 15603.219839007777, 15913.522594322189, 14306.785398219243, 15491.84508154904, 15669.059856408652, 15694.9215253923, 15706.607334816721, 12894.67763305925, 14168.433262669378, 14316.856831431553, 14612.19632920157, 14631.707365852837, 11188.552457901593, 11277.830832537355, 11753.647390578297, 11904.880951190724, 12070.396480176132, 10815.188860835311, 11422.714432139262, 11491.597794077166, 11949.522019119138, 12661.366931653196], "value": 7592.133193647698, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1544.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 105.0, 113.0, 112.0, 112.0, 100.0, 111.0, 112.0, 111.0, 112.0], "value": 109.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 125.0, 150.0, 200.0, 124.0, 155.0, 159.0, 119.0, 182.0, 119.0], "value": 149.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 163.0, 166.0, 172.0, 164.0, 164.0, 162.0, 163.0, 162.0], "value": 164.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 76.0, 194.0, 78.0, 75.0, 74.0, 77.0, 161.0, 76.0], "value": 96.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 158.0, 83.0, 83.0, 84.0, 147.0, 83.0, 83.0, 143.0], "value": 103.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 117.0, 118.0, 117.0, 117.0, 119.0, 117.0, 117.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 147.0, 148.0, 147.0, 147.0, 147.0, 146.0, 148.0], "value": 147.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 95.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 95.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 55.0, 54.0, 55.0, 53.0, 57.0, 53.0, 54.0, 53.0], "value": 54.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 62.0, 63.0, 62.0, 63.0, 62.0, 62.0, 61.0], "value": 62.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 88.0, 86.0, 79.0, 81.0, 85.0, 77.0, 80.0, 80.0, 83.0], "value": 81.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 134.0, 126.0, 126.0, 138.0, 131.0, 132.0, 126.0, 171.0, 126.0], "value": 133.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 161.0, 170.0, 169.0, 160.0, 160.0, 163.0, 166.0, 163.0], "value": 163.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 66.0, 66.0, 65.0, 65.0, 66.0, 67.0, 64.0, 65.0, 64.0], "value": 65.7, "unit": "score"}]}]} 16:43:05 INFO - Return code: 0 16:43:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:43:05 ERROR - # TBPL SUCCESS # 16:43:05 INFO - Running post-action listener: _resource_record_post_action 16:43:05 INFO - [mozharness: 2016-08-25 23:43:05.461181Z] Finished run-tests step (success) 16:43:05 INFO - Running post-run listener: _resource_record_post_run 16:43:05 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 192512; Write bytes: 408358912; Read time: 48; Write time: 351360 16:43:05 INFO - TinderboxPrint: CPU usage
13.3% 16:43:05 INFO - TinderboxPrint: I/O read bytes / time
192,512 / 48 16:43:05 INFO - TinderboxPrint: I/O write bytes / time
408,358,912 / 351,360 16:43:05 INFO - TinderboxPrint: CPU idle
8,244.7 (86.7%) 16:43:05 INFO - TinderboxPrint: CPU user
1,207.9 (12.7%) 16:43:05 INFO - TinderboxPrint: Swap in / out
0 / 0 16:43:05 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 120033280; Read time: 0; Write time: 145200 16:43:05 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 192512; Write bytes: 287989760; Read time: 48; Write time: 206160 16:43:06 INFO - Running post-run listener: _upload_blobber_files 16:43:06 INFO - Blob upload gear active. 16:43:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:43:06 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 16:43:06 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', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:43:06 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 Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:43:06 INFO - (blobuploader) - INFO - Open directory for files ... 16:43:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:43:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:43:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:43:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:43:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:43:07 INFO - (blobuploader) - INFO - Done attempting. 16:43:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:43:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:43:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:43:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:43:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:43:07 INFO - (blobuploader) - INFO - Done attempting. 16:43:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:43:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:43:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:43:11 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:43:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:43:11 INFO - (blobuploader) - INFO - Done attempting. 16:43:11 INFO - (blobuploader) - INFO - Iteration through files over. 16:43:11 INFO - Return code: 0 16:43:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:43:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:43:11 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/48e10da5f339a29a5db4bdad0959e97e125a949f8ece18657cb1e758ff95f2d857475e62b1387e5b6b215960ae2249f27cac855ab1ab24e193f05d1e6481c901", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8ab4b32fd6711c89e6bdc945ff466eb9e2746b7fe75e858cfe0cc3db0b78a391ca54df489883e3667e97598c99df430936b6d1a22da9b7091e5d36caab829415", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/980a0378a44b1e6dca6ba525bc8111148900b6a4a78a973440bd74993f1e08b356f9cfc72ccd16434ab741cbbd7dfbf862cc86954b87dc8236d4031a4f2a77f0"} 16:43:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:43:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:43:11 INFO - Contents: 16:43:11 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/48e10da5f339a29a5db4bdad0959e97e125a949f8ece18657cb1e758ff95f2d857475e62b1387e5b6b215960ae2249f27cac855ab1ab24e193f05d1e6481c901", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8ab4b32fd6711c89e6bdc945ff466eb9e2746b7fe75e858cfe0cc3db0b78a391ca54df489883e3667e97598c99df430936b6d1a22da9b7091e5d36caab829415", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/980a0378a44b1e6dca6ba525bc8111148900b6a4a78a973440bd74993f1e08b356f9cfc72ccd16434ab741cbbd7dfbf862cc86954b87dc8236d4031a4f2a77f0"} 16:43:11 INFO - Running post-run listener: copy_logs_to_upload_dir 16:43:11 INFO - Copying logs to upload dir... 16:43:11 INFO - mkdir: /builds/slave/test/build/upload/logs 16:43:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.949494 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-08-25 16:43:11.424084) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-25 16:43:11.428355) ========= 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=62c568580acbfdaac3eec7be000001dc-1472167353.800986-1502237999 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/Mozilla-Inbound/sha512/48e10da5f339a29a5db4bdad0959e97e125a949f8ece18657cb1e758ff95f2d857475e62b1387e5b6b215960ae2249f27cac855ab1ab24e193f05d1e6481c901", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8ab4b32fd6711c89e6bdc945ff466eb9e2746b7fe75e858cfe0cc3db0b78a391ca54df489883e3667e97598c99df430936b6d1a22da9b7091e5d36caab829415", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/980a0378a44b1e6dca6ba525bc8111148900b6a4a78a973440bd74993f1e08b356f9cfc72ccd16434ab741cbbd7dfbf862cc86954b87dc8236d4031a4f2a77f0"} build_url:https://queue.taskcluster.net/v1/task/ai5GivCzSIGE3ygYwpbYqw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011268 build_url: 'https://queue.taskcluster.net/v1/task/ai5GivCzSIGE3ygYwpbYqw/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/Mozilla-Inbound/sha512/48e10da5f339a29a5db4bdad0959e97e125a949f8ece18657cb1e758ff95f2d857475e62b1387e5b6b215960ae2249f27cac855ab1ab24e193f05d1e6481c901", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8ab4b32fd6711c89e6bdc945ff466eb9e2746b7fe75e858cfe0cc3db0b78a391ca54df489883e3667e97598c99df430936b6d1a22da9b7091e5d36caab829415", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/980a0378a44b1e6dca6ba525bc8111148900b6a4a78a973440bd74993f1e08b356f9cfc72ccd16434ab741cbbd7dfbf862cc86954b87dc8236d4031a4f2a77f0"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-25 16:43:11.454386) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 16:43:11.454983) ========= 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=62c568580acbfdaac3eec7be000001dc-1472167353.800986-1502237999 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004504 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 16:43:11.539917) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-25 16:43:11.540275) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-25 16:43:11.540589) ========= ========= Total master_lag: 0.19 =========