builder: larch_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-017 starttime: 1471982847.32 results: success (0) buildid: 20160823103647 builduid: 50d7bc2eabcd4906a2e5a33581301de0 revision: 7214320961eda063ecef1be314c1c4da9b949dbe ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-23 13:07:27.320553) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-23 13:07:27.321082) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-23 13:07:27.321361) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-23 13:07:27.335775) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 13:07:27.336065) ========= 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=0333a256a5e4f052382dd180000001b1-1471982846.641249-1898329975 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-23 13:07:27-- 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% 45.9M=0s 2016-08-23 13:07:27 (45.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.121233 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 13:07:27.471093) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 13:07:27.471418) ========= 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=0333a256a5e4f052382dd180000001b1-1471982846.641249-1898329975 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014257 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 13:07:27.520195) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-23 13:07:27.520505) ========= bash -c 'python archiver_client.py mozharness --repo projects/larch --rev 7214320961eda063ecef1be314c1c4da9b949dbe --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/larch --rev 7214320961eda063ecef1be314c1c4da9b949dbe --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=0333a256a5e4f052382dd180000001b1-1471982846.641249-1898329975 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-23 13:07:27,752 truncating revision to first 12 chars 2016-08-23 13:07:27,752 Setting DEBUG logging. 2016-08-23 13:07:27,752 attempt 1/10 2016-08-23 13:07:27,752 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/larch/7214320961ed?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-23 13:07:28,901 unpacking tar archive at: larch-7214320961ed/testing/mozharness/ program finished with exit code 0 elapsedTime=1.442724 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-23 13:07:28.976715) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-23 13:07:28.977070) ========= script_repo_revision: 7214320961eda063ecef1be314c1c4da9b949dbe ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-23 13:07:28.977437) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-23 13:07:28.977708) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-23 13:07:28.988269) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-08-23 13:07:28.988603) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Larch-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Larch-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Larch-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Larch-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0333a256a5e4f052382dd180000001b1-1471982846.641249-1898329975 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:07:29 INFO - MultiFileLogger online at 20160823 13:07:29 in /builds/slave/test 13:07:29 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Larch-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Larch-Non-PGO 13:07:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:07:29 INFO - {'append_to_log': False, 13:07:29 INFO - 'base_work_dir': '/builds/slave/test', 13:07:29 INFO - 'blob_upload_branch': 'Larch-Non-PGO', 13:07:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:07:29 INFO - 'branch': 'Larch-Non-PGO', 13:07:29 INFO - 'buildbot_json_path': 'buildprops.json', 13:07:29 INFO - 'config_files': ('talos/linux_config.py',), 13:07:29 INFO - 'default_actions': ('clobber', 13:07:29 INFO - 'read-buildbot-config', 13:07:29 INFO - 'download-and-extract', 13:07:29 INFO - 'populate-webroot', 13:07:29 INFO - 'create-virtualenv', 13:07:29 INFO - 'install', 13:07:29 INFO - 'run-tests'), 13:07:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:07:29 INFO - 'download_minidump_stackwalk': True, 13:07:29 INFO - 'download_symbols': 'ondemand', 13:07:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:07:29 INFO - 'tooltool.py': '/tools/tooltool.py', 13:07:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:07:29 INFO - '/tools/misc-python/virtualenv.py')}, 13:07:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:07:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:07:29 INFO - 'installer_path': 'installer.exe', 13:07:29 INFO - 'log_level': 'info', 13:07:29 INFO - 'log_name': 'talos', 13:07:29 INFO - 'log_to_console': True, 13:07:29 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:07:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:07:29 INFO - 'opt_config_files': (), 13:07:29 INFO - 'pip_index': False, 13:07:29 INFO - 'sps_profile': False, 13:07:29 INFO - 'sps_profile_interval': 0, 13:07:29 INFO - 'suite': 'dromaeojs-e10s', 13:07:29 INFO - 'system_bits': '32', 13:07:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:07:29 INFO - 'title': 'talos-linux64-ix-017', 13:07:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:07:29 INFO - 'use_talos_json': True, 13:07:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:07:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:07:29 INFO - 'work_dir': 'build'} 13:07:29 INFO - [mozharness: 2016-08-23 20:07:29.315017Z] Running clobber step. 13:07:29 INFO - Running pre-action listener: _resource_record_pre_action 13:07:29 INFO - Running main action method: clobber 13:07:29 INFO - rmtree: /builds/slave/test/build 13:07:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:07:30 INFO - Running post-action listener: _resource_record_post_action 13:07:30 INFO - [mozharness: 2016-08-23 20:07:30.287843Z] Finished clobber step (success) 13:07:30 INFO - [mozharness: 2016-08-23 20:07:30.287942Z] Running read-buildbot-config step. 13:07:30 INFO - Running pre-action listener: _resource_record_pre_action 13:07:30 INFO - Running main action method: read_buildbot_config 13:07:30 INFO - Using buildbot properties: 13:07:30 INFO - { 13:07:30 INFO - "project": "", 13:07:30 INFO - "product": "firefox", 13:07:30 INFO - "script_repo_revision": "production", 13:07:30 INFO - "builddir": "larch_ubuntu64_hw_test-dromaeojs-e10s", 13:07:30 INFO - "repository": "", 13:07:30 INFO - "buildername": "Ubuntu HW 12.04 x64 larch talos dromaeojs-e10s", 13:07:30 INFO - "buildid": "20160823103647", 13:07:30 INFO - "pgo_build": "False", 13:07:30 INFO - "basedir": "/builds/slave/test", 13:07:30 INFO - "buildnumber": 2, 13:07:30 INFO - "slavename": "talos-linux64-ix-017", 13:07:30 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 13:07:30 INFO - "platform": "ubuntu64_hw", 13:07:30 INFO - "scheduler": "tests-larch-linux64-talos", 13:07:30 INFO - "branch": "larch", 13:07:30 INFO - "repo_path": "projects/larch", 13:07:30 INFO - "revision": "7214320961eda063ecef1be314c1c4da9b949dbe", 13:07:30 INFO - "stage_platform": "linux64", 13:07:30 INFO - "builduid": "50d7bc2eabcd4906a2e5a33581301de0", 13:07:30 INFO - "slavebuilddir": "test" 13:07:30 INFO - } 13:07:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/DlBw0_GQQlGoZ0CEKBc1Og/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 13:07:30 INFO - Running post-action listener: _resource_record_post_action 13:07:30 INFO - [mozharness: 2016-08-23 20:07:30.290349Z] Finished read-buildbot-config step (success) 13:07:30 INFO - [mozharness: 2016-08-23 20:07:30.290436Z] Running download-and-extract step. 13:07:30 INFO - Running pre-action listener: _resource_record_pre_action 13:07:30 INFO - Running main action method: download_and_extract 13:07:30 INFO - mkdir: /builds/slave/test/build/tests 13:07:30 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')]} 13:07:30 INFO - trying https://queue.taskcluster.net/v1/task/DlBw0_GQQlGoZ0CEKBc1Og/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 13:07:30 INFO - Downloading https://queue.taskcluster.net/v1/task/DlBw0_GQQlGoZ0CEKBc1Og/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 13:07:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DlBw0_GQQlGoZ0CEKBc1Og/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 13:07:30 INFO - Downloaded 1361 bytes. 13:07:30 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 13:07:30 INFO - Using the following test package requirements: 13:07:30 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 13:07:30 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 13:07:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:07:30 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 13:07:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:07:30 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 13:07:30 INFO - u'jsshell-linux-x86_64.zip'], 13:07:30 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 13:07:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:07:30 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 13:07:30 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 13:07:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:07:30 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 13:07:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:07:30 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 13:07:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:07:30 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 13:07:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:07:30 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:07:30 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')]} 13:07:30 INFO - trying https://queue.taskcluster.net/v1/task/DlBw0_GQQlGoZ0CEKBc1Og/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 13:07:30 INFO - Downloading https://queue.taskcluster.net/v1/task/DlBw0_GQQlGoZ0CEKBc1Og/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 13:07:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DlBw0_GQQlGoZ0CEKBc1Og/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 13:07:31 INFO - Downloaded 20330692 bytes. 13:07:31 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 13:07:35 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 13:07:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:07:35 INFO - trying https://queue.taskcluster.net/v1/task/DlBw0_GQQlGoZ0CEKBc1Og/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 13:07:35 INFO - Downloading https://queue.taskcluster.net/v1/task/DlBw0_GQQlGoZ0CEKBc1Og/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 13:07:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DlBw0_GQQlGoZ0CEKBc1Og/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 13:07:36 INFO - Downloaded 20330692 bytes. 13:07:36 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 13:07: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')]} 13:07:41 INFO - trying https://queue.taskcluster.net/v1/task/DlBw0_GQQlGoZ0CEKBc1Og/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 13:07:41 INFO - Downloading https://queue.taskcluster.net/v1/task/DlBw0_GQQlGoZ0CEKBc1Og/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 13:07:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DlBw0_GQQlGoZ0CEKBc1Og/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 13:07:42 INFO - Downloaded 14413981 bytes. 13:07:42 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 13:07:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:07:42 INFO - trying https://queue.taskcluster.net/v1/task/DlBw0_GQQlGoZ0CEKBc1Og/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 13:07:42 INFO - Downloading https://queue.taskcluster.net/v1/task/DlBw0_GQQlGoZ0CEKBc1Og/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 13:07:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DlBw0_GQQlGoZ0CEKBc1Og/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 13:07:43 INFO - Downloaded 55747458 bytes. 13:07:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DlBw0_GQQlGoZ0CEKBc1Og/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 13:07:43 INFO - mkdir: /builds/slave/test/properties 13:07:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:07:43 INFO - Writing to file /builds/slave/test/properties/build_url 13:07:43 INFO - Contents: 13:07:43 INFO - build_url:https://queue.taskcluster.net/v1/task/DlBw0_GQQlGoZ0CEKBc1Og/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 13:07:44 INFO - Running post-action listener: _resource_record_post_action 13:07:44 INFO - Running post-action listener: set_extra_try_arguments 13:07:44 INFO - [mozharness: 2016-08-23 20:07:44.045188Z] Finished download-and-extract step (success) 13:07:44 INFO - [mozharness: 2016-08-23 20:07:44.045438Z] Running populate-webroot step. 13:07:44 INFO - Running pre-action listener: _resource_record_pre_action 13:07:44 INFO - Running main action method: populate_webroot 13:07:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:07:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:07:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:07:44 INFO - '--tppagecycles', 13:07:44 INFO - '7'], 13:07:44 INFO - 'tests': ['tsvgm']}}, 13:07:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:07:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:07:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:07:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:07:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:07:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:07:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:07:44 INFO - 'talos_options': ['--disable-e10s'], 13:07:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:07:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:07:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:07:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:07:44 INFO - 'talos_options': ['--disable-e10s'], 13:07:44 INFO - 'tests': ['damp', 'tps']}, 13:07:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:07:44 INFO - 'tests': ['damp', 'tps']}, 13:07:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:07:44 INFO - 'tests': ['dromaeo_dom']}, 13:07:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:07:44 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:07:44 INFO - 'tests': ['basic_compositor_video']}, 13:07:44 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:07:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:07:44 INFO - 'tests': ['a11yr', 13:07:44 INFO - 'ts_paint', 13:07:44 INFO - 'tpaint', 13:07:44 INFO - 'sessionrestore', 13:07:44 INFO - 'sessionrestore_no_auto_restore', 13:07:44 INFO - 'tabpaint']}, 13:07:44 INFO - 'other-e10s': {'tests': ['a11yr', 13:07:44 INFO - 'ts_paint', 13:07:44 INFO - 'tpaint', 13:07:44 INFO - 'sessionrestore', 13:07:44 INFO - 'sessionrestore_no_auto_restore', 13:07:44 INFO - 'tabpaint']}, 13:07:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:07:44 INFO - 'ts_paint', 13:07:44 INFO - 'tpaint', 13:07:44 INFO - 'sessionrestore', 13:07:44 INFO - 'sessionrestore_no_auto_restore', 13:07:44 INFO - 'tabpaint']}, 13:07:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:07:44 INFO - 'ts_paint', 13:07:44 INFO - 'tpaint', 13:07:44 INFO - 'sessionrestore', 13:07:44 INFO - 'sessionrestore_no_auto_restore', 13:07:44 INFO - 'tabpaint']}, 13:07:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:07:44 INFO - 'tests': ['a11yr', 13:07:44 INFO - 'ts_paint', 13:07:44 INFO - 'tpaint', 13:07:44 INFO - 'sessionrestore', 13:07:44 INFO - 'sessionrestore_no_auto_restore', 13:07:44 INFO - 'tabpaint']}, 13:07:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:07:44 INFO - 'tests': ['a11yr', 13:07:44 INFO - 'ts_paint', 13:07:44 INFO - 'tpaint', 13:07:44 INFO - 'sessionrestore', 13:07:44 INFO - 'sessionrestore_no_auto_restore', 13:07:44 INFO - 'tabpaint']}, 13:07:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:07:44 INFO - 'tests': ['tsvgx', 13:07:44 INFO - 'tsvgr_opacity', 13:07:44 INFO - 'tart', 13:07:44 INFO - 'tscrollx', 13:07:44 INFO - 'cart']}, 13:07:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:07:44 INFO - 'tsvgr_opacity', 13:07:44 INFO - 'tart', 13:07:44 INFO - 'tscrollx', 13:07:44 INFO - 'cart']}, 13:07:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:07:44 INFO - 'talos_options': ['--disable-e10s'], 13:07:44 INFO - 'tests': ['tp5o']}, 13:07:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:07:44 INFO - 'tests': ['tp5o']}, 13:07:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:07:44 INFO - 'talos_options': ['--disable-e10s', 13:07:44 INFO - '--xperf_path', 13:07:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:07:44 INFO - 'tests': ['tp5n']}, 13:07:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:07:44 INFO - 'talos_options': ['--xperf_path', 13:07:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:07:44 INFO - 'tests': ['tp5n']}}, 13:07:44 INFO - 'talos.zip': {'path': '', 13:07:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:07:44 INFO - Running post-action listener: _resource_record_post_action 13:07:44 INFO - [mozharness: 2016-08-23 20:07:44.069601Z] Finished populate-webroot step (success) 13:07:44 INFO - [mozharness: 2016-08-23 20:07:44.069700Z] Running create-virtualenv step. 13:07:44 INFO - Running pre-action listener: _resource_record_pre_action 13:07:44 INFO - Running main action method: create_virtualenv 13:07:44 INFO - Creating virtualenv /builds/slave/test/build/venv 13:07:44 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 13:07:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:07:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:07:44 INFO - Using real prefix '/usr' 13:07:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:07:44 INFO - Installing distribute.............................................................................................................................................................................................done. 13:07:46 INFO - Installing pip.................done. 13:07:46 INFO - Return code: 0 13:07:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:07:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:07:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:07:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:07:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:07:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f71019d1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd68230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd62090>, '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 0xd659b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd65e40>, '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': '0333a256a5e4f052382dd180000001b1-1471982846.641249-1898329975', '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 13:07:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 13:07:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 13:07:46 INFO - Using env: {'DISPLAY': ':0', 13:07:46 INFO - 'HOME': '/home/cltbld', 13:07:46 INFO - 'LANG': 'en_US.UTF-8', 13:07:46 INFO - 'LANGUAGE': 'en_US:en', 13:07:46 INFO - 'LOGNAME': 'cltbld', 13:07:46 INFO - 'MAIL': '/var/mail/cltbld', 13:07:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:07:46 INFO - 'MOZ_NO_REMOTE': '1', 13:07:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:07:46 INFO - 'NO_EM_RESTART': '1', 13:07:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:07:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:07:46 INFO - 'PWD': '/builds/slave/test', 13:07:46 INFO - 'SHELL': '/bin/bash', 13:07:46 INFO - 'SHLVL': '1', 13:07:46 INFO - 'TERM': 'linux', 13:07:46 INFO - 'TMOUT': '86400', 13:07:46 INFO - 'USER': 'cltbld', 13:07:46 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1471982846.641249-1898329975', 13:07:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:07:46 INFO - '_': '/tools/buildbot/bin/python'} 13:07:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:07:46 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 13:07:46 INFO - Cleaning up... 13:07:46 INFO - Return code: 0 13:07:46 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:07:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:07:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:07:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:07:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:07:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f71019d1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd68230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd62090>, '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 0xd659b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd65e40>, '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': '0333a256a5e4f052382dd180000001b1-1471982846.641249-1898329975', '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 13:07:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 13:07:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 13:07:46 INFO - Using env: {'DISPLAY': ':0', 13:07:46 INFO - 'HOME': '/home/cltbld', 13:07:46 INFO - 'LANG': 'en_US.UTF-8', 13:07:46 INFO - 'LANGUAGE': 'en_US:en', 13:07:46 INFO - 'LOGNAME': 'cltbld', 13:07:46 INFO - 'MAIL': '/var/mail/cltbld', 13:07:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:07:46 INFO - 'MOZ_NO_REMOTE': '1', 13:07:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:07:46 INFO - 'NO_EM_RESTART': '1', 13:07:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:07:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:07:46 INFO - 'PWD': '/builds/slave/test', 13:07:46 INFO - 'SHELL': '/bin/bash', 13:07:46 INFO - 'SHLVL': '1', 13:07:46 INFO - 'TERM': 'linux', 13:07:46 INFO - 'TMOUT': '86400', 13:07:46 INFO - 'USER': 'cltbld', 13:07:46 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1471982846.641249-1898329975', 13:07:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:07:46 INFO - '_': '/tools/buildbot/bin/python'} 13:07:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:07:47 INFO - Downloading/unpacking psutil>=3.1.1 13:07:47 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 13:07:47 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 13:07:47 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 13:07:47 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 13:07:47 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 13:07:47 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 13:07:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:07:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:07:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:07:49 INFO - Installing collected packages: psutil 13:07:49 INFO - Running setup.py install for psutil 13:07:49 INFO - building 'psutil._psutil_linux' extension 13:07:49 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 13:07:49 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 13:07:49 INFO - building 'psutil._psutil_posix' extension 13:07:49 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 13:07:49 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 13:07:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:07:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:07:49 INFO - Successfully installed psutil 13:07:49 INFO - Cleaning up... 13:07:49 INFO - Return code: 0 13:07:49 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:07:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:07:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:07:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:07:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:07:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f71019d1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd68230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd62090>, '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 0xd659b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd65e40>, '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': '0333a256a5e4f052382dd180000001b1-1471982846.641249-1898329975', '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 13:07:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 13:07:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 13:07:49 INFO - Using env: {'DISPLAY': ':0', 13:07:49 INFO - 'HOME': '/home/cltbld', 13:07:49 INFO - 'LANG': 'en_US.UTF-8', 13:07:49 INFO - 'LANGUAGE': 'en_US:en', 13:07:49 INFO - 'LOGNAME': 'cltbld', 13:07:49 INFO - 'MAIL': '/var/mail/cltbld', 13:07:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:07:49 INFO - 'MOZ_NO_REMOTE': '1', 13:07:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:07:49 INFO - 'NO_EM_RESTART': '1', 13:07:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:07:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:07:49 INFO - 'PWD': '/builds/slave/test', 13:07:49 INFO - 'SHELL': '/bin/bash', 13:07:49 INFO - 'SHLVL': '1', 13:07:49 INFO - 'TERM': 'linux', 13:07:49 INFO - 'TMOUT': '86400', 13:07:49 INFO - 'USER': 'cltbld', 13:07:49 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1471982846.641249-1898329975', 13:07:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:07:49 INFO - '_': '/tools/buildbot/bin/python'} 13:07:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:07:50 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:07:50 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 13:07:50 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 13:07:50 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 13:07:50 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 13:07:50 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 13:07:50 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 13:07:51 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:07:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:07:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:07:51 INFO - Installing collected packages: mozsystemmonitor 13:07:51 INFO - Running setup.py install for mozsystemmonitor 13:07:52 INFO - Successfully installed mozsystemmonitor 13:07:52 INFO - Cleaning up... 13:07:52 INFO - Return code: 0 13:07:52 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:07: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')]} 13:07:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:07:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07: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')]} 13:07:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:07:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07: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', '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 0x7f71019d1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd68230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd62090>, '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 0xd659b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd65e40>, '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': '0333a256a5e4f052382dd180000001b1-1471982846.641249-1898329975', '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 13:07: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 13:07: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 jsonschema==2.5.1 13:07:52 INFO - Using env: {'DISPLAY': ':0', 13:07:52 INFO - 'HOME': '/home/cltbld', 13:07:52 INFO - 'LANG': 'en_US.UTF-8', 13:07:52 INFO - 'LANGUAGE': 'en_US:en', 13:07:52 INFO - 'LOGNAME': 'cltbld', 13:07:52 INFO - 'MAIL': '/var/mail/cltbld', 13:07:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:07:52 INFO - 'MOZ_NO_REMOTE': '1', 13:07:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:07:52 INFO - 'NO_EM_RESTART': '1', 13:07:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:07:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:07:52 INFO - 'PWD': '/builds/slave/test', 13:07:52 INFO - 'SHELL': '/bin/bash', 13:07:52 INFO - 'SHLVL': '1', 13:07:52 INFO - 'TERM': 'linux', 13:07:52 INFO - 'TMOUT': '86400', 13:07:52 INFO - 'USER': 'cltbld', 13:07:52 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1471982846.641249-1898329975', 13:07:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:07:52 INFO - '_': '/tools/buildbot/bin/python'} 13:07:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:07:52 INFO - Downloading/unpacking jsonschema==2.5.1 13:07:52 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 13:07:52 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 13:07:52 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 13:07:52 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 13:07:52 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 13:07:52 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 13:07:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:07:54 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:07:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:07:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:07:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:07:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:07:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:07:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:07:54 INFO - Downloading functools32-3.2.3-2.tar.gz 13:07:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:07:54 INFO - warning: no files found matching '*.txt' 13:07:54 INFO - no previously-included directories found matching 'build' 13:07:54 INFO - no previously-included directories found matching 'dist' 13:07:54 INFO - no previously-included directories found matching '.git*' 13:07:54 INFO - Installing collected packages: jsonschema, functools32 13:07:54 INFO - Running setup.py install for functools32 13:07:54 INFO - warning: no files found matching '*.txt' 13:07:54 INFO - no previously-included directories found matching 'build' 13:07:54 INFO - no previously-included directories found matching 'dist' 13:07:54 INFO - no previously-included directories found matching '.git*' 13:07:54 INFO - Successfully installed jsonschema functools32 13:07:54 INFO - Cleaning up... 13:07:54 INFO - Return code: 0 13:07:54 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:07:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:07:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:07:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:07:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:07:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f71019d1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd68230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd62090>, '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 0xd659b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd65e40>, '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': '0333a256a5e4f052382dd180000001b1-1471982846.641249-1898329975', '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 13:07:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 13:07:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 13:07:54 INFO - Using env: {'DISPLAY': ':0', 13:07:54 INFO - 'HOME': '/home/cltbld', 13:07:54 INFO - 'LANG': 'en_US.UTF-8', 13:07:54 INFO - 'LANGUAGE': 'en_US:en', 13:07:54 INFO - 'LOGNAME': 'cltbld', 13:07:54 INFO - 'MAIL': '/var/mail/cltbld', 13:07:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:07:54 INFO - 'MOZ_NO_REMOTE': '1', 13:07:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:07:54 INFO - 'NO_EM_RESTART': '1', 13:07:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:07:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:07:54 INFO - 'PWD': '/builds/slave/test', 13:07:54 INFO - 'SHELL': '/bin/bash', 13:07:54 INFO - 'SHLVL': '1', 13:07:54 INFO - 'TERM': 'linux', 13:07:54 INFO - 'TMOUT': '86400', 13:07:54 INFO - 'USER': 'cltbld', 13:07:54 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1471982846.641249-1898329975', 13:07:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:07:54 INFO - '_': '/tools/buildbot/bin/python'} 13:07:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:07:54 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:07:54 INFO - Cleaning up... 13:07:54 INFO - Return code: 0 13:07:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:07:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:07:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:07:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:07:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:07:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f71019d1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd68230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd62090>, '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 0xd659b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd65e40>, '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': '0333a256a5e4f052382dd180000001b1-1471982846.641249-1898329975', '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 13:07:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:07:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:07:54 INFO - Using env: {'DISPLAY': ':0', 13:07:54 INFO - 'HOME': '/home/cltbld', 13:07:54 INFO - 'LANG': 'en_US.UTF-8', 13:07:54 INFO - 'LANGUAGE': 'en_US:en', 13:07:54 INFO - 'LOGNAME': 'cltbld', 13:07:54 INFO - 'MAIL': '/var/mail/cltbld', 13:07:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:07:54 INFO - 'MOZ_NO_REMOTE': '1', 13:07:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:07:54 INFO - 'NO_EM_RESTART': '1', 13:07:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:07:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:07:54 INFO - 'PWD': '/builds/slave/test', 13:07:54 INFO - 'SHELL': '/bin/bash', 13:07:54 INFO - 'SHLVL': '1', 13:07:54 INFO - 'TERM': 'linux', 13:07:54 INFO - 'TMOUT': '86400', 13:07:54 INFO - 'USER': 'cltbld', 13:07:54 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1471982846.641249-1898329975', 13:07:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:07:54 INFO - '_': '/tools/buildbot/bin/python'} 13:07:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:07:55 INFO - Downloading/unpacking blobuploader==1.2.4 13:07: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 13:07: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 13:07: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 13:07: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 13:07: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 13:07: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 13:07:56 INFO - Downloading blobuploader-1.2.4.tar.gz 13:07:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:07:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:07:57 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 13:07:57 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 13:07:57 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 13:07:57 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 13:07:57 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 13:07:57 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 13:07:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:07:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:07:57 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 13:07:57 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 13:07:57 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 13:07:57 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 13:07:57 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 13:07:57 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 13:07:57 INFO - Downloading docopt-0.6.1.tar.gz 13:07:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:07:57 INFO - Installing collected packages: blobuploader, requests, docopt 13:07:57 INFO - Running setup.py install for blobuploader 13:07:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:07:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:07:57 INFO - Running setup.py install for requests 13:07:58 INFO - Running setup.py install for docopt 13:07:58 INFO - Successfully installed blobuploader requests docopt 13:07:58 INFO - Cleaning up... 13:07:58 INFO - Return code: 0 13:07:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:07:58 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')]} 13:07:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:07:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:58 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')]} 13:07:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:07:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:58 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 0x7f71019d1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd68230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd62090>, '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 0xd659b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd65e40>, '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': '0333a256a5e4f052382dd180000001b1-1471982846.641249-1898329975', '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 13:07:58 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 13:07:58 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 13:07:58 INFO - Using env: {'DISPLAY': ':0', 13:07:58 INFO - 'HOME': '/home/cltbld', 13:07:58 INFO - 'LANG': 'en_US.UTF-8', 13:07:58 INFO - 'LANGUAGE': 'en_US:en', 13:07:58 INFO - 'LOGNAME': 'cltbld', 13:07:58 INFO - 'MAIL': '/var/mail/cltbld', 13:07:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:07:58 INFO - 'MOZ_NO_REMOTE': '1', 13:07:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:07:58 INFO - 'NO_EM_RESTART': '1', 13:07:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:07:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:07:58 INFO - 'PWD': '/builds/slave/test', 13:07:58 INFO - 'SHELL': '/bin/bash', 13:07:58 INFO - 'SHLVL': '1', 13:07:58 INFO - 'TERM': 'linux', 13:07:58 INFO - 'TMOUT': '86400', 13:07:58 INFO - 'USER': 'cltbld', 13:07:58 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1471982846.641249-1898329975', 13:07:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:07:58 INFO - '_': '/tools/buildbot/bin/python'} 13:07:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:07:58 INFO - Running setup.py (path:/tmp/pip-PoYFSQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:07:58 INFO - Running setup.py (path:/tmp/pip-8j9aSQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:07:58 INFO - Running setup.py (path:/tmp/pip-JnBu52-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:07:58 INFO - Running setup.py (path:/tmp/pip-8bQJxA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:07:58 INFO - Running setup.py (path:/tmp/pip-1lYRXt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:07:58 INFO - Running setup.py (path:/tmp/pip-uEJjVr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:07:58 INFO - Running setup.py (path:/tmp/pip-GTl2gq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:07:59 INFO - Running setup.py (path:/tmp/pip-ptUOxq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:07:59 INFO - Running setup.py (path:/tmp/pip-96XoXi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:07:59 INFO - Running setup.py (path:/tmp/pip-cR4oNm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:07:59 INFO - Running setup.py (path:/tmp/pip-vRmbRW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:07:59 INFO - Running setup.py (path:/tmp/pip-O_Lr6I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:07:59 INFO - Running setup.py (path:/tmp/pip-EughDB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:07:59 INFO - Running setup.py (path:/tmp/pip-K21VdG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:07:59 INFO - Running setup.py (path:/tmp/pip-27MsXj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:07:59 INFO - Running setup.py (path:/tmp/pip-wo6sgb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:07:59 INFO - Running setup.py (path:/tmp/pip-a0YrkI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:07:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:07:59 INFO - Running setup.py install for manifestparser 13:07:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:07:59 INFO - Running setup.py install for mozcrash 13:07:59 INFO - Running setup.py install for mozdebug 13:08:00 INFO - Running setup.py install for mozdevice 13:08:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:08:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:08:00 INFO - Running setup.py install for mozfile 13:08:00 INFO - Running setup.py install for mozhttpd 13:08:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:08:00 INFO - Running setup.py install for mozinfo 13:08:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:08:00 INFO - Running setup.py install for mozInstall 13:08:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:08:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:08:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:08:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:08:00 INFO - Running setup.py install for mozleak 13:08:00 INFO - Running setup.py install for mozlog 13:08:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:08:00 INFO - Running setup.py install for moznetwork 13:08:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:08:00 INFO - Running setup.py install for mozprocess 13:08:01 INFO - Running setup.py install for mozprofile 13:08:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:08:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:08:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:08:01 INFO - Running setup.py install for mozrunner 13:08:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:08:01 INFO - Running setup.py install for mozscreenshot 13:08:01 INFO - Running setup.py install for moztest 13:08:01 INFO - Running setup.py install for mozversion 13:08:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:08:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:08:01 INFO - Cleaning up... 13:08:01 INFO - Return code: 0 13:08:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:08:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:08:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:08:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:08:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:08:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f71019d1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd68230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd62090>, '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 0xd659b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd65e40>, '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': '0333a256a5e4f052382dd180000001b1-1471982846.641249-1898329975', '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 13:08:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 13:08:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:08:01 INFO - Using env: {'DISPLAY': ':0', 13:08:01 INFO - 'HOME': '/home/cltbld', 13:08:01 INFO - 'LANG': 'en_US.UTF-8', 13:08:01 INFO - 'LANGUAGE': 'en_US:en', 13:08:01 INFO - 'LOGNAME': 'cltbld', 13:08:01 INFO - 'MAIL': '/var/mail/cltbld', 13:08:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:08:01 INFO - 'MOZ_NO_REMOTE': '1', 13:08:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:08:01 INFO - 'NO_EM_RESTART': '1', 13:08:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:08:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:08:01 INFO - 'PWD': '/builds/slave/test', 13:08:01 INFO - 'SHELL': '/bin/bash', 13:08:01 INFO - 'SHLVL': '1', 13:08:01 INFO - 'TERM': 'linux', 13:08:01 INFO - 'TMOUT': '86400', 13:08:01 INFO - 'USER': 'cltbld', 13:08:01 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1471982846.641249-1898329975', 13:08:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:08:01 INFO - '_': '/tools/buildbot/bin/python'} 13:08:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:08:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:08:01 INFO - Running setup.py (path:/tmp/pip-goF8dw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:08:01 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 13:08:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:08:01 INFO - Running setup.py (path:/tmp/pip-ydF9C0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:08:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:08:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:08:01 INFO - Running setup.py (path:/tmp/pip-wnYIQg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:08:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 13:08:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:08:02 INFO - Running setup.py (path:/tmp/pip-Lj0qDH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:08:02 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)) 13:08:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:08:02 INFO - Running setup.py (path:/tmp/pip-9PURTJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:08:02 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)) 13:08:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:08:02 INFO - Running setup.py (path:/tmp/pip-2wuSsW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:08:02 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)) 13:08:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:08:02 INFO - Running setup.py (path:/tmp/pip-HMOcoD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:08:02 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)) 13:08:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:08:02 INFO - Running setup.py (path:/tmp/pip-JsH8cI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:08:02 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)) 13:08:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:08:02 INFO - Running setup.py (path:/tmp/pip-6F4g9l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:08:02 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)) 13:08:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:08:02 INFO - Running setup.py (path:/tmp/pip-BIi9C7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:08:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:08:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:08:02 INFO - Running setup.py (path:/tmp/pip-lz0Mfm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:08:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 13:08:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:08:02 INFO - Running setup.py (path:/tmp/pip-R6EbcB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:08:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 13:08:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:08:02 INFO - Running setup.py (path:/tmp/pip-8ZkykK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:08:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 13:08:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:08:02 INFO - Running setup.py (path:/tmp/pip-yp3Z7F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:08:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 13:08:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:08:02 INFO - Running setup.py (path:/tmp/pip-NdN1Y7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:08:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 13:08:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:08:02 INFO - Running setup.py (path:/tmp/pip-p7Jxb_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:08:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 13:08:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:08:02 INFO - Running setup.py (path:/tmp/pip-wxSRUn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:08:03 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)) 13:08:03 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)) 13:08:03 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)) 13:08:03 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)) 13:08:03 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)) 13:08:03 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)) 13:08:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:08: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 13:08: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 13:08: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 13:08: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 13:08: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 13:08: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 13:08:04 INFO - Downloading blessings-1.6.tar.gz 13:08:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:08:04 INFO - Installing collected packages: blessings 13:08:04 INFO - Running setup.py install for blessings 13:08:05 INFO - Successfully installed blessings 13:08:05 INFO - Cleaning up... 13:08:05 INFO - Return code: 0 13:08:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:08:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:08:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:08:05 INFO - Reading from file tmpfile_stdout 13:08:05 INFO - Current package versions: 13:08:05 INFO - argparse == 1.2.1 13:08:05 INFO - blessings == 1.6 13:08:05 INFO - blobuploader == 1.2.4 13:08:05 INFO - docopt == 0.6.1 13:08:05 INFO - functools32 == 3.2.3-2 13:08:05 INFO - jsonschema == 2.5.1 13:08:05 INFO - manifestparser == 1.1 13:08:05 INFO - mozInstall == 1.12 13:08:05 INFO - mozcrash == 0.17 13:08:05 INFO - mozdebug == 0.1 13:08:05 INFO - mozdevice == 0.48 13:08:05 INFO - mozfile == 1.2 13:08:05 INFO - mozhttpd == 0.7 13:08:05 INFO - mozinfo == 0.9 13:08:05 INFO - mozleak == 0.1 13:08:05 INFO - mozlog == 3.3 13:08:05 INFO - moznetwork == 0.27 13:08:05 INFO - mozprocess == 0.23 13:08:05 INFO - mozprofile == 0.28 13:08:05 INFO - mozrunner == 6.12 13:08:05 INFO - mozscreenshot == 0.1 13:08:05 INFO - mozsystemmonitor == 0.3 13:08:05 INFO - moztest == 0.7 13:08:05 INFO - mozversion == 1.4 13:08:05 INFO - psutil == 3.1.1 13:08:05 INFO - requests == 1.2.3 13:08:05 INFO - wsgiref == 0.1.2 13:08:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:08:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:08:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:08:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:08:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:08:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:05 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 0x7f71019d1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd68230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd62090>, '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 0xd659b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd65e40>, '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': '0333a256a5e4f052382dd180000001b1-1471982846.641249-1898329975', '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 13:08:05 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 13:08:05 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 13:08:05 INFO - Using env: {'DISPLAY': ':0', 13:08:05 INFO - 'HOME': '/home/cltbld', 13:08:05 INFO - 'LANG': 'en_US.UTF-8', 13:08:05 INFO - 'LANGUAGE': 'en_US:en', 13:08:05 INFO - 'LOGNAME': 'cltbld', 13:08:05 INFO - 'MAIL': '/var/mail/cltbld', 13:08:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:08:05 INFO - 'MOZ_NO_REMOTE': '1', 13:08:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:08:05 INFO - 'NO_EM_RESTART': '1', 13:08:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:08:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:08:05 INFO - 'PWD': '/builds/slave/test', 13:08:05 INFO - 'SHELL': '/bin/bash', 13:08:05 INFO - 'SHLVL': '1', 13:08:05 INFO - 'TERM': 'linux', 13:08:05 INFO - 'TMOUT': '86400', 13:08:05 INFO - 'USER': 'cltbld', 13:08:05 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1471982846.641249-1898329975', 13:08:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:08:05 INFO - '_': '/tools/buildbot/bin/python'} 13:08:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:08:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:08:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 13:08:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 13:08:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 13:08:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 13:08:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 13:08:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 13:08:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 13:08:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 13:08:05 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:08:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 13:08:05 INFO - Cleaning up... 13:08:05 INFO - Return code: 0 13:08:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:08:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:08:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:08:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:08:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:08:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f71019d1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd68230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd62090>, '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 0xd659b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd65e40>, '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': '0333a256a5e4f052382dd180000001b1-1471982846.641249-1898329975', '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 13:08:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 13:08:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 13:08:05 INFO - Using env: {'DISPLAY': ':0', 13:08:05 INFO - 'HOME': '/home/cltbld', 13:08:05 INFO - 'LANG': 'en_US.UTF-8', 13:08:05 INFO - 'LANGUAGE': 'en_US:en', 13:08:05 INFO - 'LOGNAME': 'cltbld', 13:08:05 INFO - 'MAIL': '/var/mail/cltbld', 13:08:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:08:05 INFO - 'MOZ_NO_REMOTE': '1', 13:08:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:08:05 INFO - 'NO_EM_RESTART': '1', 13:08:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:08:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:08:05 INFO - 'PWD': '/builds/slave/test', 13:08:05 INFO - 'SHELL': '/bin/bash', 13:08:05 INFO - 'SHLVL': '1', 13:08:05 INFO - 'TERM': 'linux', 13:08:05 INFO - 'TMOUT': '86400', 13:08:05 INFO - 'USER': 'cltbld', 13:08:05 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1471982846.641249-1898329975', 13:08:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:08:05 INFO - '_': '/tools/buildbot/bin/python'} 13:08:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:08:05 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:08:05 INFO - Cleaning up... 13:08:05 INFO - Return code: 0 13:08:05 INFO - Running post-action listener: _resource_record_post_action 13:08:05 INFO - Running post-action listener: _start_resource_monitoring 13:08:05 INFO - Starting resource monitoring. 13:08:05 INFO - [mozharness: 2016-08-23 20:08:05.845750Z] Finished create-virtualenv step (success) 13:08:05 INFO - [mozharness: 2016-08-23 20:08:05.846253Z] Running install step. 13:08:05 INFO - Running pre-action listener: _resource_record_pre_action 13:08:05 INFO - Running main action method: install 13:08:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:08:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:08:06 INFO - Reading from file tmpfile_stdout 13:08:06 INFO - Detecting whether we're running mozinstall >=1.0... 13:08:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:08:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:08:06 INFO - Reading from file tmpfile_stdout 13:08:06 INFO - Output received: 13:08:06 INFO - Usage: mozinstall [options] installer 13:08:06 INFO - Options: 13:08:06 INFO - -h, --help show this help message and exit 13:08:06 INFO - -d DEST, --destination=DEST 13:08:06 INFO - Directory to install application into. [default: 13:08:06 INFO - "/builds/slave/test"] 13:08:06 INFO - --app=APP Application being installed. [default: firefox] 13:08:06 INFO - mkdir: /builds/slave/test/build/application 13:08:06 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'] 13:08:06 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 13:08:22 INFO - Reading from file tmpfile_stdout 13:08:22 INFO - Output received: 13:08:22 INFO - /builds/slave/test/build/application/firefox/firefox 13:08:22 INFO - Running post-action listener: _resource_record_post_action 13:08:22 INFO - [mozharness: 2016-08-23 20:08:22.247190Z] Finished install step (success) 13:08:22 INFO - [mozharness: 2016-08-23 20:08:22.247440Z] Running run-tests step. 13:08:22 INFO - Running pre-action listener: _resource_record_pre_action 13:08:22 INFO - Running main action method: run_tests 13:08:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:08:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:08:22 INFO - Python 2.7.3 13:08:22 INFO - Return code: 0 13:08:22 INFO - grabbing minidump binary from tooltool 13:08:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:08:22 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd62090>, '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 0xd659b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd65e40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:08:22 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 13:08:22 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 13:08:22 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 13:08:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:08:22 INFO - Return code: 0 13:08:22 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:08:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:08:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:08:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:08:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:08:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Larch-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DlBw0_GQQlGoZ0CEKBc1Og/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--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 13:08:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Larch-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DlBw0_GQQlGoZ0CEKBc1Og/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-017 --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 13:08:22 INFO - Using env: {'DISPLAY': ':0', 13:08:22 INFO - 'HOME': '/home/cltbld', 13:08:22 INFO - 'LANG': 'en_US.UTF-8', 13:08:22 INFO - 'LANGUAGE': 'en_US:en', 13:08:22 INFO - 'LOGNAME': 'cltbld', 13:08:22 INFO - 'MAIL': '/var/mail/cltbld', 13:08:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:08:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:08:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:08:22 INFO - 'MOZ_NO_REMOTE': '1', 13:08:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:08:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:08:22 INFO - 'NO_EM_RESTART': '1', 13:08:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:08:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:08:22 INFO - 'PWD': '/builds/slave/test', 13:08:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:08:22 INFO - 'SHELL': '/bin/bash', 13:08:22 INFO - 'SHLVL': '1', 13:08:22 INFO - 'TERM': 'linux', 13:08:22 INFO - 'TMOUT': '86400', 13:08:22 INFO - 'USER': 'cltbld', 13:08:22 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1471982846.641249-1898329975', 13:08:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:08:22 INFO - '_': '/tools/buildbot/bin/python'} 13:08:22 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Larch-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DlBw0_GQQlGoZ0CEKBc1Og/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--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 13:08:22 INFO - mozversion application_buildid: 20160823103647 13:08:22 INFO - mozversion application_changeset: 7214320961eda063ecef1be314c1c4da9b949dbe 13:08:22 INFO - mozversion application_display_name: Nightly 13:08:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:08:22 INFO - mozversion application_name: Firefox 13:08:22 INFO - mozversion application_remotingname: firefox 13:08:22 INFO - mozversion application_repository: https://hg.mozilla.org/projects/larch 13:08:22 INFO - mozversion application_vendor: Mozilla 13:08:22 INFO - mozversion application_version: 51.0a1 13:08:22 INFO - mozversion platform_buildid: 20160823103647 13:08:22 INFO - mozversion platform_changeset: 7214320961eda063ecef1be314c1c4da9b949dbe 13:08:22 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/larch 13:08:22 INFO - mozversion platform_version: 51.0a1 13:08:22 INFO - using testdate: 1471982902 13:08:22 INFO - actual date: 1471982902 13:08:22 INFO - starting webserver on 'localhost:55447' 13:08:22 INFO - SUITE-START | Running 2 tests 13:08:22 INFO - TEST-START | dromaeo_css 13:08:22 INFO - operating with platform_type : linux_ 13:08:22 INFO - Initialising browser for dromaeo_css test... 13:08:22 INFO - TEST-INFO | started process 22344 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6HZSk0/profile http://localhost:55447/getInfo.html) 13:08:27 INFO - PROCESS | 22344 | __metrics Screen width/height:1600/1200 13:08:27 INFO - PROCESS | 22344 | colorDepth:24 13:08:27 INFO - PROCESS | 22344 | Browser inner width/height: 1024/697 13:08:27 INFO - PROCESS | 22344 | __metrics 13:08:27 ERROR - PROCESS | 22344 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2993: TypeError: this.tabs is undefined 13:08:28 INFO - TEST-INFO | 22344: exit 0 13:08:28 INFO - Browser initialized. 13:08:28 INFO - Running cycle 1/1 for dromaeo_css test... 13:08:28 INFO - TEST-INFO | started process 22463 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6HZSk0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:08:41 INFO - PROCESS | 22463 | RSS: Main: 189562880 13:08:41 INFO - PROCESS | 22463 | 13:09:30 INFO - PROCESS | 22463 | 1471982970905 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] 13:11:43 INFO - PROCESS | 22463 | Cycle 1(1): loaded http://localhost:55447/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55447/tests/dromaeo/cssquery-ext.html) 13:11:44 INFO - PROCESS | 22463 | RSS: Main: 201510912 13:11:44 INFO - PROCESS | 22463 | 13:14:46 INFO - PROCESS | 22463 | Cycle 1(1): loaded http://localhost:55447/tests/dromaeo/cssquery-ext.html (next: http://localhost:55447/tests/dromaeo/cssquery-jquery.html) 13:14:47 INFO - PROCESS | 22463 | RSS: Main: 200794112 13:14:47 INFO - PROCESS | 22463 | 13:17:49 INFO - PROCESS | 22463 | Cycle 1(1): loaded http://localhost:55447/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55447/tests/dromaeo/cssquery-mootools.html) 13:17:50 INFO - PROCESS | 22463 | RSS: Main: 201359360 13:17:50 INFO - PROCESS | 22463 | 13:20:52 INFO - PROCESS | 22463 | Cycle 1(1): loaded http://localhost:55447/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55447/tests/dromaeo/cssquery-prototype.html) 13:20:52 INFO - PROCESS | 22463 | RSS: Main: 199004160 13:20:52 INFO - PROCESS | 22463 | 13:23:55 INFO - PROCESS | 22463 | Cycle 1(1): loaded http://localhost:55447/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55447/tests/dromaeo/cssquery-yui.html) 13:23:56 INFO - PROCESS | 22463 | RSS: Main: 201789440 13:23:56 INFO - PROCESS | 22463 | 13:26:58 INFO - PROCESS | 22463 | Cycle 1(1): loaded http://localhost:55447/tests/dromaeo/cssquery-yui.html (next: http://localhost:55447/tests/dromaeo/cssquery-dojo.html) 13:26:59 INFO - PROCESS | 22463 | RSS: Main: 202010624 13:26:59 INFO - PROCESS | 22463 | 13:26:59 INFO - PROCESS | 22463 | __start_tp_report 13:26:59 INFO - PROCESS | 22463 | _x_x_mozilla_page_load 13:26:59 INFO - PROCESS | 22463 | _x_x_mozilla_page_load_details 13:26:59 INFO - PROCESS | 22463 | |i|pagename|runs| 13:26:59 INFO - PROCESS | 22463 | |0;dojo.html;2588.7928965682745;2616.764491195792;2634.2492389668946;2638.208537438768;2638.4327369615553;4715.622750179986;4718.009218064202;4730.4559975602815;4769.141554520189;4771.832985845496;4737.976310118444;4749.097671442423;4760.500147484516;4779.307000484928;4787.760611969405;4380.583844534772;4430.49049359323;4469.486009108945;4476.060027394251;4515.435570553681;4251.8511852085185;4360.149770794696;4426.1811564860445;4432.069265454258;4449.021215332622;4461.531539188403;4466.620337271336;4485.3944717463055;4486.147631949919;4503.977480112579;4478.305862591304;4495.303227999665;4500.369948207253;4503.076869241798;4504.909901801946;4354.063876266586;4362;4381.430414046185;4430.955690443118;4455.376247325345;4842.4189097308545;4851.975740121276;4858.052679727454;4859.028194361142;4877.146499362598;5199;5203.19350500673;5212.58299336056;5215.426303106655;5218.530332270076;5104.106781313255;5153.175491921274;5156.278121063054;5208.140656791625;5226.346706661668;4846.200376937801;4863.076015557032;4865.70805751656;4871.098846713369;4873.074115917964;5325.4940780625775;5343.251944727741;5358.598105142052;5365.731713414391;5375.9462405376225;4991.50084991498;5023.723695196726;5042.9747851261245;5114.335136432314;5125.820596279113;5176.456472070378;5205.9219111713355;5209.739513024334;5211.739413029333;5211.739413029409;5016.774245158977;5170.586353091744;5175.534201921845;5177.767000484987;5187.0922588546855;4846.660733748674;4985.651004429655;5039.722815245197;5134.922976155361;5139.511746384088;4245.426867372927;4322.7190232634775;4326.6538676905775;4328.394024836525;4328.567143285646;3780.7542509736777;3796.981015094962;3819.388897776342;3830.2148059647707;3846.3268927937497;4330.458692663417;4429.446319210098;4432.933505997413;4474.6867719259335;4536.72779633223;5142.922856157161;5158.690478571298;5183.092958732207;5183.2743415921805;5185.948140518622;4508.0533088051225;4513.954860451354;4522;4524.09518096382;4528.139653465831;4526.321051842184;4539.909201815945;4575.519570445122;4634.814607415733;4640.744759038218;4888.853334399973;4923;4926.950730492649;4935.383077115361;4943.3573635427165;5127.2052831811125;5218.921716174336;5219.2953951216095;5227.320448341843;5233.947660523499;4846.369971903771;4940.333055037524;4940.481249468898;4949.851504454872;4952.5542701157065;5180.197069454241;5180.818671346485;5187.507186817246;5189.662671926313;5197.92203116946;5124.180131178993;5132.435432102391;5240.973795131;5253.159494480865;5254.3169387979315;5094.898102038012;5097.6941383517105;5108.10608143566;5108.463611320758;5117.2068329409;5079.136546786981;5101.387833460009;5103.260027296095;5116.462771408948;5116.565091967075;4853.39332583427;4903.166461701448;4924.778384972757;5015.824446144514;5018.272350509229;4903.215485522299;5011.599072074152;5018.548330650259;5065.746712664426;5146.382434107782;4988.625853060962;5017.598592112549;5018.4730603286125;5019.799208031784;5034.395872495177 13:26:59 INFO - PROCESS | 22463 | |1;ext.html;539.5629540072541;542.6201658838813;552.516548020482;574.9223854779606;582.6387639663404;34230;35005.47491787622;37702;37740.62259377409;37783.43324850129;37715.24569508615;38598.61401385985;38617.420738688874;38642.42036369457;38655;7320.670569824358;7483.550986940773;7497.775066747979;7505.0862030182225;7510.624468776567;7552.848943021137;7622.733204337849;7647.50291231071;7661.387089032892;7661.885071723901;7371.931069994875;7420.183779784246;7436;7451.664675089634;7463.888041679379;7581.317681408672;7639.503432276884;7640.426967977424;7649.6940122395035;7671.808204794869;7320.780376588711;7330.523515971445;7413.962930185368;7420.777376678709;7427.14587822402;35523.4671479928;35955;36004;36016.639833601854;36167.63832361669;2564.9358766030814;2694.4745774573967;2697.5953606958915;2720.1975417251956;3028.98832587804;24650.50698986028;25116.24651260447;25235.747642523707;25320.240392788244;25408.36479088019;3020.0486846643457;3037.8329191894436;3059.892903748358;3104.58088158098;3114.2214446388402;258207;259759.9999999981;259958;260132;260981;48680.5131948676;48840.26739598909;48919.26621100686;48945.51054489481;48977.51022489801;31738.365232695218;32747.345053098805;51149.744251278506;51150;51310.230346544835;12777.808332875014;13143.408546615425;13148.211107333591;13183.472661093641;13188.934055329853;9987.900120998842;10037.598496060076;10045.69862904114;10056.34633748804;10098.697039088838;17212.39756608513;17252.65494690099;17276.13619319029;17380;17506.824931750518;6634.568753031134;6643.269240383554;6687.76592819249;6809.557378770364;6882.518223724392;753.9181274870579;769.3114662377253;847.9830403391898;871.3421366868101;1028.3161697471248;27939;28007.859960700473;28312.8584357081;28340.291492712848;28575.857120714678;955.4983633592419;961.5288508630721;973.0512750068768;974.70758772368;1029.1098200056897;13713.657158571115;14220.715585688435;14466.349014294383;14518;14669.853301467063;368332;373072;373432;373598;374047;47614.76192619084;48324.758376207894;48345.75827120842;48374.516254837705;48425.75787121112;1174.929504229749;1184.2420850655587;1195.3306148556662;1205.6081773423673;1208.5649166300125;25419;26486.735132648428;27679.861600691867;27941.161765147077;28162.577561336188;41769.79115104405;41792;42045.78977105095;42102;42206.155876881676;323171;325815;326606;326784;326971;24724.505509890063;24774;25037.374065648506;25162;25178;39447;40298.798506008454;40409.59590404058;40988.90110988877;41159.38260926028;33150.502742459365;33673;34457.655423445445;35803.462948055276;36323;34164.31671366509;34201;34681.30637387289;34729.479057813645;34796.304073917876;31520.211994700316;32166.83916580402;32320.676793232706;35238.11904702403;35320.82339588286;29962.550561741155;30987.69012309848;32403.51394729128;32538.674613253563;32619;24742.628860567467;25256.74743252544;25324.240272791845;25419.491610168065;25533.872330638227 13:26:59 INFO - PROCESS | 22463 | |2;jquery.html;354.79953826088274;360.998195009025;361.11886995730424;364.8522348448879;380.53954714795094;15939.442119525818;17043.573910652223;17703.203355848986;17908.64182716345;17935.10324483777;15274.923625381858;15492.767608485881;16213.756793648105;16361.181940902938;16532.42136525222;4693.366395536602;4950.529699678525;4952.529509696591;4955.4548999610015;4959.479254678261;3665.1203711109274;4943.678660887049;5621.353544342392;5861.853453663672;5879.382664820197;5894.292684877821;5926.674032928208;5936.7328470218945;5936.940630593704;5972.372900845414;5667.631603945731;5770.567207459458;5793.942060579382;5810.680412577307;5811.941880581182;4959.603231741452;5059.266406371093;5080.695158290514;5090.490950904917;5092.668976516515;20868.686969695467;21234.5753084939;21264.36206913795;21312.14751409942;21497.785022149892;1864.8414884734814;1888.046536499073;1942.0483962858239;2153.676948457728;2364.6689463475127;13433.194008359433;13577.52478663242;13604.455821767118;13734.793978090336;13992;1785.3751187084417;1796.91015449227;1818.97271540927;1821.1440622907344;1823.3527097880326;65712.3428765711;66377.33622663759;66448.6677566614;66888.6655566724;67158.66420667914;9312.580933857857;9643.324967252365;9762.804743905082;9839;9841.55712992917;13007.544735934385;13009.154404963836;13022.153560018569;13058.08593398472;13098.148620339647;6758.797236082925;6894.172699276119;6896.137982752156;7190.568565886064;7209.963950180216;6577.736890524326;6614.173228346457;6766.763163289262;6800.795976120724;6818.4886133540185;5859.794907178229;5926.525877929756;5998.190244317048;6017.368176341509;6174.783882564088;1594.107299912053;1626.9267882945296;1673.7740405045406;1704.6420251747024;1783.8394544490798;757.7310054930531;828.3869936247133;850.2900078434576;979.0405402705388;980.3627642032736;16466.588335291475;16990.745138822927;17173.57066073358;17435.912820435817;17467;844.0841686769924;877.7410663854179;882.9823403531893;902.8961669407971;941.4492521874643;6379.521535884827;9443.858342124873;10020.799584008279;10153.88307286198;10155.949220253999;405113.4119576286;409201;413906;417577;418765;78937.60531197308;82864.58567707243;83267;83670;86568.56715716381;883.6642076011075;914.0767824497173;945.2863088368238;946.1626460582297;948.4025064209504;15288;15521.76717349218;15677.764833527734;15967.760483592987;16292.674146516767;36474;36624.45063323999;36634.45048324331;37212;38628.420573691976;50683.49316506788;50915;51229.23156152586;51332;51355.74322128366;7147.249538798559;7360.852782944204;7515.38419239866;7586.127595326608;7790.298873101448;10513.264071515227;11225.831612525983;11243.66269011931;11508.136889733136;12467.064970127096;7369.963150184215;9253.259739220981;9594.45746877064;9598.232141428529;10468.476576171008;9958;10150;10362.171026318027;10530;10694.251402401756;10364.222683298633;10366.326188797704;10825.621103261348;10855.728606784893;11129.944350278196;7235.167955685163;7421.443391745533;7482.738104166328;7514.511556748794;7686.769396918102;8706.390552661253;10009;10151.187904967437;10246.38521688701;10727.678169654922 13:26:59 INFO - PROCESS | 22463 | |3;mootools.html;1303.8370203724533;1351.3108314759472;1390.478570536049;1647.5057482755162;1655.759914812353;6827.385535301822;7301.123865136185;7323.63381830909;7971.561564113978;7977.800554986121;7459.515131516448;7747.961260193705;7759.379249660028;7783.221677832214;7791.454598178129;2049.4876280929766;2090.446031801574;2091.393495886191;2094.8847813370257;2095.968560471594;2071.326818783894;2087;2099.9475013124716;2141.325482473024;2147.4309308033385;2084.437201955471;2111.957760844782;2116.492041909946;2134.6264403729365;2161.5460753241837;2084.47888027993;2085.322270262171;2086.3010891351414;2088.3108574170487;2089.98955005224;2055.1162999910034;2102.873827570351;2122.0238690202527;2127.4681329667583;2132.936011919645;7704.845903081907;7873.566953817538;7874.921250787476;7878.4485086044;7890.2109789021215;4267.786610669454;4392.143532011259;4403.273459879116;4404.119176164748;4424.159409712144;2737.110439107298;2851.572264160372;2893.4502444535683;2909.3599408130176;2913.883444662211;890.2299510923006;933.4865823796885;936.2416442681382;943.3773709351794;946.2240962410826;10627.096696780784;10644.254902156852;10666.973275077788;10717.30337528066;10729.356238625707;3882.6117388261514;3909.902252443712;4110.979445102756;4119.97940010298;4128.60778226068;9001.414908030956;9116.635334586543;9131.497767622712;9138.268938485038;9163.679271225608;4451.043025749479;4451.755153466525;4499.4150760400935;4517.864464066083;4533.093381323749;3537.1157210697324;3914.2562913047;4043.433919251307;4086.9386959195635;4089.836406543705;3461.9307613848086;3501.3347463981763;3581.2479379330634;3585.982070089633;3635.94546081809;1168.3515648814819;1173.284296579086;1190.2917763930448;1193.0098018644503;1194.1879521925;731.8463122744176;736.62432159599;754.9433792465587;769.5152054205814;772.069656064441;4912.70523768575;5030.597552195815;5097.61767867404;5110.84785919784;5192.402873669576;380.90477380654835;381.9751716138442;383.61829979170346;386.95936926622863;392.05319154242756;3302.126641342369;3386.255023894739;3403.982980085084;3405.165734395089;3437;8702.30381569473;9082.318826087938;9094.772630684285;9105.863412048824;9686.32195746291;9251.583678734472;9277.768055798524;9292.349535532448;9297.442153470813;9349.39228950116;6965.860682786316;7024.894626580605;7030.296970303031;7042.190148133031;7043.859122817413;5110.824510362711;5139.408967968731;5219.582433405394;5289.814856480005;5337;8591.226789588967;8610.569471526524;8662.480251184697;8702.608382622671;8751.474911505331;8626.353023523387;8865.113488651341;8872.512011839412;8905;8929.419587727038;5728.684922329312;5753.769849205984;5862.091375836752;6313.873722525432;6426.485881129405;7101.147862256562;7149.142102947471;7154.499185057204;7156.642167891689;7185.604791736296;6338.334474880256;6452.161219041494;6473.676316184078;6704.698288577123;6734.6295953721055;6334.9366506334345;6361.8727625448155;6371.108044873628;6373.235211774617;6406.647634380154;5511.118221084607;5529.30883639545;5535.529479994246;5539.473749993906;5617.410171931889;4277.743335399886;4341.196878577473;4348.608625223745;4382.145481631179;4438.4451943507065;4335.132973405394;4455.26488129455;4479.0817882333395;4492.797824097989;4523.411956445641 13:26:59 INFO - PROCESS | 22463 | |4;prototype.html;284.2524161455372;290.45684569854376;293.19664120310347;300.5926968957063;303.30089144521895;4897.36334276544;4991.251312303157;5012;5014.470586471125;5032.84901452957;4898.363212782342;4898.853034408965;4902.6813257138265;4919.655624106314;4965.329680493132;3677.797721125337;3691.612380700028;3767.303048935942;3788.867389641363;3832.482614847002;3783.243351329745;3786.4131059685656;3793.2413517296513;3796.316663000659;3849.8845034648866;3733.2906747717984;3756.4928734620885;3780.6786423154067;3803.0526342084827;3804.334241507739;3587.121155316964;3770.4909837171904;3803.7527560708604;3816.2749077675153;3819.52255968004;3301.735861131128;3325.7671962962604;3337.3992681317354;3339.5157702133297;3367.848446819899;4828.73441960692;4877.8780530486665;4885.36490256268;4887.364642596475;4907.399078488407;4335.523092459827;4368.60682538573;4392.275274579691;4395.846145384929;4396.054848207651;5003.949170674163;5176.55999240065;5196.870078248074;5216.191490319006;5216.713080780555;3638;3639.326724555939;3650.3976843820737;3654.506641603376;3664.8534058637624;5512.503874651301;5512.7596290834645;5530.557555395559;5534.889302213933;5535.169724541311;3459.6367381425093;3643.3441980443245;3646.927061458756;3650.4889315495852;3755.361588529902;3703.185299234218;3730.2539492101687;3735.3836616958442;3735.533058367704;3738.420544815558;4298.656107511391;4310.978445107754;4325.718828276152;4339.175556644227;4339.7396156230725;5098.847034588968;5225.372955245395;5229.581633469314;5241.0042092002395;5247.685138891678;1276.5340650662442;1295.7019885426405;1303.2962200411862;1304.6738315421144;1309.1294289297512;807.604273905782;812.9105798362175;822.5928165558087;845.3490812074668;845.6955496021427;4400.515943246241;4472.249566516634;4619.284010978304;4622.6301895848255;4647.140279048387;5319.361676598833;5344;5364.275822763955;5378.462153784591;5393.622446428791;4534.795934182904;4621.514740952219;4633.907321853544;4638.350630911675;4654.604358629555;2786.275568352243;2847.5301575239855;2853.9012480195274;2853.957190642142;2866.498362786504;4999.950000499948;5021.723805190676;5040.747962601855;5048.29323894655;5059.747012649426;5195.2986346843445;5423.593230507728;5465.59008074396;5486.972565137149;5516.448355164452;5038.672486288379;5043.9747801260755;5050.444451110375;5071.873203169876;5091.312672789126;5340.572754179579;5383.757730902041;5407.972485227951;5409.513143817076;5413.215083812904;5032.835880571243;5186.688798672092;5234.633575649668;5307.708076055854;5320.680759154463;5010.949890501049;5030.220315851049;5060.645754797129;5101.158308878993;5105.2086926526445;3726.925461490809;3736.7757934524016;3740.850365985439;3741.8877433677035;3747.4566187903147;5221.347331583552;5341.919871201857;5362.865928351823;5412.323459567554;5440.483154100354;5191.584673226208;5193.143131383279;5216.347956505437;5228.398734145622;5264.341957255343;5216.608754343363;5246.08193566132;5253.816116435906;5254.65844720092;5261.7895284189735;4758.310045043519;5058.468860769566;5061.215511595708;5082.263071854634;5147.301390541187;4950.257461380822;5100.617453691062;5158.561522270649;5181.404138524118;5212.244224587489;5112.565431938327;5119.692818430906;5123.718195499283;5154.175331946871;5158.535731784157 13:26:59 INFO - PROCESS | 22463 | |5;yui.html;556.2546188107935;576.4091805898953;576.4293349583913;580.4746704232668;585.2976428286055;12122.151449398545;12144.574939877106;12581.1822231555;12635.684107897296;12635.747285054293;12273.693157671041;12348.197367171128;12390.25658460493;12403.379831008458;12416.937915310433;737.5427235114223;762.8626847167508;765.2768134113265;766.1534004924562;766.2567309709573;607.9483243924271;730.7186733107765;757.6628400361841;764.3846703403758;766.1916677904808;809.0938149272823;812.1431889356726;812.8049268175654;813.4631143445328;814.2102160903913;796.9880451793169;804.694216197844;805.524740403162;805.5569436809732;805.8912046873714;586.3842964886894;591.5711109445617;592.1354821959943;593.7090825495476;593.946544810969;10905.83641245382;10919.181061420426;10954.835677464844;11045.83431248532;11079.113670906308;13054.216746995211;13467.797983030263;13727.45090196401;13828.170309781344;14137.575872723835;10361;10372.858985511588;10426.113780328682;10471.895281047167;10623.575056997788;3113.077522321868;3155.7790954633183;3169.6037995250595;3183.0769076967654;3205.6634053424286;69174.65412672955;69920.85356158984;70192;70348;70399;10091;10175.694729158136;10248;10339.121174700234;10385.324953877975;20387;20463.8976805118;20528.28151014737;20737;20823.167073316898;5694.800681976111;6073.939260607426;6413.198350206224;6475.32009139043;6498.5126115541525;3548.8935331940083;3566.625504322061;3602.765820221677;3608.1520842601967;3663.2124093320062;2675.3712877473777;2744.917652470389;2767.750902418792;2769.2246171072134;2773.292810333352;478.4880178209283;479.63787340557656;481.67005601163316;487.7561219390305;498.40938487891964;415.7858702768077;468.5689165967318;496.4935765519222;505.97723102460475;516.1200153737868;7172.497925145294;7441.144268409094;7448.292412220831;7557.697692092364;7589.696412143563;422.3390394033389;429.1117387008862;446.46201327400405;466.9463011753624;484.22765688726423;3221.1430984376443;3399.2691571312284;3469.635688252697;3490.6683865032783;3515;76214;78009.21990780134;79942.60602636756;91669.54165229131;102028;78496;78792.6060369706;80141.59929200317;81570.18429815744;82774.17225827785;59702;67825.3217467819;70809;70845.64577177081;71543.6422817893;7692.961535192512;8665.783355416164;8861.60122794463;8864.822703545764;9070.727878163665;35550;38116.237675245786;40426.39360409537;40881.59118408778;41493.377599336636;60410;60674.69662651658;60988;61002;64022.3597764035;9874.802503950024;10193.490325483845;10248;10349.74125646865;10392.48037598102;11460.942809379401;11499.195056345976;11582.88417115818;11806.527738890349;11888;10351.63769268072;10492.108170805262;10622.150227981589;10779.137668986305;11418.0865530759;10954.233203675985;10956.616518421817;10964.232503724663;11061.446927653746;11457.651181507938;10618.84071738909;10939.56241750321;10951.83572246433;10997.285176463503;11035.72410689707;9248.491332976751;9394.778678771716;9473.47895865734;9901.356411833207;9902.929112773067;9646.9035309646;9715.319927605;10090.747731306483;10178.541965611714;10199.286049976727 13:26:59 INFO - PROCESS | 22463 | __end_tp_report 13:26:59 INFO - PROCESS | 22463 | __start_cc_report 13:26:59 INFO - PROCESS | 22463 | _x_x_mozilla_cycle_collect,389 13:26:59 INFO - PROCESS | 22463 | __end_cc_report 13:26:59 INFO - PROCESS | 22463 | __startTimestamp1471984019079__endTimestamp 13:26:59 INFO - PROCESS | 22463 | 13:26:59 INFO - PROCESS | 22463 | ------- Summary: start ------- 13:26:59 INFO - PROCESS | 22463 | Number of tests: 6 13:26:59 INFO - PROCESS | 22463 | 13:26:59 INFO - PROCESS | 22463 | [#0] dojo.html Cycles:165 Average:4779.11 Median:4924.78 stddev:520.04 (10.6%) stddev-sans-first:492.43 13:26:59 INFO - PROCESS | 22463 | Values: 2588.8 2616.8 2634.2 2638.2 2638.4 4715.6 4718.0 4730.5 4769.1 4771.8 4738.0 4749.1 4760.5 4779.3 4787.8 4380.6 4430.5 4469.5 4476.1 4515.4 4251.9 4360.1 4426.2 4432.1 4449.0 4461.5 4466.6 4485.4 4486.1 4504.0 4478.3 4495.3 4500.4 4503.1 4504.9 4354.1 4362.0 4381.4 4431.0 4455.4 4842.4 4852.0 4858.1 4859.0 4877.1 5199.0 5203.2 5212.6 5215.4 5218.5 5104.1 5153.2 5156.3 5208.1 5226.3 4846.2 4863.1 4865.7 4871.1 4873.1 5325.5 5343.3 5358.6 5365.7 5375.9 4991.5 5023.7 5043.0 5114.3 5125.8 5176.5 5205.9 5209.7 5211.7 5211.7 5016.8 5170.6 5175.5 5177.8 5187.1 4846.7 4985.7 5039.7 5134.9 5139.5 4245.4 4322.7 4326.7 4328.4 4328.6 3780.8 3797.0 3819.4 3830.2 3846.3 4330.5 4429.4 4432.9 4474.7 4536.7 5142.9 5158.7 5183.1 5183.3 5185.9 4508.1 4514.0 4522.0 4524.1 4528.1 4526.3 4539.9 4575.5 4634.8 4640.7 4888.9 4923.0 4927.0 4935.4 4943.4 5127.2 5218.9 5219.3 5227.3 5233.9 4846.4 4940.3 4940.5 4949.9 4952.6 5180.2 5180.8 5187.5 5189.7 5197.9 5124.2 5132.4 5241.0 5253.2 5254.3 5094.9 5097.7 5108.1 5108.5 5117.2 5079.1 5101.4 5103.3 5116.5 5116.6 4853.4 4903.2 4924.8 5015.8 5018.3 4903.2 5011.6 5018.5 5065.7 5146.4 4988.6 5017.6 5018.5 5019.8 5034.4 13:26:59 INFO - PROCESS | 22463 | 13:26:59 INFO - PROCESS | 22463 | [#1] ext.html Cycles:180 Average:46266.71 Median:35121.80 stddev:85001.48 (242.0%) stddev-sans-first:85170.59 13:26:59 INFO - PROCESS | 22463 | Values: 539.6 542.6 552.5 574.9 582.6 34230.0 35005.5 37702.0 37740.6 37783.4 37715.2 38598.6 38617.4 38642.4 38655.0 7320.7 7483.6 7497.8 7505.1 7510.6 7552.8 7622.7 7647.5 7661.4 7661.9 7371.9 7420.2 7436.0 7451.7 7463.9 7581.3 7639.5 7640.4 7649.7 7671.8 7320.8 7330.5 7414.0 7420.8 7427.1 35523.5 35955.0 36004.0 36016.6 36167.6 2564.9 2694.5 2697.6 2720.2 3029.0 24650.5 25116.2 25235.7 25320.2 25408.4 3020.0 3037.8 3059.9 3104.6 3114.2 258207.0 259760.0 259958.0 260132.0 260981.0 48680.5 48840.3 48919.3 48945.5 48977.5 31738.4 32747.3 51149.7 51150.0 51310.2 12777.8 13143.4 13148.2 13183.5 13188.9 9987.9 10037.6 10045.7 10056.3 10098.7 17212.4 17252.7 17276.1 17380.0 17506.8 6634.6 6643.3 6687.8 6809.6 6882.5 753.9 769.3 848.0 871.3 1028.3 27939.0 28007.9 28312.9 28340.3 28575.9 955.5 961.5 973.1 974.7 1029.1 13713.7 14220.7 14466.3 14518.0 14669.9 368332.0 373072.0 373432.0 373598.0 374047.0 47614.8 48324.8 48345.8 48374.5 48425.8 1174.9 1184.2 1195.3 1205.6 1208.6 25419.0 26486.7 27679.9 27941.2 28162.6 41769.8 41792.0 42045.8 42102.0 42206.2 323171.0 325815.0 326606.0 326784.0 326971.0 24724.5 24774.0 25037.4 25162.0 25178.0 39447.0 40298.8 40409.6 40988.9 41159.4 33150.5 33673.0 34457.7 35803.5 36323.0 34164.3 34201.0 34681.3 34729.5 34796.3 31520.2 32166.8 32320.7 35238.1 35320.8 29962.6 30987.7 32403.5 32538.7 32619.0 24742.6 25256.7 25324.2 25419.5 25533.9 13:26:59 INFO - PROCESS | 22463 | 13:26:59 INFO - PROCESS | 22463 | [#2] jquery.html Cycles:180 Average:25151.65 Median:4951.53 stddev:68113.68 (1375.6%) stddev-sans-first:68279.31 13:26:59 INFO - PROCESS | 22463 | Values: 354.8 361.0 361.1 364.9 380.5 15939.4 17043.6 17703.2 17908.6 17935.1 15274.9 15492.8 16213.8 16361.2 16532.4 4693.4 4950.5 4952.5 4955.5 4959.5 3665.1 4943.7 5621.4 5861.9 5879.4 5894.3 5926.7 5936.7 5936.9 5972.4 5667.6 5770.6 5793.9 5810.7 5811.9 4959.6 5059.3 5080.7 5090.5 5092.7 20868.7 21234.6 21264.4 21312.1 21497.8 1864.8 1888.0 1942.0 2153.7 2364.7 13433.2 13577.5 13604.5 13734.8 13992.0 1785.4 1796.9 1819.0 1821.1 1823.4 65712.3 66377.3 66448.7 66888.7 67158.7 9312.6 9643.3 9762.8 9839.0 9841.6 13007.5 13009.2 13022.2 13058.1 13098.1 6758.8 6894.2 6896.1 7190.6 7210.0 6577.7 6614.2 6766.8 6800.8 6818.5 5859.8 5926.5 5998.2 6017.4 6174.8 1594.1 1626.9 1673.8 1704.6 1783.8 757.7 828.4 850.3 979.0 980.4 16466.6 16990.7 17173.6 17435.9 17467.0 844.1 877.7 883.0 902.9 941.4 6379.5 9443.9 10020.8 10153.9 10155.9 405113.4 409201.0 413906.0 417577.0 418765.0 78937.6 82864.6 83267.0 83670.0 86568.6 883.7 914.1 945.3 946.2 948.4 15288.0 15521.8 15677.8 15967.8 16292.7 36474.0 36624.5 36634.5 37212.0 38628.4 50683.5 50915.0 51229.2 51332.0 51355.7 7147.2 7360.9 7515.4 7586.1 7790.3 10513.3 11225.8 11243.7 11508.1 12467.1 7370.0 9253.3 9594.5 9598.2 10468.5 9958.0 10150.0 10362.2 10530.0 10694.3 10364.2 10366.3 10825.6 10855.7 11129.9 7235.2 7421.4 7482.7 7514.5 7686.8 8706.4 10009.0 10151.2 10246.4 10727.7 13:26:59 INFO - PROCESS | 22463 | 13:26:59 INFO - PROCESS | 22463 | [#3] mootools.html Cycles:180 Average:4954.62 Median:4971.65 stddev:2830.62 (56.9%) stddev-sans-first:2825.27 13:26:59 INFO - PROCESS | 22463 | Values: 1303.8 1351.3 1390.5 1647.5 1655.8 6827.4 7301.1 7323.6 7971.6 7977.8 7459.5 7748.0 7759.4 7783.2 7791.5 2049.5 2090.4 2091.4 2094.9 2096.0 2071.3 2087.0 2099.9 2141.3 2147.4 2084.4 2112.0 2116.5 2134.6 2161.5 2084.5 2085.3 2086.3 2088.3 2090.0 2055.1 2102.9 2122.0 2127.5 2132.9 7704.8 7873.6 7874.9 7878.4 7890.2 4267.8 4392.1 4403.3 4404.1 4424.2 2737.1 2851.6 2893.5 2909.4 2913.9 890.2 933.5 936.2 943.4 946.2 10627.1 10644.3 10667.0 10717.3 10729.4 3882.6 3909.9 4111.0 4120.0 4128.6 9001.4 9116.6 9131.5 9138.3 9163.7 4451.0 4451.8 4499.4 4517.9 4533.1 3537.1 3914.3 4043.4 4086.9 4089.8 3461.9 3501.3 3581.2 3586.0 3635.9 1168.4 1173.3 1190.3 1193.0 1194.2 731.8 736.6 754.9 769.5 772.1 4912.7 5030.6 5097.6 5110.8 5192.4 380.9 382.0 383.6 387.0 392.1 3302.1 3386.3 3404.0 3405.2 3437.0 8702.3 9082.3 9094.8 9105.9 9686.3 9251.6 9277.8 9292.3 9297.4 9349.4 6965.9 7024.9 7030.3 7042.2 7043.9 5110.8 5139.4 5219.6 5289.8 5337.0 8591.2 8610.6 8662.5 8702.6 8751.5 8626.4 8865.1 8872.5 8905.0 8929.4 5728.7 5753.8 5862.1 6313.9 6426.5 7101.1 7149.1 7154.5 7156.6 7185.6 6338.3 6452.2 6473.7 6704.7 6734.6 6334.9 6361.9 6371.1 6373.2 6406.6 5511.1 5529.3 5535.5 5539.5 5617.4 4277.7 4341.2 4348.6 4382.1 4438.4 4335.1 4455.3 4479.1 4492.8 4523.4 13:26:59 INFO - PROCESS | 22463 | 13:26:59 INFO - PROCESS | 22463 | [#4] prototype.html Cycles:180 Average:4294.94 Median:4934.96 stddev:1274.92 (25.8%) stddev-sans-first:1242.45 13:26:59 INFO - PROCESS | 22463 | Values: 284.3 290.5 293.2 300.6 303.3 4897.4 4991.3 5012.0 5014.5 5032.8 4898.4 4898.9 4902.7 4919.7 4965.3 3677.8 3691.6 3767.3 3788.9 3832.5 3783.2 3786.4 3793.2 3796.3 3849.9 3733.3 3756.5 3780.7 3803.1 3804.3 3587.1 3770.5 3803.8 3816.3 3819.5 3301.7 3325.8 3337.4 3339.5 3367.8 4828.7 4877.9 4885.4 4887.4 4907.4 4335.5 4368.6 4392.3 4395.8 4396.1 5003.9 5176.6 5196.9 5216.2 5216.7 3638.0 3639.3 3650.4 3654.5 3664.9 5512.5 5512.8 5530.6 5534.9 5535.2 3459.6 3643.3 3646.9 3650.5 3755.4 3703.2 3730.3 3735.4 3735.5 3738.4 4298.7 4311.0 4325.7 4339.2 4339.7 5098.8 5225.4 5229.6 5241.0 5247.7 1276.5 1295.7 1303.3 1304.7 1309.1 807.6 812.9 822.6 845.3 845.7 4400.5 4472.2 4619.3 4622.6 4647.1 5319.4 5344.0 5364.3 5378.5 5393.6 4534.8 4621.5 4633.9 4638.4 4654.6 2786.3 2847.5 2853.9 2854.0 2866.5 5000.0 5021.7 5040.7 5048.3 5059.7 5195.3 5423.6 5465.6 5487.0 5516.4 5038.7 5044.0 5050.4 5071.9 5091.3 5340.6 5383.8 5408.0 5409.5 5413.2 5032.8 5186.7 5234.6 5307.7 5320.7 5010.9 5030.2 5060.6 5101.2 5105.2 3726.9 3736.8 3740.9 3741.9 3747.5 5221.3 5341.9 5362.9 5412.3 5440.5 5191.6 5193.1 5216.3 5228.4 5264.3 5216.6 5246.1 5253.8 5254.7 5261.8 4758.3 5058.5 5061.2 5082.3 5147.3 4950.3 5100.6 5158.6 5181.4 5212.2 5112.6 5119.7 5123.7 5154.2 5158.5 13:26:59 INFO - PROCESS | 22463 | 13:26:59 INFO - PROCESS | 22463 | [#5] yui.html Cycles:180 Average:16959.43 Median:437.79 stddev:24027.35 (5488.4%) stddev-sans-first:24063.18 13:26:59 INFO - PROCESS | 22463 | Values: 556.3 576.4 576.4 580.5 585.3 12122.2 12144.6 12581.2 12635.7 12635.7 12273.7 12348.2 12390.3 12403.4 12416.9 737.5 762.9 765.3 766.2 766.3 607.9 730.7 757.7 764.4 766.2 809.1 812.1 812.8 813.5 814.2 797.0 804.7 805.5 805.6 805.9 586.4 591.6 592.1 593.7 593.9 10905.8 10919.2 10954.8 11045.8 11079.1 13054.2 13467.8 13727.5 13828.2 14137.6 10361.0 10372.9 10426.1 10471.9 10623.6 3113.1 3155.8 3169.6 3183.1 3205.7 69174.7 69920.9 70192.0 70348.0 70399.0 10091.0 10175.7 10248.0 10339.1 10385.3 20387.0 20463.9 20528.3 20737.0 20823.2 5694.8 6073.9 6413.2 6475.3 6498.5 3548.9 3566.6 3602.8 3608.2 3663.2 2675.4 2744.9 2767.8 2769.2 2773.3 478.5 479.6 481.7 487.8 498.4 415.8 468.6 496.5 506.0 516.1 7172.5 7441.1 7448.3 7557.7 7589.7 422.3 429.1 446.5 466.9 484.2 3221.1 3399.3 3469.6 3490.7 3515.0 76214.0 78009.2 79942.6 91669.5 102028.0 78496.0 78792.6 80141.6 81570.2 82774.2 59702.0 67825.3 70809.0 70845.6 71543.6 7693.0 8665.8 8861.6 8864.8 9070.7 35550.0 38116.2 40426.4 40881.6 41493.4 60410.0 60674.7 60988.0 61002.0 64022.4 9874.8 10193.5 10248.0 10349.7 10392.5 11460.9 11499.2 11582.9 11806.5 11888.0 10351.6 10492.1 10622.2 10779.1 11418.1 10954.2 10956.6 10964.2 11061.4 11457.7 10618.8 10939.6 10951.8 10997.3 11035.7 9248.5 9394.8 9473.5 9901.4 9902.9 9646.9 9715.3 10090.7 10178.5 10199.3 13:26:59 INFO - PROCESS | 22463 | -------- Summary: end -------- 13:26:59 INFO - PROCESS | 22463 | 13:27:00 INFO - TEST-INFO | 22463: exit 0 13:27:00 INFO - TEST-OK | dromaeo_css | took 1117678ms 13:27:00 INFO - TEST-START | kraken 13:27:00 INFO - operating with platform_type : linux_ 13:27:00 INFO - Initialising browser for kraken test... 13:27:00 INFO - TEST-INFO | started process 22821 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoq3xam/profile http://localhost:55447/getInfo.html) 13:27:05 INFO - PROCESS | 22821 | __metrics Screen width/height:1600/1200 13:27:05 INFO - PROCESS | 22821 | colorDepth:24 13:27:05 INFO - PROCESS | 22821 | Browser inner width/height: 1024/697 13:27:05 INFO - PROCESS | 22821 | __metrics 13:27:05 ERROR - PROCESS | 22821 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2993: TypeError: this.tabs is undefined 13:27:06 INFO - TEST-INFO | 22821: exit 0 13:27:06 INFO - Browser initialized. 13:27:06 INFO - Running cycle 1/1 for kraken test... 13:27:06 INFO - TEST-INFO | started process 22945 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoq3xam/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:27:18 INFO - PROCESS | 22945 | RSS: Main: 190230528 13:27:18 INFO - PROCESS | 22945 | 13:27:21 INFO - PROCESS | 22945 | Cycle 1(1): loaded http://localhost:55447/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55447/tests/kraken/driver.html?testName=audio-beat-detection) 13:27:22 INFO - PROCESS | 22945 | RSS: Main: 202801152 13:27:22 INFO - PROCESS | 22945 | 13:27:25 INFO - PROCESS | 22945 | Cycle 1(1): loaded http://localhost:55447/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55447/tests/kraken/driver.html?testName=audio-dft) 13:27:26 INFO - PROCESS | 22945 | RSS: Main: 201818112 13:27:26 INFO - PROCESS | 22945 | 13:27:29 INFO - PROCESS | 22945 | Cycle 1(1): loaded http://localhost:55447/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55447/tests/kraken/driver.html?testName=audio-fft) 13:27:29 INFO - PROCESS | 22945 | RSS: Main: 198430720 13:27:29 INFO - PROCESS | 22945 | 13:27:31 INFO - PROCESS | 22945 | Cycle 1(1): loaded http://localhost:55447/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55447/tests/kraken/driver.html?testName=audio-oscillator) 13:27:32 INFO - PROCESS | 22945 | RSS: Main: 198479872 13:27:32 INFO - PROCESS | 22945 | 13:27:34 INFO - PROCESS | 22945 | Cycle 1(1): loaded http://localhost:55447/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55447/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:27:35 INFO - PROCESS | 22945 | RSS: Main: 198684672 13:27:35 INFO - PROCESS | 22945 | 13:27:38 INFO - PROCESS | 22945 | Cycle 1(1): loaded http://localhost:55447/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55447/tests/kraken/driver.html?testName=imaging-darkroom) 13:27:39 INFO - PROCESS | 22945 | RSS: Main: 199196672 13:27:39 INFO - PROCESS | 22945 | 13:27:42 INFO - PROCESS | 22945 | Cycle 1(1): loaded http://localhost:55447/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55447/tests/kraken/driver.html?testName=imaging-desaturate) 13:27:43 INFO - PROCESS | 22945 | RSS: Main: 196988928 13:27:43 INFO - PROCESS | 22945 | 13:27:46 INFO - PROCESS | 22945 | Cycle 1(1): loaded http://localhost:55447/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55447/tests/kraken/driver.html?testName=json-parse-financial) 13:27:47 INFO - PROCESS | 22945 | RSS: Main: 197832704 13:27:47 INFO - PROCESS | 22945 | 13:27:48 INFO - PROCESS | 22945 | Cycle 1(1): loaded http://localhost:55447/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55447/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:27:49 INFO - PROCESS | 22945 | RSS: Main: 197955584 13:27:49 INFO - PROCESS | 22945 | 13:27:51 INFO - PROCESS | 22945 | Cycle 1(1): loaded http://localhost:55447/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55447/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:27:52 INFO - PROCESS | 22945 | RSS: Main: 198602752 13:27:52 INFO - PROCESS | 22945 | 13:27:54 INFO - PROCESS | 22945 | Cycle 1(1): loaded http://localhost:55447/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55447/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:27:55 INFO - PROCESS | 22945 | RSS: Main: 199098368 13:27:55 INFO - PROCESS | 22945 | 13:27:58 INFO - PROCESS | 22945 | Cycle 1(1): loaded http://localhost:55447/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55447/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:27:58 INFO - PROCESS | 22945 | RSS: Main: 199614464 13:27:58 INFO - PROCESS | 22945 | 13:28:01 INFO - PROCESS | 22945 | Cycle 1(1): loaded http://localhost:55447/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55447/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:28:02 INFO - PROCESS | 22945 | RSS: Main: 199192576 13:28:02 INFO - PROCESS | 22945 | 13:28:04 INFO - PROCESS | 22945 | Cycle 1(1): loaded http://localhost:55447/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55447/tests/kraken/driver.html?testName=ai-astar) 13:28:04 INFO - PROCESS | 22945 | RSS: Main: 202186752 13:28:04 INFO - PROCESS | 22945 | 13:28:04 INFO - PROCESS | 22945 | __start_tp_report 13:28:04 INFO - PROCESS | 22945 | _x_x_mozilla_page_load 13:28:04 INFO - PROCESS | 22945 | _x_x_mozilla_page_load_details 13:28:04 INFO - PROCESS | 22945 | |i|pagename|runs| 13:28:04 INFO - PROCESS | 22945 | |0;ai-astar;110;118;114;117;116;118;124;116;117;116 13:28:04 INFO - PROCESS | 22945 | |1;audio-beat-detection;155;125;155;193;129;152;152;125;196;125 13:28:04 INFO - PROCESS | 22945 | |2;audio-dft;180;165;165;174;163;170;165;167;167;165 13:28:04 INFO - PROCESS | 22945 | |3;audio-fft;78;79;80;175;80;79;76;79;162;78 13:28:04 INFO - PROCESS | 22945 | |4;audio-oscillator;88;88;142;90;89;88;133;88;89;131 13:28:04 INFO - PROCESS | 22945 | |5;imaging-gaussian-blur;120;120;123;119;119;118;120;118;118;118 13:28:04 INFO - PROCESS | 22945 | |6;imaging-darkroom;147;147;151;149;148;151;149;149;149;149 13:28:04 INFO - PROCESS | 22945 | |7;imaging-desaturate;97;97;96;96;96;96;97;96;96;96 13:28:04 INFO - PROCESS | 22945 | |8;json-parse-financial;65;67;68;67;67;66;69;68;68;65 13:28:04 INFO - PROCESS | 22945 | |9;json-stringify-tinderbox;65;70;70;69;67;66;66;66;66;73 13:28:04 INFO - PROCESS | 22945 | |10;stanford-crypto-aes;85;84;85;85;84;85;89;86;84;85 13:28:04 INFO - PROCESS | 22945 | |11;stanford-crypto-ccm;146;138;138;144;149;143;141;146;157;149 13:28:04 INFO - PROCESS | 22945 | |12;stanford-crypto-pbkdf2;180;179;179;173;175;175;175;178;173;173 13:28:04 INFO - PROCESS | 22945 | |13;stanford-crypto-sha256-iterative;69;73;71;72;74;74;71;72;76;75 13:28:04 INFO - PROCESS | 22945 | __end_tp_report 13:28:04 INFO - PROCESS | 22945 | __start_cc_report 13:28:04 INFO - PROCESS | 22945 | _x_x_mozilla_cycle_collect,1003 13:28:04 INFO - PROCESS | 22945 | __end_cc_report 13:28:04 INFO - PROCESS | 22945 | __startTimestamp1471984084390__endTimestamp 13:28:04 INFO - PROCESS | 22945 | 13:28:04 INFO - PROCESS | 22945 | ------- Summary: start ------- 13:28:04 INFO - PROCESS | 22945 | Number of tests: 14 13:28:04 INFO - PROCESS | 22945 | 13:28:04 INFO - PROCESS | 22945 | [#0] ai-astar Cycles:10 Average:116.60 Median:117.00 stddev:3.50 (3.0%) stddev-sans-first:2.78 13:28:04 INFO - PROCESS | 22945 | Values: 110.0 118.0 114.0 117.0 116.0 118.0 124.0 116.0 117.0 116.0 13:28:04 INFO - PROCESS | 22945 | 13:28:04 INFO - PROCESS | 22945 | [#1] audio-beat-detection Cycles:10 Average:150.70 Median:153.50 stddev:26.53 (17.3%) stddev-sans-first:28.09 13:28:04 INFO - PROCESS | 22945 | Values: 155.0 125.0 155.0 193.0 129.0 152.0 152.0 125.0 196.0 125.0 13:28:04 INFO - PROCESS | 22945 | 13:28:04 INFO - PROCESS | 22945 | [#2] audio-dft Cycles:10 Average:168.10 Median:167.00 stddev:5.24 (3.1%) stddev-sans-first:3.35 13:28:04 INFO - PROCESS | 22945 | Values: 180.0 165.0 165.0 174.0 163.0 170.0 165.0 167.0 167.0 165.0 13:28:04 INFO - PROCESS | 22945 | 13:28:04 INFO - PROCESS | 22945 | [#3] audio-fft Cycles:10 Average:96.60 Median:79.00 stddev:38.04 (48.1%) stddev-sans-first:39.74 13:28:04 INFO - PROCESS | 22945 | Values: 78.0 79.0 80.0 175.0 80.0 79.0 76.0 79.0 162.0 78.0 13:28:04 INFO - PROCESS | 22945 | 13:28:04 INFO - PROCESS | 22945 | [#4] audio-oscillator Cycles:10 Average:102.60 Median:88.00 stddev:22.77 (25.9%) stddev-sans-first:23.53 13:28:04 INFO - PROCESS | 22945 | Values: 88.0 88.0 142.0 90.0 89.0 88.0 133.0 88.0 89.0 131.0 13:28:04 INFO - PROCESS | 22945 | 13:28:04 INFO - PROCESS | 22945 | [#5] imaging-gaussian-blur Cycles:10 Average:119.30 Median:119.50 stddev:1.57 (1.3%) stddev-sans-first:1.64 13:28:04 INFO - PROCESS | 22945 | Values: 120.0 120.0 123.0 119.0 119.0 118.0 120.0 118.0 118.0 118.0 13:28:04 INFO - PROCESS | 22945 | 13:28:04 INFO - PROCESS | 22945 | [#6] imaging-darkroom Cycles:10 Average:148.90 Median:149.00 stddev:1.37 (0.9%) stddev-sans-first:1.27 13:28:04 INFO - PROCESS | 22945 | Values: 147.0 147.0 151.0 149.0 148.0 151.0 149.0 149.0 149.0 149.0 13:28:04 INFO - PROCESS | 22945 | 13:28:04 INFO - PROCESS | 22945 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 13:28:04 INFO - PROCESS | 22945 | Values: 97.0 97.0 96.0 96.0 96.0 96.0 97.0 96.0 96.0 96.0 13:28:04 INFO - PROCESS | 22945 | 13:28:04 INFO - PROCESS | 22945 | [#8] json-parse-financial Cycles:10 Average:67.00 Median:67.50 stddev:1.33 (2.0%) stddev-sans-first:1.20 13:28:04 INFO - PROCESS | 22945 | Values: 65.0 67.0 68.0 67.0 67.0 66.0 69.0 68.0 68.0 65.0 13:28:04 INFO - PROCESS | 22945 | 13:28:04 INFO - PROCESS | 22945 | [#9] json-stringify-tinderbox Cycles:10 Average:67.80 Median:68.00 stddev:2.57 (3.8%) stddev-sans-first:2.52 13:28:04 INFO - PROCESS | 22945 | Values: 65.0 70.0 70.0 69.0 67.0 66.0 66.0 66.0 66.0 73.0 13:28:04 INFO - PROCESS | 22945 | 13:28:04 INFO - PROCESS | 22945 | [#10] stanford-crypto-aes Cycles:10 Average:85.20 Median:85.00 stddev:1.48 (1.7%) stddev-sans-first:1.56 13:28:04 INFO - PROCESS | 22945 | Values: 85.0 84.0 85.0 85.0 84.0 85.0 89.0 86.0 84.0 85.0 13:28:04 INFO - PROCESS | 22945 | 13:28:04 INFO - PROCESS | 22945 | [#11] stanford-crypto-ccm Cycles:10 Average:145.10 Median:146.00 stddev:5.74 (3.9%) stddev-sans-first:6.08 13:28:04 INFO - PROCESS | 22945 | Values: 146.0 138.0 138.0 144.0 149.0 143.0 141.0 146.0 157.0 149.0 13:28:04 INFO - PROCESS | 22945 | 13:28:04 INFO - PROCESS | 22945 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.00 Median:176.50 stddev:2.75 (1.6%) stddev-sans-first:2.51 13:28:04 INFO - PROCESS | 22945 | Values: 180.0 179.0 179.0 173.0 175.0 175.0 175.0 178.0 173.0 173.0 13:28:04 INFO - PROCESS | 22945 | 13:28:04 INFO - PROCESS | 22945 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.70 Median:73.50 stddev:2.11 (2.9%) stddev-sans-first:1.76 13:28:04 INFO - PROCESS | 22945 | Values: 69.0 73.0 71.0 72.0 74.0 74.0 71.0 72.0 76.0 75.0 13:28:04 INFO - PROCESS | 22945 | -------- Summary: end -------- 13:28:04 INFO - PROCESS | 22945 | 13:28:05 INFO - TEST-INFO | 22945: exit 0 13:28:05 INFO - TEST-OK | kraken | took 65411ms 13:28:05 INFO - SUITE-END | took 1183s 13:28:06 INFO - Completed test suite (00:19:43) 13:28:06 INFO - javascript benchmark 13:28:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6294.913785763251, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2588.7928965682745, 2616.764491195792, 2634.2492389668946, 2638.208537438768, 2638.4327369615553, 4715.622750179986, 4718.009218064202, 4730.4559975602815, 4769.141554520189, 4771.832985845496, 4737.976310118444, 4749.097671442423, 4760.500147484516, 4779.307000484928, 4787.760611969405, 4380.583844534772, 4430.49049359323, 4469.486009108945, 4476.060027394251, 4515.435570553681, 4251.8511852085185, 4360.149770794696, 4426.1811564860445, 4432.069265454258, 4449.021215332622, 4461.531539188403, 4466.620337271336, 4485.3944717463055, 4486.147631949919, 4503.977480112579, 4478.305862591304, 4495.303227999665, 4500.369948207253, 4503.076869241798, 4504.909901801946, 4354.063876266586, 4362.0, 4381.430414046185, 4430.955690443118, 4455.376247325345, 4842.4189097308545, 4851.975740121276, 4858.052679727454, 4859.028194361142, 4877.146499362598, 5199.0, 5203.19350500673, 5212.58299336056, 5215.426303106655, 5218.530332270076, 5104.106781313255, 5153.175491921274, 5156.278121063054, 5208.140656791625, 5226.346706661668, 4846.200376937801, 4863.076015557032, 4865.70805751656, 4871.098846713369, 4873.074115917964, 5325.4940780625775, 5343.251944727741, 5358.598105142052, 5365.731713414391, 5375.9462405376225, 4991.50084991498, 5023.723695196726, 5042.9747851261245, 5114.335136432314, 5125.820596279113, 5176.456472070378, 5205.9219111713355, 5209.739513024334, 5211.739413029333, 5211.739413029409, 5016.774245158977, 5170.586353091744, 5175.534201921845, 5177.767000484987, 5187.0922588546855, 4846.660733748674, 4985.651004429655, 5039.722815245197, 5134.922976155361, 5139.511746384088, 4245.426867372927, 4322.7190232634775, 4326.6538676905775, 4328.394024836525, 4328.567143285646, 3780.7542509736777, 3796.981015094962, 3819.388897776342, 3830.2148059647707, 3846.3268927937497, 4330.458692663417, 4429.446319210098, 4432.933505997413, 4474.6867719259335, 4536.72779633223, 5142.922856157161, 5158.690478571298, 5183.092958732207, 5183.2743415921805, 5185.948140518622, 4508.0533088051225, 4513.954860451354, 4522.0, 4524.09518096382, 4528.139653465831, 4526.321051842184, 4539.909201815945, 4575.519570445122, 4634.814607415733, 4640.744759038218, 4888.853334399973, 4923.0, 4926.950730492649, 4935.383077115361, 4943.3573635427165, 5127.2052831811125, 5218.921716174336, 5219.2953951216095, 5227.320448341843, 5233.947660523499, 4846.369971903771, 4940.333055037524, 4940.481249468898, 4949.851504454872, 4952.5542701157065, 5180.197069454241, 5180.818671346485, 5187.507186817246, 5189.662671926313, 5197.92203116946, 5124.180131178993, 5132.435432102391, 5240.973795131, 5253.159494480865, 5254.3169387979315, 5094.898102038012, 5097.6941383517105, 5108.10608143566, 5108.463611320758, 5117.2068329409, 5079.136546786981, 5101.387833460009, 5103.260027296095, 5116.462771408948, 5116.565091967075, 4853.39332583427, 4903.166461701448, 4924.778384972757, 5015.824446144514, 5018.272350509229, 4903.215485522299, 5011.599072074152, 5018.548330650259, 5065.746712664426, 5146.382434107782, 4988.625853060962, 5017.598592112549, 5018.4730603286125, 5019.799208031784, 5034.395872495177], "value": 4744.234151843811, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [539.5629540072541, 542.6201658838813, 552.516548020482, 574.9223854779606, 582.6387639663404, 34230.0, 35005.47491787622, 37702.0, 37740.62259377409, 37783.43324850129, 37715.24569508615, 38598.61401385985, 38617.420738688874, 38642.42036369457, 38655.0, 7320.670569824358, 7483.550986940773, 7497.775066747979, 7505.0862030182225, 7510.624468776567, 7552.848943021137, 7622.733204337849, 7647.50291231071, 7661.387089032892, 7661.885071723901, 7371.931069994875, 7420.183779784246, 7436.0, 7451.664675089634, 7463.888041679379, 7581.317681408672, 7639.503432276884, 7640.426967977424, 7649.6940122395035, 7671.808204794869, 7320.780376588711, 7330.523515971445, 7413.962930185368, 7420.777376678709, 7427.14587822402, 35523.4671479928, 35955.0, 36004.0, 36016.639833601854, 36167.63832361669, 2564.9358766030814, 2694.4745774573967, 2697.5953606958915, 2720.1975417251956, 3028.98832587804, 24650.50698986028, 25116.24651260447, 25235.747642523707, 25320.240392788244, 25408.36479088019, 3020.0486846643457, 3037.8329191894436, 3059.892903748358, 3104.58088158098, 3114.2214446388402, 258207.0, 259759.9999999981, 259958.0, 260132.0, 260981.0, 48680.5131948676, 48840.26739598909, 48919.26621100686, 48945.51054489481, 48977.51022489801, 31738.365232695218, 32747.345053098805, 51149.744251278506, 51150.0, 51310.230346544835, 12777.808332875014, 13143.408546615425, 13148.211107333591, 13183.472661093641, 13188.934055329853, 9987.900120998842, 10037.598496060076, 10045.69862904114, 10056.34633748804, 10098.697039088838, 17212.39756608513, 17252.65494690099, 17276.13619319029, 17380.0, 17506.824931750518, 6634.568753031134, 6643.269240383554, 6687.76592819249, 6809.557378770364, 6882.518223724392, 753.9181274870579, 769.3114662377253, 847.9830403391898, 871.3421366868101, 1028.3161697471248, 27939.0, 28007.859960700473, 28312.8584357081, 28340.291492712848, 28575.857120714678, 955.4983633592419, 961.5288508630721, 973.0512750068768, 974.70758772368, 1029.1098200056897, 13713.657158571115, 14220.715585688435, 14466.349014294383, 14518.0, 14669.853301467063, 368332.0, 373072.0, 373432.0, 373598.0, 374047.0, 47614.76192619084, 48324.758376207894, 48345.75827120842, 48374.516254837705, 48425.75787121112, 1174.929504229749, 1184.2420850655587, 1195.3306148556662, 1205.6081773423673, 1208.5649166300125, 25419.0, 26486.735132648428, 27679.861600691867, 27941.161765147077, 28162.577561336188, 41769.79115104405, 41792.0, 42045.78977105095, 42102.0, 42206.155876881676, 323171.0, 325815.0, 326606.0, 326784.0, 326971.0, 24724.505509890063, 24774.0, 25037.374065648506, 25162.0, 25178.0, 39447.0, 40298.798506008454, 40409.59590404058, 40988.90110988877, 41159.38260926028, 33150.502742459365, 33673.0, 34457.655423445445, 35803.462948055276, 36323.0, 34164.31671366509, 34201.0, 34681.30637387289, 34729.479057813645, 34796.304073917876, 31520.211994700316, 32166.83916580402, 32320.676793232706, 35238.11904702403, 35320.82339588286, 29962.550561741155, 30987.69012309848, 32403.51394729128, 32538.674613253563, 32619.0, 24742.628860567467, 25256.74743252544, 25324.240272791845, 25419.491610168065, 25533.872330638227], "value": 16704.38377833877, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [354.79953826088274, 360.998195009025, 361.11886995730424, 364.8522348448879, 380.53954714795094, 15939.442119525818, 17043.573910652223, 17703.203355848986, 17908.64182716345, 17935.10324483777, 15274.923625381858, 15492.767608485881, 16213.756793648105, 16361.181940902938, 16532.42136525222, 4693.366395536602, 4950.529699678525, 4952.529509696591, 4955.4548999610015, 4959.479254678261, 3665.1203711109274, 4943.678660887049, 5621.353544342392, 5861.853453663672, 5879.382664820197, 5894.292684877821, 5926.674032928208, 5936.7328470218945, 5936.940630593704, 5972.372900845414, 5667.631603945731, 5770.567207459458, 5793.942060579382, 5810.680412577307, 5811.941880581182, 4959.603231741452, 5059.266406371093, 5080.695158290514, 5090.490950904917, 5092.668976516515, 20868.686969695467, 21234.5753084939, 21264.36206913795, 21312.14751409942, 21497.785022149892, 1864.8414884734814, 1888.046536499073, 1942.0483962858239, 2153.676948457728, 2364.6689463475127, 13433.194008359433, 13577.52478663242, 13604.455821767118, 13734.793978090336, 13992.0, 1785.3751187084417, 1796.91015449227, 1818.97271540927, 1821.1440622907344, 1823.3527097880326, 65712.3428765711, 66377.33622663759, 66448.6677566614, 66888.6655566724, 67158.66420667914, 9312.580933857857, 9643.324967252365, 9762.804743905082, 9839.0, 9841.55712992917, 13007.544735934385, 13009.154404963836, 13022.153560018569, 13058.08593398472, 13098.148620339647, 6758.797236082925, 6894.172699276119, 6896.137982752156, 7190.568565886064, 7209.963950180216, 6577.736890524326, 6614.173228346457, 6766.763163289262, 6800.795976120724, 6818.4886133540185, 5859.794907178229, 5926.525877929756, 5998.190244317048, 6017.368176341509, 6174.783882564088, 1594.107299912053, 1626.9267882945296, 1673.7740405045406, 1704.6420251747024, 1783.8394544490798, 757.7310054930531, 828.3869936247133, 850.2900078434576, 979.0405402705388, 980.3627642032736, 16466.588335291475, 16990.745138822927, 17173.57066073358, 17435.912820435817, 17467.0, 844.0841686769924, 877.7410663854179, 882.9823403531893, 902.8961669407971, 941.4492521874643, 6379.521535884827, 9443.858342124873, 10020.799584008279, 10153.88307286198, 10155.949220253999, 405113.4119576286, 409201.0, 413906.0, 417577.0, 418765.0, 78937.60531197308, 82864.58567707243, 83267.0, 83670.0, 86568.56715716381, 883.6642076011075, 914.0767824497173, 945.2863088368238, 946.1626460582297, 948.4025064209504, 15288.0, 15521.76717349218, 15677.764833527734, 15967.760483592987, 16292.674146516767, 36474.0, 36624.45063323999, 36634.45048324331, 37212.0, 38628.420573691976, 50683.49316506788, 50915.0, 51229.23156152586, 51332.0, 51355.74322128366, 7147.249538798559, 7360.852782944204, 7515.38419239866, 7586.127595326608, 7790.298873101448, 10513.264071515227, 11225.831612525983, 11243.66269011931, 11508.136889733136, 12467.064970127096, 7369.963150184215, 9253.259739220981, 9594.45746877064, 9598.232141428529, 10468.476576171008, 9958.0, 10150.0, 10362.171026318027, 10530.0, 10694.251402401756, 10364.222683298633, 10366.326188797704, 10825.621103261348, 10855.728606784893, 11129.944350278196, 7235.167955685163, 7421.443391745533, 7482.738104166328, 7514.511556748794, 7686.769396918102, 8706.390552661253, 10009.0, 10151.187904967437, 10246.38521688701, 10727.678169654922], "value": 8339.613279892941, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1303.8370203724533, 1351.3108314759472, 1390.478570536049, 1647.5057482755162, 1655.759914812353, 6827.385535301822, 7301.123865136185, 7323.63381830909, 7971.561564113978, 7977.800554986121, 7459.515131516448, 7747.961260193705, 7759.379249660028, 7783.221677832214, 7791.454598178129, 2049.4876280929766, 2090.446031801574, 2091.393495886191, 2094.8847813370257, 2095.968560471594, 2071.326818783894, 2087.0, 2099.9475013124716, 2141.325482473024, 2147.4309308033385, 2084.437201955471, 2111.957760844782, 2116.492041909946, 2134.6264403729365, 2161.5460753241837, 2084.47888027993, 2085.322270262171, 2086.3010891351414, 2088.3108574170487, 2089.98955005224, 2055.1162999910034, 2102.873827570351, 2122.0238690202527, 2127.4681329667583, 2132.936011919645, 7704.845903081907, 7873.566953817538, 7874.921250787476, 7878.4485086044, 7890.2109789021215, 4267.786610669454, 4392.143532011259, 4403.273459879116, 4404.119176164748, 4424.159409712144, 2737.110439107298, 2851.572264160372, 2893.4502444535683, 2909.3599408130176, 2913.883444662211, 890.2299510923006, 933.4865823796885, 936.2416442681382, 943.3773709351794, 946.2240962410826, 10627.096696780784, 10644.254902156852, 10666.973275077788, 10717.30337528066, 10729.356238625707, 3882.6117388261514, 3909.902252443712, 4110.979445102756, 4119.97940010298, 4128.60778226068, 9001.414908030956, 9116.635334586543, 9131.497767622712, 9138.268938485038, 9163.679271225608, 4451.043025749479, 4451.755153466525, 4499.4150760400935, 4517.864464066083, 4533.093381323749, 3537.1157210697324, 3914.2562913047, 4043.433919251307, 4086.9386959195635, 4089.836406543705, 3461.9307613848086, 3501.3347463981763, 3581.2479379330634, 3585.982070089633, 3635.94546081809, 1168.3515648814819, 1173.284296579086, 1190.2917763930448, 1193.0098018644503, 1194.1879521925, 731.8463122744176, 736.62432159599, 754.9433792465587, 769.5152054205814, 772.069656064441, 4912.70523768575, 5030.597552195815, 5097.61767867404, 5110.84785919784, 5192.402873669576, 380.90477380654835, 381.9751716138442, 383.61829979170346, 386.95936926622863, 392.05319154242756, 3302.126641342369, 3386.255023894739, 3403.982980085084, 3405.165734395089, 3437.0, 8702.30381569473, 9082.318826087938, 9094.772630684285, 9105.863412048824, 9686.32195746291, 9251.583678734472, 9277.768055798524, 9292.349535532448, 9297.442153470813, 9349.39228950116, 6965.860682786316, 7024.894626580605, 7030.296970303031, 7042.190148133031, 7043.859122817413, 5110.824510362711, 5139.408967968731, 5219.582433405394, 5289.814856480005, 5337.0, 8591.226789588967, 8610.569471526524, 8662.480251184697, 8702.608382622671, 8751.474911505331, 8626.353023523387, 8865.113488651341, 8872.512011839412, 8905.0, 8929.419587727038, 5728.684922329312, 5753.769849205984, 5862.091375836752, 6313.873722525432, 6426.485881129405, 7101.147862256562, 7149.142102947471, 7154.499185057204, 7156.642167891689, 7185.604791736296, 6338.334474880256, 6452.161219041494, 6473.676316184078, 6704.698288577123, 6734.6295953721055, 6334.9366506334345, 6361.8727625448155, 6371.108044873628, 6373.235211774617, 6406.647634380154, 5511.118221084607, 5529.30883639545, 5535.529479994246, 5539.473749993906, 5617.410171931889, 4277.743335399886, 4341.196878577473, 4348.608625223745, 4382.145481631179, 4438.4451943507065, 4335.132973405394, 4455.26488129455, 4479.0817882333395, 4492.797824097989, 4523.411956445641], "value": 3912.506232779938, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [284.2524161455372, 290.45684569854376, 293.19664120310347, 300.5926968957063, 303.30089144521895, 4897.36334276544, 4991.251312303157, 5012.0, 5014.470586471125, 5032.84901452957, 4898.363212782342, 4898.853034408965, 4902.6813257138265, 4919.655624106314, 4965.329680493132, 3677.797721125337, 3691.612380700028, 3767.303048935942, 3788.867389641363, 3832.482614847002, 3783.243351329745, 3786.4131059685656, 3793.2413517296513, 3796.316663000659, 3849.8845034648866, 3733.2906747717984, 3756.4928734620885, 3780.6786423154067, 3803.0526342084827, 3804.334241507739, 3587.121155316964, 3770.4909837171904, 3803.7527560708604, 3816.2749077675153, 3819.52255968004, 3301.735861131128, 3325.7671962962604, 3337.3992681317354, 3339.5157702133297, 3367.848446819899, 4828.73441960692, 4877.8780530486665, 4885.36490256268, 4887.364642596475, 4907.399078488407, 4335.523092459827, 4368.60682538573, 4392.275274579691, 4395.846145384929, 4396.054848207651, 5003.949170674163, 5176.55999240065, 5196.870078248074, 5216.191490319006, 5216.713080780555, 3638.0, 3639.326724555939, 3650.3976843820737, 3654.506641603376, 3664.8534058637624, 5512.503874651301, 5512.7596290834645, 5530.557555395559, 5534.889302213933, 5535.169724541311, 3459.6367381425093, 3643.3441980443245, 3646.927061458756, 3650.4889315495852, 3755.361588529902, 3703.185299234218, 3730.2539492101687, 3735.3836616958442, 3735.533058367704, 3738.420544815558, 4298.656107511391, 4310.978445107754, 4325.718828276152, 4339.175556644227, 4339.7396156230725, 5098.847034588968, 5225.372955245395, 5229.581633469314, 5241.0042092002395, 5247.685138891678, 1276.5340650662442, 1295.7019885426405, 1303.2962200411862, 1304.6738315421144, 1309.1294289297512, 807.604273905782, 812.9105798362175, 822.5928165558087, 845.3490812074668, 845.6955496021427, 4400.515943246241, 4472.249566516634, 4619.284010978304, 4622.6301895848255, 4647.140279048387, 5319.361676598833, 5344.0, 5364.275822763955, 5378.462153784591, 5393.622446428791, 4534.795934182904, 4621.514740952219, 4633.907321853544, 4638.350630911675, 4654.604358629555, 2786.275568352243, 2847.5301575239855, 2853.9012480195274, 2853.957190642142, 2866.498362786504, 4999.950000499948, 5021.723805190676, 5040.747962601855, 5048.29323894655, 5059.747012649426, 5195.2986346843445, 5423.593230507728, 5465.59008074396, 5486.972565137149, 5516.448355164452, 5038.672486288379, 5043.9747801260755, 5050.444451110375, 5071.873203169876, 5091.312672789126, 5340.572754179579, 5383.757730902041, 5407.972485227951, 5409.513143817076, 5413.215083812904, 5032.835880571243, 5186.688798672092, 5234.633575649668, 5307.708076055854, 5320.680759154463, 5010.949890501049, 5030.220315851049, 5060.645754797129, 5101.158308878993, 5105.2086926526445, 3726.925461490809, 3736.7757934524016, 3740.850365985439, 3741.8877433677035, 3747.4566187903147, 5221.347331583552, 5341.919871201857, 5362.865928351823, 5412.323459567554, 5440.483154100354, 5191.584673226208, 5193.143131383279, 5216.347956505437, 5228.398734145622, 5264.341957255343, 5216.608754343363, 5246.08193566132, 5253.816116435906, 5254.65844720092, 5261.7895284189735, 4758.310045043519, 5058.468860769566, 5061.215511595708, 5082.263071854634, 5147.301390541187, 4950.257461380822, 5100.617453691062, 5158.561522270649, 5181.404138524118, 5212.244224587489, 5112.565431938327, 5119.692818430906, 5123.718195499283, 5154.175331946871, 5158.535731784157], "value": 3882.758248508312, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [556.2546188107935, 576.4091805898953, 576.4293349583913, 580.4746704232668, 585.2976428286055, 12122.151449398545, 12144.574939877106, 12581.1822231555, 12635.684107897296, 12635.747285054293, 12273.693157671041, 12348.197367171128, 12390.25658460493, 12403.379831008458, 12416.937915310433, 737.5427235114223, 762.8626847167508, 765.2768134113265, 766.1534004924562, 766.2567309709573, 607.9483243924271, 730.7186733107765, 757.6628400361841, 764.3846703403758, 766.1916677904808, 809.0938149272823, 812.1431889356726, 812.8049268175654, 813.4631143445328, 814.2102160903913, 796.9880451793169, 804.694216197844, 805.524740403162, 805.5569436809732, 805.8912046873714, 586.3842964886894, 591.5711109445617, 592.1354821959943, 593.7090825495476, 593.946544810969, 10905.83641245382, 10919.181061420426, 10954.835677464844, 11045.83431248532, 11079.113670906308, 13054.216746995211, 13467.797983030263, 13727.45090196401, 13828.170309781344, 14137.575872723835, 10361.0, 10372.858985511588, 10426.113780328682, 10471.895281047167, 10623.575056997788, 3113.077522321868, 3155.7790954633183, 3169.6037995250595, 3183.0769076967654, 3205.6634053424286, 69174.65412672955, 69920.85356158984, 70192.0, 70348.0, 70399.0, 10091.0, 10175.694729158136, 10248.0, 10339.121174700234, 10385.324953877975, 20387.0, 20463.8976805118, 20528.28151014737, 20737.0, 20823.167073316898, 5694.800681976111, 6073.939260607426, 6413.198350206224, 6475.32009139043, 6498.5126115541525, 3548.8935331940083, 3566.625504322061, 3602.765820221677, 3608.1520842601967, 3663.2124093320062, 2675.3712877473777, 2744.917652470389, 2767.750902418792, 2769.2246171072134, 2773.292810333352, 478.4880178209283, 479.63787340557656, 481.67005601163316, 487.7561219390305, 498.40938487891964, 415.7858702768077, 468.5689165967318, 496.4935765519222, 505.97723102460475, 516.1200153737868, 7172.497925145294, 7441.144268409094, 7448.292412220831, 7557.697692092364, 7589.696412143563, 422.3390394033389, 429.1117387008862, 446.46201327400405, 466.9463011753624, 484.22765688726423, 3221.1430984376443, 3399.2691571312284, 3469.635688252697, 3490.6683865032783, 3515.0, 76214.0, 78009.21990780134, 79942.60602636756, 91669.54165229131, 102028.0, 78496.0, 78792.6060369706, 80141.59929200317, 81570.18429815744, 82774.17225827785, 59702.0, 67825.3217467819, 70809.0, 70845.64577177081, 71543.6422817893, 7692.961535192512, 8665.783355416164, 8861.60122794463, 8864.822703545764, 9070.727878163665, 35550.0, 38116.237675245786, 40426.39360409537, 40881.59118408778, 41493.377599336636, 60410.0, 60674.69662651658, 60988.0, 61002.0, 64022.3597764035, 9874.802503950024, 10193.490325483845, 10248.0, 10349.74125646865, 10392.48037598102, 11460.942809379401, 11499.195056345976, 11582.88417115818, 11806.527738890349, 11888.0, 10351.63769268072, 10492.108170805262, 10622.150227981589, 10779.137668986305, 11418.0865530759, 10954.233203675985, 10956.616518421817, 10964.232503724663, 11061.446927653746, 11457.651181507938, 10618.84071738909, 10939.56241750321, 10951.83572246433, 10997.285176463503, 11035.72410689707, 9248.491332976751, 9394.778678771716, 9473.47895865734, 9901.356411833207, 9902.929112773067, 9646.9035309646, 9715.319927605, 10090.747731306483, 10178.541965611714, 10199.286049976727], "value": 6196.582625752742, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1612.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 118.0, 114.0, 117.0, 116.0, 118.0, 124.0, 116.0, 117.0, 116.0], "value": 116.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 125.0, 155.0, 193.0, 129.0, 152.0, 152.0, 125.0, 196.0, 125.0], "value": 150.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 165.0, 165.0, 174.0, 163.0, 170.0, 165.0, 167.0, 167.0, 165.0], "value": 168.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 79.0, 80.0, 175.0, 80.0, 79.0, 76.0, 79.0, 162.0, 78.0], "value": 96.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 88.0, 142.0, 90.0, 89.0, 88.0, 133.0, 88.0, 89.0, 131.0], "value": 102.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 120.0, 123.0, 119.0, 119.0, 118.0, 120.0, 118.0, 118.0, 118.0], "value": 119.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 151.0, 149.0, 148.0, 151.0, 149.0, 149.0, 149.0, 149.0], "value": 148.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 97.0, 96.0, 96.0, 96.0, 96.0, 97.0, 96.0, 96.0, 96.0], "value": 96.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 67.0, 68.0, 67.0, 67.0, 66.0, 69.0, 68.0, 68.0, 65.0], "value": 67.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 70.0, 70.0, 69.0, 67.0, 66.0, 66.0, 66.0, 66.0, 73.0], "value": 67.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 85.0, 85.0, 84.0, 85.0, 89.0, 86.0, 84.0, 85.0], "value": 85.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 138.0, 138.0, 144.0, 149.0, 143.0, 141.0, 146.0, 157.0, 149.0], "value": 145.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 179.0, 179.0, 173.0, 175.0, 175.0, 175.0, 178.0, 173.0, 173.0], "value": 176.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 73.0, 71.0, 72.0, 74.0, 74.0, 71.0, 72.0, 76.0, 75.0], "value": 72.7, "unit": "score"}]}]} 13:28:06 INFO - Return code: 0 13:28:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:28:06 ERROR - # TBPL SUCCESS # 13:28:06 INFO - Running post-action listener: _resource_record_post_action 13:28:06 INFO - [mozharness: 2016-08-23 20:28:06.184226Z] Finished run-tests step (success) 13:28:06 INFO - Running post-run listener: _resource_record_post_run 13:28:06 INFO - Total resource usage - Wall time: 1200s; CPU: 14.0%; Read bytes: 8192; Write bytes: 409104384; Read time: 28; Write time: 271176 13:28:06 INFO - TinderboxPrint: CPU usage
13.8% 13:28:06 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 28 13:28:06 INFO - TinderboxPrint: I/O write bytes / time
409,104,384 / 271,176 13:28:06 INFO - TinderboxPrint: CPU idle
8,243.6 (86.1%) 13:28:06 INFO - TinderboxPrint: CPU user
1,233.0 (12.9%) 13:28:06 INFO - TinderboxPrint: Swap in / out
0 / 0 13:28:06 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 117637120; Read time: 0; Write time: 73796 13:28:06 INFO - run-tests - Wall time: 1184s; CPU: 14.0%; Read bytes: 4096; Write bytes: 291467264; Read time: 8; Write time: 197380 13:28:06 INFO - Running post-run listener: _upload_blobber_files 13:28:06 INFO - Blob upload gear active. 13:28:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:28: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 13:28: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', 'Larch-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:28: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 Larch-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:28:07 INFO - (blobuploader) - INFO - Open directory for files ... 13:28:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:28:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:28:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:28:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:28:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:28:07 INFO - (blobuploader) - INFO - Done attempting. 13:28:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:28:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:28:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:28:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:28:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:28:08 INFO - (blobuploader) - INFO - Done attempting. 13:28:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:28:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:28:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:28:12 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:28:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:28:12 INFO - (blobuploader) - INFO - Done attempting. 13:28:12 INFO - (blobuploader) - INFO - Iteration through files over. 13:28:12 INFO - Return code: 0 13:28:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:28:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:28:12 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/835f7c776b751fa545b6e43327d06730887c97ed3f7ab97a317c0279cbf0b2188041816317351ad8a896f823720e2bd5329d7994b74c37028edc5e9066990081", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/36389ab67241e8f507bdc6ac4aac40931d17086371350051bf080f0da6859069eb075a80c4b5e13dd44cb11c65bf337bb40f93f9e72d1c9db69dd545e63a6f02", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/e7a0a16a91225fd4b800d093e70002621268448da4617bdda0fec7565af086ee73fbb56fbe92dbdee6a3277c63ada51564bfc37d9c17b155921578252f5bb478"} 13:28:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:28:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:28:12 INFO - Contents: 13:28:12 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/835f7c776b751fa545b6e43327d06730887c97ed3f7ab97a317c0279cbf0b2188041816317351ad8a896f823720e2bd5329d7994b74c37028edc5e9066990081", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/36389ab67241e8f507bdc6ac4aac40931d17086371350051bf080f0da6859069eb075a80c4b5e13dd44cb11c65bf337bb40f93f9e72d1c9db69dd545e63a6f02", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/e7a0a16a91225fd4b800d093e70002621268448da4617bdda0fec7565af086ee73fbb56fbe92dbdee6a3277c63ada51564bfc37d9c17b155921578252f5bb478"} 13:28:12 INFO - Running post-run listener: copy_logs_to_upload_dir 13:28:12 INFO - Copying logs to upload dir... 13:28:12 INFO - mkdir: /builds/slave/test/build/upload/logs 13:28:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.624717 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-08-23 13:28:12.627306) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-23 13:28:12.631052) ========= 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=0333a256a5e4f052382dd180000001b1-1471982846.641249-1898329975 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/Larch-Non-PGO/sha512/835f7c776b751fa545b6e43327d06730887c97ed3f7ab97a317c0279cbf0b2188041816317351ad8a896f823720e2bd5329d7994b74c37028edc5e9066990081", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/36389ab67241e8f507bdc6ac4aac40931d17086371350051bf080f0da6859069eb075a80c4b5e13dd44cb11c65bf337bb40f93f9e72d1c9db69dd545e63a6f02", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/e7a0a16a91225fd4b800d093e70002621268448da4617bdda0fec7565af086ee73fbb56fbe92dbdee6a3277c63ada51564bfc37d9c17b155921578252f5bb478"} build_url:https://queue.taskcluster.net/v1/task/DlBw0_GQQlGoZ0CEKBc1Og/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011203 build_url: 'https://queue.taskcluster.net/v1/task/DlBw0_GQQlGoZ0CEKBc1Og/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/Larch-Non-PGO/sha512/835f7c776b751fa545b6e43327d06730887c97ed3f7ab97a317c0279cbf0b2188041816317351ad8a896f823720e2bd5329d7994b74c37028edc5e9066990081", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/36389ab67241e8f507bdc6ac4aac40931d17086371350051bf080f0da6859069eb075a80c4b5e13dd44cb11c65bf337bb40f93f9e72d1c9db69dd545e63a6f02", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/e7a0a16a91225fd4b800d093e70002621268448da4617bdda0fec7565af086ee73fbb56fbe92dbdee6a3277c63ada51564bfc37d9c17b155921578252f5bb478"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-23 13:28:12.656500) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 13:28:12.656837) ========= 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=0333a256a5e4f052382dd180000001b1-1471982846.641249-1898329975 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004582 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 13:28:12.739773) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-23 13:28:12.740122) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-23 13:28:12.740449) ========= ========= Total master_lag: 0.17 =========