builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-024 starttime: 1471879431.03 results: success (0) buildid: 20160822064718 builduid: 85f1f2ee215e4af2a7e14c914c0f02e7 revision: 8e2c02a74e751c3ea0ae0f05aec1b09c382d3786 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-22 08:23:51.025498) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-22 08:23:51.026069) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-22 08:23:51.026472) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-22 08:23:51.041989) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 08:23:51.042277) ========= 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=41a7e32711b8e08598a63237000001d6-1471879388.635933-1266655020 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-22 08:23:51-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 222M=0s 2016-08-22 08:23:51 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.361790 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 08:23:51.418132) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 08:23:51.418464) ========= 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=41a7e32711b8e08598a63237000001d6-1471879388.635933-1266655020 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023093 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 08:23:51.468906) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 08:23:51.469292) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 8e2c02a74e751c3ea0ae0f05aec1b09c382d3786 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 8e2c02a74e751c3ea0ae0f05aec1b09c382d3786 --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=41a7e32711b8e08598a63237000001d6-1471879388.635933-1266655020 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-22 08:23:51,976 truncating revision to first 12 chars 2016-08-22 08:23:51,976 Setting DEBUG logging. 2016-08-22 08:23:51,976 attempt 1/10 2016-08-22 08:23:51,976 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/8e2c02a74e75?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-22 08:23:52,269 unpacking tar archive at: autoland-8e2c02a74e75/testing/mozharness/ program finished with exit code 0 elapsedTime=0.632968 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 08:23:52.116201) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-22 08:23:52.116607) ========= script_repo_revision: 8e2c02a74e751c3ea0ae0f05aec1b09c382d3786 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-22 08:23:52.117061) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-22 08:23:52.117411) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-22 08:23:52.127859) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-08-22 08:23:52.128239) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=41a7e32711b8e08598a63237000001d6-1471879388.635933-1266655020 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:23:52 INFO - MultiFileLogger online at 20160822 08:23:52 in /builds/slave/test 08:23:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 08:23:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:23:52 INFO - {'append_to_log': False, 08:23:52 INFO - 'base_work_dir': '/builds/slave/test', 08:23:52 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 08:23:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:23:52 INFO - 'branch': 'Autoland-Non-PGO', 08:23:52 INFO - 'buildbot_json_path': 'buildprops.json', 08:23:52 INFO - 'config_files': ('talos/linux_config.py',), 08:23:52 INFO - 'default_actions': ('clobber', 08:23:52 INFO - 'read-buildbot-config', 08:23:52 INFO - 'download-and-extract', 08:23:52 INFO - 'populate-webroot', 08:23:52 INFO - 'create-virtualenv', 08:23:52 INFO - 'install', 08:23:52 INFO - 'run-tests'), 08:23:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:23:52 INFO - 'download_minidump_stackwalk': True, 08:23:52 INFO - 'download_symbols': 'ondemand', 08:23:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:23:52 INFO - 'tooltool.py': '/tools/tooltool.py', 08:23:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:23:52 INFO - '/tools/misc-python/virtualenv.py')}, 08:23:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:23:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:23:52 INFO - 'installer_path': 'installer.exe', 08:23:52 INFO - 'log_level': 'info', 08:23:52 INFO - 'log_name': 'talos', 08:23:52 INFO - 'log_to_console': True, 08:23:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:23:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:23:52 INFO - 'opt_config_files': (), 08:23:52 INFO - 'pip_index': False, 08:23:52 INFO - 'sps_profile': False, 08:23:52 INFO - 'sps_profile_interval': 0, 08:23:52 INFO - 'suite': 'dromaeojs', 08:23:52 INFO - 'system_bits': '32', 08:23:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:23:52 INFO - 'title': 'talos-linux64-ix-024', 08:23:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:23:52 INFO - 'use_talos_json': True, 08:23:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:23:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:23:52 INFO - 'work_dir': 'build'} 08:23:52 INFO - [mozharness: 2016-08-22 15:23:52.726043Z] Running clobber step. 08:23:52 INFO - Running pre-action listener: _resource_record_pre_action 08:23:52 INFO - Running main action method: clobber 08:23:52 INFO - rmtree: /builds/slave/test/build 08:23:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:23:53 INFO - Running post-action listener: _resource_record_post_action 08:23:53 INFO - [mozharness: 2016-08-22 15:23:53.193442Z] Finished clobber step (success) 08:23:53 INFO - [mozharness: 2016-08-22 15:23:53.193543Z] Running read-buildbot-config step. 08:23:53 INFO - Running pre-action listener: _resource_record_pre_action 08:23:53 INFO - Running main action method: read_buildbot_config 08:23:53 INFO - Using buildbot properties: 08:23:53 INFO - { 08:23:53 INFO - "project": "", 08:23:53 INFO - "product": "firefox", 08:23:53 INFO - "script_repo_revision": "production", 08:23:53 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 08:23:53 INFO - "repository": "", 08:23:53 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 08:23:53 INFO - "buildid": "20160822064718", 08:23:53 INFO - "pgo_build": "False", 08:23:53 INFO - "basedir": "/builds/slave/test", 08:23:53 INFO - "buildnumber": 449, 08:23:53 INFO - "slavename": "talos-linux64-ix-024", 08:23:53 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:23:53 INFO - "platform": "ubuntu64_hw", 08:23:53 INFO - "scheduler": "tests-autoland-linux64-talos", 08:23:53 INFO - "branch": "autoland", 08:23:53 INFO - "repo_path": "integration/autoland", 08:23:53 INFO - "revision": "8e2c02a74e751c3ea0ae0f05aec1b09c382d3786", 08:23:53 INFO - "stage_platform": "linux64", 08:23:53 INFO - "builduid": "85f1f2ee215e4af2a7e14c914c0f02e7", 08:23:53 INFO - "slavebuilddir": "test" 08:23:53 INFO - } 08:23:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/cexWBkXNRqaa8lA5AbWN2w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 08:23:53 INFO - Running post-action listener: _resource_record_post_action 08:23:53 INFO - [mozharness: 2016-08-22 15:23:53.195975Z] Finished read-buildbot-config step (success) 08:23:53 INFO - [mozharness: 2016-08-22 15:23:53.196063Z] Running download-and-extract step. 08:23:53 INFO - Running pre-action listener: _resource_record_pre_action 08:23:53 INFO - Running main action method: download_and_extract 08:23:53 INFO - mkdir: /builds/slave/test/build/tests 08:23:53 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')]} 08:23:53 INFO - trying https://queue.taskcluster.net/v1/task/cexWBkXNRqaa8lA5AbWN2w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 08:23:53 INFO - Downloading https://queue.taskcluster.net/v1/task/cexWBkXNRqaa8lA5AbWN2w/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 08:23:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cexWBkXNRqaa8lA5AbWN2w/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 08:23:53 INFO - Downloaded 1361 bytes. 08:23:53 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 08:23:53 INFO - Using the following test package requirements: 08:23:53 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 08:23:53 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:23:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:23:53 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:23:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:23:53 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:23:53 INFO - u'jsshell-linux-x86_64.zip'], 08:23:53 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:23:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:23:53 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 08:23:53 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:23:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:23:53 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:23:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:23:53 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:23:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:23:53 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:23:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:23:53 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:23:53 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')]} 08:23:53 INFO - trying https://queue.taskcluster.net/v1/task/cexWBkXNRqaa8lA5AbWN2w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 08:23:53 INFO - Downloading https://queue.taskcluster.net/v1/task/cexWBkXNRqaa8lA5AbWN2w/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 08:23:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cexWBkXNRqaa8lA5AbWN2w/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 08:23:54 INFO - Downloaded 20331017 bytes. 08:23:54 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 08:23:58 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 08:23: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')]} 08:23:58 INFO - trying https://queue.taskcluster.net/v1/task/cexWBkXNRqaa8lA5AbWN2w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 08:23:58 INFO - Downloading https://queue.taskcluster.net/v1/task/cexWBkXNRqaa8lA5AbWN2w/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 08:23:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cexWBkXNRqaa8lA5AbWN2w/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 08:23:59 INFO - Downloaded 20331017 bytes. 08:23:59 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 08:24:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:24:04 INFO - trying https://queue.taskcluster.net/v1/task/cexWBkXNRqaa8lA5AbWN2w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 08:24:04 INFO - Downloading https://queue.taskcluster.net/v1/task/cexWBkXNRqaa8lA5AbWN2w/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 08:24:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cexWBkXNRqaa8lA5AbWN2w/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 08:24:05 INFO - Downloaded 14413981 bytes. 08:24:05 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 08:24: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')]} 08:24:05 INFO - trying https://queue.taskcluster.net/v1/task/cexWBkXNRqaa8lA5AbWN2w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:24:05 INFO - Downloading https://queue.taskcluster.net/v1/task/cexWBkXNRqaa8lA5AbWN2w/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 08:24:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cexWBkXNRqaa8lA5AbWN2w/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 08:24:06 INFO - Downloaded 55761360 bytes. 08:24:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cexWBkXNRqaa8lA5AbWN2w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:24:06 INFO - mkdir: /builds/slave/test/properties 08:24:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:24:06 INFO - Writing to file /builds/slave/test/properties/build_url 08:24:06 INFO - Contents: 08:24:06 INFO - build_url:https://queue.taskcluster.net/v1/task/cexWBkXNRqaa8lA5AbWN2w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:24:07 INFO - Running post-action listener: _resource_record_post_action 08:24:07 INFO - Running post-action listener: set_extra_try_arguments 08:24:07 INFO - [mozharness: 2016-08-22 15:24:07.199517Z] Finished download-and-extract step (success) 08:24:07 INFO - [mozharness: 2016-08-22 15:24:07.199813Z] Running populate-webroot step. 08:24:07 INFO - Running pre-action listener: _resource_record_pre_action 08:24:07 INFO - Running main action method: populate_webroot 08:24:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:24:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:24:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:24:07 INFO - '--tppagecycles', 08:24:07 INFO - '7'], 08:24:07 INFO - 'tests': ['tsvgm']}}, 08:24:07 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:24:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:24:07 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:24:07 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:24:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:24:07 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:24:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:24:07 INFO - 'talos_options': ['--disable-e10s'], 08:24:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:24:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:24:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:24:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:24:07 INFO - 'talos_options': ['--disable-e10s'], 08:24:07 INFO - 'tests': ['damp', 'tps']}, 08:24:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:24:07 INFO - 'tests': ['damp', 'tps']}, 08:24:07 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:24:07 INFO - 'tests': ['dromaeo_dom']}, 08:24:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:24:07 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:24:07 INFO - 'tests': ['basic_compositor_video']}, 08:24:07 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:24:07 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:24:07 INFO - 'tests': ['a11yr', 08:24:07 INFO - 'ts_paint', 08:24:07 INFO - 'tpaint', 08:24:07 INFO - 'sessionrestore', 08:24:07 INFO - 'sessionrestore_no_auto_restore', 08:24:07 INFO - 'tabpaint']}, 08:24:07 INFO - 'other-e10s': {'tests': ['a11yr', 08:24:07 INFO - 'ts_paint', 08:24:07 INFO - 'tpaint', 08:24:07 INFO - 'sessionrestore', 08:24:07 INFO - 'sessionrestore_no_auto_restore', 08:24:07 INFO - 'tabpaint']}, 08:24:07 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:24:07 INFO - 'ts_paint', 08:24:07 INFO - 'tpaint', 08:24:07 INFO - 'sessionrestore', 08:24:07 INFO - 'sessionrestore_no_auto_restore', 08:24:07 INFO - 'tabpaint']}, 08:24:07 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:24:07 INFO - 'ts_paint', 08:24:07 INFO - 'tpaint', 08:24:07 INFO - 'sessionrestore', 08:24:07 INFO - 'sessionrestore_no_auto_restore', 08:24:07 INFO - 'tabpaint']}, 08:24:07 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:24:07 INFO - 'tests': ['a11yr', 08:24:07 INFO - 'ts_paint', 08:24:07 INFO - 'tpaint', 08:24:07 INFO - 'sessionrestore', 08:24:07 INFO - 'sessionrestore_no_auto_restore', 08:24:07 INFO - 'tabpaint']}, 08:24:07 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:24:07 INFO - 'tests': ['a11yr', 08:24:07 INFO - 'ts_paint', 08:24:07 INFO - 'tpaint', 08:24:07 INFO - 'sessionrestore', 08:24:07 INFO - 'sessionrestore_no_auto_restore', 08:24:07 INFO - 'tabpaint']}, 08:24:07 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:24:07 INFO - 'tests': ['tsvgx', 08:24:07 INFO - 'tsvgr_opacity', 08:24:07 INFO - 'tart', 08:24:07 INFO - 'tscrollx', 08:24:07 INFO - 'cart']}, 08:24:07 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:24:07 INFO - 'tsvgr_opacity', 08:24:07 INFO - 'tart', 08:24:07 INFO - 'tscrollx', 08:24:07 INFO - 'cart']}, 08:24:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:24:07 INFO - 'talos_options': ['--disable-e10s'], 08:24:07 INFO - 'tests': ['tp5o']}, 08:24:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:24:07 INFO - 'tests': ['tp5o']}, 08:24:07 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:24:07 INFO - 'talos_options': ['--disable-e10s', 08:24:07 INFO - '--xperf_path', 08:24:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:24:07 INFO - 'tests': ['tp5n']}, 08:24:07 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:24:07 INFO - 'talos_options': ['--xperf_path', 08:24:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:24:07 INFO - 'tests': ['tp5n']}}, 08:24:07 INFO - 'talos.zip': {'path': '', 08:24:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:24:07 INFO - Running post-action listener: _resource_record_post_action 08:24:07 INFO - [mozharness: 2016-08-22 15:24:07.219805Z] Finished populate-webroot step (success) 08:24:07 INFO - [mozharness: 2016-08-22 15:24:07.219897Z] Running create-virtualenv step. 08:24:07 INFO - Running pre-action listener: _resource_record_pre_action 08:24:07 INFO - Running main action method: create_virtualenv 08:24:07 INFO - Creating virtualenv /builds/slave/test/build/venv 08:24:07 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 08:24:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:24:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:24:07 INFO - Using real prefix '/usr' 08:24:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:24:07 INFO - Installing distribute.............................................................................................................................................................................................done. 08:24:09 INFO - Installing pip.................done. 08:24:09 INFO - Return code: 0 08:24:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:24:09 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')]} 08:24:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:24:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:09 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')]} 08:24:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:24:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:09 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 0x7f80b61b2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1110230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110a090>, '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 0x110d9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110de40>, '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': '41a7e32711b8e08598a63237000001d6-1471879388.635933-1266655020', '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 08:24:09 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 08:24:09 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 08:24:09 INFO - Using env: {'DISPLAY': ':0', 08:24:09 INFO - 'HOME': '/home/cltbld', 08:24:09 INFO - 'LANG': 'en_US.UTF-8', 08:24:09 INFO - 'LANGUAGE': 'en_US:en', 08:24:09 INFO - 'LOGNAME': 'cltbld', 08:24:09 INFO - 'MAIL': '/var/mail/cltbld', 08:24:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:24:09 INFO - 'MOZ_NO_REMOTE': '1', 08:24:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:24:09 INFO - 'NO_EM_RESTART': '1', 08:24:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:24:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:24:09 INFO - 'PWD': '/builds/slave/test', 08:24:09 INFO - 'SHELL': '/bin/bash', 08:24:09 INFO - 'SHLVL': '1', 08:24:09 INFO - 'TERM': 'linux', 08:24:09 INFO - 'TMOUT': '86400', 08:24:09 INFO - 'USER': 'cltbld', 08:24:09 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1471879388.635933-1266655020', 08:24:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:24:09 INFO - '_': '/tools/buildbot/bin/python'} 08:24:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:24:09 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 08:24:09 INFO - Cleaning up... 08:24:10 INFO - Return code: 0 08:24:10 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:24:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:24:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:24:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:24:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:24:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f80b61b2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1110230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110a090>, '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 0x110d9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110de40>, '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': '41a7e32711b8e08598a63237000001d6-1471879388.635933-1266655020', '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 08:24:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:24:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:24:10 INFO - Using env: {'DISPLAY': ':0', 08:24:10 INFO - 'HOME': '/home/cltbld', 08:24:10 INFO - 'LANG': 'en_US.UTF-8', 08:24:10 INFO - 'LANGUAGE': 'en_US:en', 08:24:10 INFO - 'LOGNAME': 'cltbld', 08:24:10 INFO - 'MAIL': '/var/mail/cltbld', 08:24:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:24:10 INFO - 'MOZ_NO_REMOTE': '1', 08:24:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:24:10 INFO - 'NO_EM_RESTART': '1', 08:24:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:24:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:24:10 INFO - 'PWD': '/builds/slave/test', 08:24:10 INFO - 'SHELL': '/bin/bash', 08:24:10 INFO - 'SHLVL': '1', 08:24:10 INFO - 'TERM': 'linux', 08:24:10 INFO - 'TMOUT': '86400', 08:24:10 INFO - 'USER': 'cltbld', 08:24:10 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1471879388.635933-1266655020', 08:24:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:24:10 INFO - '_': '/tools/buildbot/bin/python'} 08:24:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:24:10 INFO - Downloading/unpacking psutil>=3.1.1 08:24:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:24:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:24:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:24:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:24:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:24:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:24:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:24:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:24:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:24:12 INFO - Installing collected packages: psutil 08:24:12 INFO - Running setup.py install for psutil 08:24:12 INFO - building 'psutil._psutil_linux' extension 08:24:12 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 08:24:12 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 08:24:12 INFO - building 'psutil._psutil_posix' extension 08:24:12 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 08:24:12 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 08:24:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:24:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:24:12 INFO - Successfully installed psutil 08:24:12 INFO - Cleaning up... 08:24:12 INFO - Return code: 0 08:24:12 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:24:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:24:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:24:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:24:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:24:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f80b61b2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1110230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110a090>, '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 0x110d9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110de40>, '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': '41a7e32711b8e08598a63237000001d6-1471879388.635933-1266655020', '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 08:24:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:24:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:24:12 INFO - Using env: {'DISPLAY': ':0', 08:24:12 INFO - 'HOME': '/home/cltbld', 08:24:12 INFO - 'LANG': 'en_US.UTF-8', 08:24:12 INFO - 'LANGUAGE': 'en_US:en', 08:24:12 INFO - 'LOGNAME': 'cltbld', 08:24:12 INFO - 'MAIL': '/var/mail/cltbld', 08:24:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:24:12 INFO - 'MOZ_NO_REMOTE': '1', 08:24:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:24:12 INFO - 'NO_EM_RESTART': '1', 08:24:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:24:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:24:12 INFO - 'PWD': '/builds/slave/test', 08:24:12 INFO - 'SHELL': '/bin/bash', 08:24:12 INFO - 'SHLVL': '1', 08:24:12 INFO - 'TERM': 'linux', 08:24:12 INFO - 'TMOUT': '86400', 08:24:12 INFO - 'USER': 'cltbld', 08:24:12 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1471879388.635933-1266655020', 08:24:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:24:12 INFO - '_': '/tools/buildbot/bin/python'} 08:24:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:24:13 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:24:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:24:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:24:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:24:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:24:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:24:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:24:14 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:24:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:24:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:24:14 INFO - Installing collected packages: mozsystemmonitor 08:24:14 INFO - Running setup.py install for mozsystemmonitor 08:24:15 INFO - Successfully installed mozsystemmonitor 08:24:15 INFO - Cleaning up... 08:24:15 INFO - Return code: 0 08:24:15 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:24:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:24:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:24:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:24:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:24:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f80b61b2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1110230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110a090>, '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 0x110d9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110de40>, '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': '41a7e32711b8e08598a63237000001d6-1471879388.635933-1266655020', '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 08:24:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:24:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:24:15 INFO - Using env: {'DISPLAY': ':0', 08:24:15 INFO - 'HOME': '/home/cltbld', 08:24:15 INFO - 'LANG': 'en_US.UTF-8', 08:24:15 INFO - 'LANGUAGE': 'en_US:en', 08:24:15 INFO - 'LOGNAME': 'cltbld', 08:24:15 INFO - 'MAIL': '/var/mail/cltbld', 08:24:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:24:15 INFO - 'MOZ_NO_REMOTE': '1', 08:24:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:24:15 INFO - 'NO_EM_RESTART': '1', 08:24:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:24:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:24:15 INFO - 'PWD': '/builds/slave/test', 08:24:15 INFO - 'SHELL': '/bin/bash', 08:24:15 INFO - 'SHLVL': '1', 08:24:15 INFO - 'TERM': 'linux', 08:24:15 INFO - 'TMOUT': '86400', 08:24:15 INFO - 'USER': 'cltbld', 08:24:15 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1471879388.635933-1266655020', 08:24:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:24:15 INFO - '_': '/tools/buildbot/bin/python'} 08:24:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:24:15 INFO - Downloading/unpacking jsonschema==2.5.1 08:24:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:24:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:24:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:24:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:24:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:24:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:24:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:24:17 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:24:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:24:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:24:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:24:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:24:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:24:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:24:17 INFO - Downloading functools32-3.2.3-2.tar.gz 08:24:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:24:17 INFO - warning: no files found matching '*.txt' 08:24:17 INFO - no previously-included directories found matching 'build' 08:24:17 INFO - no previously-included directories found matching 'dist' 08:24:17 INFO - no previously-included directories found matching '.git*' 08:24:17 INFO - Installing collected packages: jsonschema, functools32 08:24:17 INFO - Running setup.py install for functools32 08:24:17 INFO - warning: no files found matching '*.txt' 08:24:17 INFO - no previously-included directories found matching 'build' 08:24:17 INFO - no previously-included directories found matching 'dist' 08:24:17 INFO - no previously-included directories found matching '.git*' 08:24:17 INFO - Successfully installed jsonschema functools32 08:24:17 INFO - Cleaning up... 08:24:17 INFO - Return code: 0 08:24:17 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:24:17 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')]} 08:24:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:24:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:17 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')]} 08:24:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:24:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:17 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 0x7f80b61b2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1110230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110a090>, '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 0x110d9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110de40>, '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': '41a7e32711b8e08598a63237000001d6-1471879388.635933-1266655020', '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 08:24:17 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 08:24:17 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 08:24:17 INFO - Using env: {'DISPLAY': ':0', 08:24:17 INFO - 'HOME': '/home/cltbld', 08:24:17 INFO - 'LANG': 'en_US.UTF-8', 08:24:17 INFO - 'LANGUAGE': 'en_US:en', 08:24:17 INFO - 'LOGNAME': 'cltbld', 08:24:17 INFO - 'MAIL': '/var/mail/cltbld', 08:24:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:24:17 INFO - 'MOZ_NO_REMOTE': '1', 08:24:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:24:17 INFO - 'NO_EM_RESTART': '1', 08:24:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:24:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:24:17 INFO - 'PWD': '/builds/slave/test', 08:24:17 INFO - 'SHELL': '/bin/bash', 08:24:17 INFO - 'SHLVL': '1', 08:24:17 INFO - 'TERM': 'linux', 08:24:17 INFO - 'TMOUT': '86400', 08:24:17 INFO - 'USER': 'cltbld', 08:24:17 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1471879388.635933-1266655020', 08:24:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:24:17 INFO - '_': '/tools/buildbot/bin/python'} 08:24:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:24:17 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:24:17 INFO - Cleaning up... 08:24:17 INFO - Return code: 0 08:24:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:24:17 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')]} 08:24:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:24:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:17 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')]} 08:24:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:24:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:17 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 0x7f80b61b2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1110230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110a090>, '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 0x110d9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110de40>, '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': '41a7e32711b8e08598a63237000001d6-1471879388.635933-1266655020', '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 08:24:17 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 08:24:17 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 08:24:17 INFO - Using env: {'DISPLAY': ':0', 08:24:17 INFO - 'HOME': '/home/cltbld', 08:24:17 INFO - 'LANG': 'en_US.UTF-8', 08:24:17 INFO - 'LANGUAGE': 'en_US:en', 08:24:17 INFO - 'LOGNAME': 'cltbld', 08:24:17 INFO - 'MAIL': '/var/mail/cltbld', 08:24:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:24:17 INFO - 'MOZ_NO_REMOTE': '1', 08:24:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:24:17 INFO - 'NO_EM_RESTART': '1', 08:24:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:24:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:24:17 INFO - 'PWD': '/builds/slave/test', 08:24:17 INFO - 'SHELL': '/bin/bash', 08:24:17 INFO - 'SHLVL': '1', 08:24:17 INFO - 'TERM': 'linux', 08:24:17 INFO - 'TMOUT': '86400', 08:24:17 INFO - 'USER': 'cltbld', 08:24:17 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1471879388.635933-1266655020', 08:24:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:24:17 INFO - '_': '/tools/buildbot/bin/python'} 08:24:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:24:18 INFO - Downloading/unpacking blobuploader==1.2.4 08:24:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:24:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:24:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:24:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:24:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:24:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:24:19 INFO - Downloading blobuploader-1.2.4.tar.gz 08:24:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:24:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:24:20 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 08:24:20 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 08:24:20 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 08:24:20 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 08:24:20 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 08:24:20 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 08:24:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:24:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:24:20 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 08:24:20 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 08:24:20 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 08:24:20 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 08:24:20 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 08:24:20 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 08:24:20 INFO - Downloading docopt-0.6.1.tar.gz 08:24:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:24:20 INFO - Installing collected packages: blobuploader, requests, docopt 08:24:20 INFO - Running setup.py install for blobuploader 08:24:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:24:20 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:24:20 INFO - Running setup.py install for requests 08:24:21 INFO - Running setup.py install for docopt 08:24:21 INFO - Successfully installed blobuploader requests docopt 08:24:21 INFO - Cleaning up... 08:24:21 INFO - Return code: 0 08:24:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:24:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:24:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:24:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:24:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:24:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:21 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 0x7f80b61b2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1110230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110a090>, '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 0x110d9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110de40>, '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': '41a7e32711b8e08598a63237000001d6-1471879388.635933-1266655020', '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 08:24:21 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 08:24:21 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 08:24:21 INFO - Using env: {'DISPLAY': ':0', 08:24:21 INFO - 'HOME': '/home/cltbld', 08:24:21 INFO - 'LANG': 'en_US.UTF-8', 08:24:21 INFO - 'LANGUAGE': 'en_US:en', 08:24:21 INFO - 'LOGNAME': 'cltbld', 08:24:21 INFO - 'MAIL': '/var/mail/cltbld', 08:24:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:24:21 INFO - 'MOZ_NO_REMOTE': '1', 08:24:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:24:21 INFO - 'NO_EM_RESTART': '1', 08:24:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:24:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:24:21 INFO - 'PWD': '/builds/slave/test', 08:24:21 INFO - 'SHELL': '/bin/bash', 08:24:21 INFO - 'SHLVL': '1', 08:24:21 INFO - 'TERM': 'linux', 08:24:21 INFO - 'TMOUT': '86400', 08:24:21 INFO - 'USER': 'cltbld', 08:24:21 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1471879388.635933-1266655020', 08:24:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:24:21 INFO - '_': '/tools/buildbot/bin/python'} 08:24:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:24:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:24:21 INFO - Running setup.py (path:/tmp/pip-ClPn4a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:24:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:24:21 INFO - Running setup.py (path:/tmp/pip-AYkHaY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:24:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:24:21 INFO - Running setup.py (path:/tmp/pip-eeAPAv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:24:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:24:21 INFO - Running setup.py (path:/tmp/pip-Lj0Lgx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:24:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:24:21 INFO - Running setup.py (path:/tmp/pip-C3TnD7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:24:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:24:21 INFO - Running setup.py (path:/tmp/pip-2abV2l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:24:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:24:22 INFO - Running setup.py (path:/tmp/pip-KZfnrW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:24:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:24:22 INFO - Running setup.py (path:/tmp/pip-pIJUUS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:24:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:24:22 INFO - Running setup.py (path:/tmp/pip-_NUdG3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:24:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:24:22 INFO - Running setup.py (path:/tmp/pip-uKmI2w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:24:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:24:22 INFO - Running setup.py (path:/tmp/pip-GyiP5S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:24:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:24:22 INFO - Running setup.py (path:/tmp/pip-OK17iF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:24:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:24:22 INFO - Running setup.py (path:/tmp/pip-47xvFO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:24:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:24:22 INFO - Running setup.py (path:/tmp/pip-lFcHIv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:24:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:24:22 INFO - Running setup.py (path:/tmp/pip-xyJvRt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:24:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:24:22 INFO - Running setup.py (path:/tmp/pip-F0Or28-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:24:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:24:22 INFO - Running setup.py (path:/tmp/pip-CRX3cY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:24:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:24:22 INFO - Running setup.py install for manifestparser 08:24:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:24:22 INFO - Running setup.py install for mozcrash 08:24:22 INFO - Running setup.py install for mozdebug 08:24:23 INFO - Running setup.py install for mozdevice 08:24:23 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:24:23 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:24:23 INFO - Running setup.py install for mozfile 08:24:23 INFO - Running setup.py install for mozhttpd 08:24:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:24:23 INFO - Running setup.py install for mozinfo 08:24:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:24:23 INFO - Running setup.py install for mozInstall 08:24:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:24:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:24:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:24:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:24:23 INFO - Running setup.py install for mozleak 08:24:23 INFO - Running setup.py install for mozlog 08:24:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:24:23 INFO - Running setup.py install for moznetwork 08:24:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:24:23 INFO - Running setup.py install for mozprocess 08:24:24 INFO - Running setup.py install for mozprofile 08:24:24 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:24:24 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:24:24 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:24:24 INFO - Running setup.py install for mozrunner 08:24:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:24:24 INFO - Running setup.py install for mozscreenshot 08:24:24 INFO - Running setup.py install for moztest 08:24:24 INFO - Running setup.py install for mozversion 08:24:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:24:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:24:24 INFO - Cleaning up... 08:24:24 INFO - Return code: 0 08:24:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:24:24 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')]} 08:24:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:24:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:24 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')]} 08:24:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:24:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:24 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 0x7f80b61b2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1110230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110a090>, '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 0x110d9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110de40>, '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': '41a7e32711b8e08598a63237000001d6-1471879388.635933-1266655020', '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 08:24:24 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 08:24:24 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 08:24:24 INFO - Using env: {'DISPLAY': ':0', 08:24:24 INFO - 'HOME': '/home/cltbld', 08:24:24 INFO - 'LANG': 'en_US.UTF-8', 08:24:24 INFO - 'LANGUAGE': 'en_US:en', 08:24:24 INFO - 'LOGNAME': 'cltbld', 08:24:24 INFO - 'MAIL': '/var/mail/cltbld', 08:24:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:24:24 INFO - 'MOZ_NO_REMOTE': '1', 08:24:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:24:24 INFO - 'NO_EM_RESTART': '1', 08:24:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:24:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:24:24 INFO - 'PWD': '/builds/slave/test', 08:24:24 INFO - 'SHELL': '/bin/bash', 08:24:24 INFO - 'SHLVL': '1', 08:24:24 INFO - 'TERM': 'linux', 08:24:24 INFO - 'TMOUT': '86400', 08:24:24 INFO - 'USER': 'cltbld', 08:24:24 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1471879388.635933-1266655020', 08:24:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:24:24 INFO - '_': '/tools/buildbot/bin/python'} 08:24:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:24:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:24:24 INFO - Running setup.py (path:/tmp/pip-QyGPdC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:24:24 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)) 08:24:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:24:24 INFO - Running setup.py (path:/tmp/pip-BHQH6V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:24:24 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)) 08:24:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:24:24 INFO - Running setup.py (path:/tmp/pip-CCaaQn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:24:25 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)) 08:24:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:24:25 INFO - Running setup.py (path:/tmp/pip-1XYQJ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:24:25 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)) 08:24:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:24:25 INFO - Running setup.py (path:/tmp/pip-d174xU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:24:25 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)) 08:24:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:24:25 INFO - Running setup.py (path:/tmp/pip-RLzN4Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:24:25 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)) 08:24:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:24:25 INFO - Running setup.py (path:/tmp/pip-8npIPZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:24:25 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)) 08:24:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:24:25 INFO - Running setup.py (path:/tmp/pip-kBHlmO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:24:25 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)) 08:24:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:24:25 INFO - Running setup.py (path:/tmp/pip-2lkjKP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:24:25 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)) 08:24:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:24:25 INFO - Running setup.py (path:/tmp/pip-V81KZf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:24:25 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)) 08:24:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:24:25 INFO - Running setup.py (path:/tmp/pip-0WPOdc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:24:25 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)) 08:24:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:24:25 INFO - Running setup.py (path:/tmp/pip-0cjxz4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:24:25 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)) 08:24:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:24:25 INFO - Running setup.py (path:/tmp/pip-KUyG4F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:24:25 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)) 08:24:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:24:25 INFO - Running setup.py (path:/tmp/pip-COfS0W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:24:25 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)) 08:24:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:24:25 INFO - Running setup.py (path:/tmp/pip-u7GtL5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:24:25 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)) 08:24:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:24:25 INFO - Running setup.py (path:/tmp/pip-IUwcIK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:24:25 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)) 08:24:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:24:25 INFO - Running setup.py (path:/tmp/pip-YhF4rn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:24:26 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)) 08:24:26 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)) 08:24:26 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)) 08:24:26 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)) 08:24:26 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)) 08:24:26 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)) 08:24:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:24:26 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 08:24:26 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 08:24:26 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 08:24:26 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 08:24:26 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 08:24:26 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 08:24:27 INFO - Downloading blessings-1.6.tar.gz 08:24:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:24:28 INFO - Installing collected packages: blessings 08:24:28 INFO - Running setup.py install for blessings 08:24:28 INFO - Successfully installed blessings 08:24:28 INFO - Cleaning up... 08:24:28 INFO - Return code: 0 08:24:28 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:24:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:24:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:24:28 INFO - Reading from file tmpfile_stdout 08:24:28 INFO - Current package versions: 08:24:28 INFO - argparse == 1.2.1 08:24:28 INFO - blessings == 1.6 08:24:28 INFO - blobuploader == 1.2.4 08:24:28 INFO - docopt == 0.6.1 08:24:28 INFO - functools32 == 3.2.3-2 08:24:28 INFO - jsonschema == 2.5.1 08:24:28 INFO - manifestparser == 1.1 08:24:28 INFO - mozInstall == 1.12 08:24:28 INFO - mozcrash == 0.17 08:24:28 INFO - mozdebug == 0.1 08:24:28 INFO - mozdevice == 0.48 08:24:28 INFO - mozfile == 1.2 08:24:28 INFO - mozhttpd == 0.7 08:24:28 INFO - mozinfo == 0.9 08:24:28 INFO - mozleak == 0.1 08:24:28 INFO - mozlog == 3.3 08:24:28 INFO - moznetwork == 0.27 08:24:28 INFO - mozprocess == 0.23 08:24:28 INFO - mozprofile == 0.28 08:24:28 INFO - mozrunner == 6.12 08:24:28 INFO - mozscreenshot == 0.1 08:24:28 INFO - mozsystemmonitor == 0.3 08:24:28 INFO - moztest == 0.7 08:24:28 INFO - mozversion == 1.4 08:24:28 INFO - psutil == 3.1.1 08:24:28 INFO - requests == 1.2.3 08:24:28 INFO - wsgiref == 0.1.2 08:24:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:24:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:24:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:24:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:24:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:24:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:28 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 0x7f80b61b2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1110230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110a090>, '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 0x110d9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110de40>, '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': '41a7e32711b8e08598a63237000001d6-1471879388.635933-1266655020', '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 08:24:28 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 08:24:28 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 08:24:28 INFO - Using env: {'DISPLAY': ':0', 08:24:28 INFO - 'HOME': '/home/cltbld', 08:24:28 INFO - 'LANG': 'en_US.UTF-8', 08:24:28 INFO - 'LANGUAGE': 'en_US:en', 08:24:28 INFO - 'LOGNAME': 'cltbld', 08:24:28 INFO - 'MAIL': '/var/mail/cltbld', 08:24:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:24:28 INFO - 'MOZ_NO_REMOTE': '1', 08:24:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:24:28 INFO - 'NO_EM_RESTART': '1', 08:24:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:24:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:24:28 INFO - 'PWD': '/builds/slave/test', 08:24:28 INFO - 'SHELL': '/bin/bash', 08:24:28 INFO - 'SHLVL': '1', 08:24:28 INFO - 'TERM': 'linux', 08:24:28 INFO - 'TMOUT': '86400', 08:24:28 INFO - 'USER': 'cltbld', 08:24:28 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1471879388.635933-1266655020', 08:24:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:24:28 INFO - '_': '/tools/buildbot/bin/python'} 08:24:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:24:28 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)) 08:24:28 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)) 08:24:28 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)) 08:24:28 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)) 08:24:28 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)) 08:24:28 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)) 08:24:28 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)) 08:24:28 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)) 08:24:28 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)) 08:24:28 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)) 08:24:28 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)) 08:24:28 INFO - Cleaning up... 08:24:28 INFO - Return code: 0 08:24:28 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:24:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:24:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:24:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:24:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:24:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:28 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 0x7f80b61b2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1110230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110a090>, '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 0x110d9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110de40>, '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': '41a7e32711b8e08598a63237000001d6-1471879388.635933-1266655020', '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 08:24:28 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 08:24:28 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 08:24:28 INFO - Using env: {'DISPLAY': ':0', 08:24:28 INFO - 'HOME': '/home/cltbld', 08:24:28 INFO - 'LANG': 'en_US.UTF-8', 08:24:28 INFO - 'LANGUAGE': 'en_US:en', 08:24:28 INFO - 'LOGNAME': 'cltbld', 08:24:28 INFO - 'MAIL': '/var/mail/cltbld', 08:24:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:24:28 INFO - 'MOZ_NO_REMOTE': '1', 08:24:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:24:28 INFO - 'NO_EM_RESTART': '1', 08:24:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:24:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:24:28 INFO - 'PWD': '/builds/slave/test', 08:24:28 INFO - 'SHELL': '/bin/bash', 08:24:28 INFO - 'SHLVL': '1', 08:24:28 INFO - 'TERM': 'linux', 08:24:28 INFO - 'TMOUT': '86400', 08:24:28 INFO - 'USER': 'cltbld', 08:24:28 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1471879388.635933-1266655020', 08:24:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:24:28 INFO - '_': '/tools/buildbot/bin/python'} 08:24:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:24:28 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:24:28 INFO - Cleaning up... 08:24:28 INFO - Return code: 0 08:24:28 INFO - Running post-action listener: _resource_record_post_action 08:24:28 INFO - Running post-action listener: _start_resource_monitoring 08:24:28 INFO - Starting resource monitoring. 08:24:28 INFO - [mozharness: 2016-08-22 15:24:28.860189Z] Finished create-virtualenv step (success) 08:24:28 INFO - [mozharness: 2016-08-22 15:24:28.860697Z] Running install step. 08:24:28 INFO - Running pre-action listener: _resource_record_pre_action 08:24:28 INFO - Running main action method: install 08:24:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:24:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:24:29 INFO - Reading from file tmpfile_stdout 08:24:29 INFO - Detecting whether we're running mozinstall >=1.0... 08:24:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:24:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:24:29 INFO - Reading from file tmpfile_stdout 08:24:29 INFO - Output received: 08:24:29 INFO - Usage: mozinstall [options] installer 08:24:29 INFO - Options: 08:24:29 INFO - -h, --help show this help message and exit 08:24:29 INFO - -d DEST, --destination=DEST 08:24:29 INFO - Directory to install application into. [default: 08:24:29 INFO - "/builds/slave/test"] 08:24:29 INFO - --app=APP Application being installed. [default: firefox] 08:24:29 INFO - mkdir: /builds/slave/test/build/application 08:24:29 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'] 08:24:29 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 08:24:45 INFO - Reading from file tmpfile_stdout 08:24:45 INFO - Output received: 08:24:45 INFO - /builds/slave/test/build/application/firefox/firefox 08:24:45 INFO - Running post-action listener: _resource_record_post_action 08:24:45 INFO - [mozharness: 2016-08-22 15:24:45.255932Z] Finished install step (success) 08:24:45 INFO - [mozharness: 2016-08-22 15:24:45.256178Z] Running run-tests step. 08:24:45 INFO - Running pre-action listener: _resource_record_pre_action 08:24:45 INFO - Running main action method: run_tests 08:24:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:24:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:24:45 INFO - Python 2.7.3 08:24:45 INFO - Return code: 0 08:24:45 INFO - grabbing minidump binary from tooltool 08:24:45 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')]} 08:24:45 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 0x110a090>, '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 0x110d9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110de40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:24:45 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 08:24:45 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 08:24:45 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 08:24:45 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:24:45 INFO - Return code: 0 08:24:45 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:24:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:24:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:24:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:24:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:24:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cexWBkXNRqaa8lA5AbWN2w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 08:24:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/cexWBkXNRqaa8lA5AbWN2w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-024 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 08:24:45 INFO - Using env: {'DISPLAY': ':0', 08:24:45 INFO - 'HOME': '/home/cltbld', 08:24:45 INFO - 'LANG': 'en_US.UTF-8', 08:24:45 INFO - 'LANGUAGE': 'en_US:en', 08:24:45 INFO - 'LOGNAME': 'cltbld', 08:24:45 INFO - 'MAIL': '/var/mail/cltbld', 08:24:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:24:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:24:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:24:45 INFO - 'MOZ_NO_REMOTE': '1', 08:24:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:24:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:24:45 INFO - 'NO_EM_RESTART': '1', 08:24:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:24:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:24:45 INFO - 'PWD': '/builds/slave/test', 08:24:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:24:45 INFO - 'SHELL': '/bin/bash', 08:24:45 INFO - 'SHLVL': '1', 08:24:45 INFO - 'TERM': 'linux', 08:24:45 INFO - 'TMOUT': '86400', 08:24:45 INFO - 'USER': 'cltbld', 08:24:45 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1471879388.635933-1266655020', 08:24:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:24:45 INFO - '_': '/tools/buildbot/bin/python'} 08:24:45 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cexWBkXNRqaa8lA5AbWN2w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:24:45 INFO - mozversion application_buildid: 20160822064718 08:24:45 INFO - mozversion application_changeset: 8e2c02a74e751c3ea0ae0f05aec1b09c382d3786 08:24:45 INFO - mozversion application_display_name: Nightly 08:24:45 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:24:45 INFO - mozversion application_name: Firefox 08:24:45 INFO - mozversion application_remotingname: firefox 08:24:45 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 08:24:45 INFO - mozversion application_vendor: Mozilla 08:24:45 INFO - mozversion application_version: 51.0a1 08:24:45 INFO - mozversion platform_buildid: 20160822064718 08:24:45 INFO - mozversion platform_changeset: 8e2c02a74e751c3ea0ae0f05aec1b09c382d3786 08:24:45 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 08:24:45 INFO - mozversion platform_version: 51.0a1 08:24:45 INFO - using testdate: 1471879485 08:24:45 INFO - actual date: 1471879485 08:24:45 INFO - starting webserver on 'localhost:43775' 08:24:45 INFO - SUITE-START | Running 2 tests 08:24:45 INFO - TEST-START | dromaeo_css 08:24:45 INFO - operating with platform_type : linux_ 08:24:45 INFO - Initialising browser for dromaeo_css test... 08:24:45 INFO - TEST-INFO | started process 4783 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGdX80h/profile http://localhost:43775/getInfo.html) 08:24:50 INFO - PROCESS | 4783 | __metrics Screen width/height:1600/1200 08:24:50 INFO - PROCESS | 4783 | colorDepth:24 08:24:50 INFO - PROCESS | 4783 | Browser inner width/height: 1024/697 08:24:50 INFO - PROCESS | 4783 | __metrics 08:24:50 INFO - PROCESS | 4783 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:24:50 INFO - PROCESS | 4783 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:24:51 INFO - TEST-INFO | 4783: exit 0 08:24:51 INFO - Browser initialized. 08:24:51 INFO - Running cycle 1/1 for dromaeo_css test... 08:24:51 INFO - TEST-INFO | started process 4863 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGdX80h/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:25:04 INFO - PROCESS | 4863 | RSS: Main: 174583808 08:25:04 INFO - PROCESS | 4863 | 08:25:55 INFO - PROCESS | 4863 | 1471879555321 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] 08:28:07 INFO - PROCESS | 4863 | Cycle 1(1): loaded http://localhost:43775/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43775/tests/dromaeo/cssquery-ext.html) 08:28:09 INFO - PROCESS | 4863 | RSS: Main: 282152960 08:28:09 INFO - PROCESS | 4863 | 08:31:11 INFO - PROCESS | 4863 | Cycle 1(1): loaded http://localhost:43775/tests/dromaeo/cssquery-ext.html (next: http://localhost:43775/tests/dromaeo/cssquery-jquery.html) 08:31:12 INFO - PROCESS | 4863 | RSS: Main: 273989632 08:31:12 INFO - PROCESS | 4863 | 08:34:14 INFO - PROCESS | 4863 | Cycle 1(1): loaded http://localhost:43775/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43775/tests/dromaeo/cssquery-mootools.html) 08:34:15 INFO - PROCESS | 4863 | RSS: Main: 243912704 08:34:15 INFO - PROCESS | 4863 | 08:37:17 INFO - PROCESS | 4863 | Cycle 1(1): loaded http://localhost:43775/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43775/tests/dromaeo/cssquery-prototype.html) 08:37:18 INFO - PROCESS | 4863 | RSS: Main: 218505216 08:37:18 INFO - PROCESS | 4863 | 08:40:21 INFO - PROCESS | 4863 | Cycle 1(1): loaded http://localhost:43775/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43775/tests/dromaeo/cssquery-yui.html) 08:40:22 INFO - PROCESS | 4863 | RSS: Main: 218710016 08:40:22 INFO - PROCESS | 4863 | 08:43:25 INFO - PROCESS | 4863 | Cycle 1(1): loaded http://localhost:43775/tests/dromaeo/cssquery-yui.html (next: http://localhost:43775/tests/dromaeo/cssquery-dojo.html) 08:43:25 INFO - PROCESS | 4863 | RSS: Main: 307019776 08:43:25 INFO - PROCESS | 4863 | 08:43:25 INFO - PROCESS | 4863 | __start_tp_report 08:43:25 INFO - PROCESS | 4863 | _x_x_mozilla_page_load 08:43:25 INFO - PROCESS | 4863 | _x_x_mozilla_page_load_details 08:43:25 INFO - PROCESS | 4863 | |i|pagename|runs| 08:43:25 INFO - PROCESS | 4863 | |0;dojo.html;2535.80981426393;2582.767550920417;2584.8578328191966;2586.1853516142414;2590.753878381553;4403.515613282536;4460.6208472279895;4500.5949464548185;4559.17934771741;4577.496475387705;4346.853201280322;4494.595486406222;4495.370648109268;4523.185826551219;4614.238650622651;4246.214450326684;4266.87199384019;4273.7008409411355;4303.419038429819;4356.455443069616;4280.186764514732;4307.870763877073;4350.434443522354;4358.476982762073;4359.4768627764715;4131.834726610932;4163.063310755056;4174.791260436966;4246.766427846467;4249.128928569636;4230.344296634026;4244.023874508849;4246.8725938221905;4270.530241673413;4294.377315289296;4216.915661686749;4223.91552168958;4235.428217190671;4241.321388577843;4289.056407590325;4397.538258482878;4556.612687921531;4593.40285762852;4628.583427491509;4633.582977532038;4945.035718034985;4975.029869175512;4975.0796102721115;4976.925346119811;4986.4514903360605;4796.160671882441;4950.405951285833;4995.850124496271;5000.0999820032375;5009.524095210985;4588.49526552079;4591.931121033153;4601.263797792404;4663.044075964419;4704.317873908264;5084.847454576368;5117.078925793318;5120.692758434506;5131.461196574381;5135;4727.409073865767;4881.8535443936735;4896.069746748178;4899.755012249373;4906.681065730716;4801.039792041605;4840.782164802592;4843.733594652257;4918.262260660858;4934.925976110361;4866.294387313819;4868.172410690191;4872.4153101628035;4873.439554451213;4873.780679869415;4711.3639658646325;4860.513948605111;4871.464138944713;4874.098291815954;4874.415070191529;4069.2675318442966;4102.364133559303;4112.115895082572;4123.092919557693;4156.875293741193;3618.203995121069;3642.581103173116;3646.9452958205648;3648.288583726148;3650.0327413235514;4193.308104162779;4289.6139347458875;4289.871303860889;4301.827926882952;4305.225059489322;4736.952630473651;4761.428628564525;4766.356541866804;4810.093704421541;4822.214561569152;4208.116295577902;4240.724352917051;4240.787960601958;4244.342126970325;4245.702800803914;4326.935095973563;4378.430803995524;4382.474103107647;4383.890402739957;4385.166818304512;4674.275487299542;4739.502352252964;4741.075490279362;4797.496262892346;4799.616030717604;4969.975150124226;4987.326710893983;4994.101061808909;4996.675216110941;5001.749912504433;4570.063137056962;4780.043991201704;4783.9521604784895;4797.64017698681;4801.087793319258;4773.76131193432;4812.903741925212;4838.225883858566;4870.464248932543;4891.437484689306;4937.530934561211;4942.28336891156;4942.579880710036;4944.3572335596145;4954.603631709382;4661.394018777537;4809.95190048109;4821.4696383397095;4837.806487740451;4846.466888642176;4693.296005599187;4730.597899178609;4734.21885388907;4798.304245884257;4810.11012962603;4712.198926182488;4730.550597693214;4731.976340118277;4734.621230301499;4744.430668319824;4688.812447502198;4830.734309613005;4832.589229915356;4840;4840.7337596432535;4612.723236605814;4627.514111018295;4639.675222734376;4642.698224615389;4680.882977925443 08:43:25 INFO - PROCESS | 4863 | |1;ext.html;550.4028129479515;555.5638823523535;564.4581202046036;573.3034363248652;579.3713820504752;28960.420791584183;38767.61232387679;39797.8010109949;39898.40152397709;44000.11999760003;41901.371479427835;42383.36424953621;42412.57587424125;42468;42505.57494425055;7683.731069412558;7815.687372505122;7839.529628222296;7844.803879902991;7848;7103.8224044398785;9826.361286516389;10070.69787906364;10085.596576136946;10520.631777887775;10031.398116113056;10103.393796372204;10108.140808031327;10108.191344692406;10134.493275336241;9979.700608981742;10047.648332308407;10059.849102263472;10063.748406289827;10064.345817521838;9969.700908972742;10031.849522257173;10046.648367307109;10048.045435683598;10052.64815731446;39018.21963560713;39180.60819391798;39399.40900886489;39477.802610986764;39531.40702889459;2967.985160074207;2983.8955636552832;3081.275900163482;3262.0866157475944;3336.6830151135846;29215.41569168605;30015.249618759488;30241.395172096436;30912.0726378209;31488;3382.2559037012065;3390.762646614738;3403.5915690117095;3433.0902310887636;3453.706434953032;182824;183312;183415.99999999866;183585;184395;26890.731092688824;27880.72119278822;52756;52990.67523311871;53093;32960.340793184485;33160.50259246113;33298.500522492184;33348.83325583405;33444.33111337759;13178;13294.66763330905;13323.866761332456;13328.133671311527;13341.733165336833;9757.560909759079;9999.550020249106;10787.514561844735;10859.402732849769;10867.184961127947;7430.888536671954;7482.289182527651;7539.208383119803;7746.419018573517;7765.844683106307;3018.3661431099713;3085.5988721466065;3095.3035566997696;3119.2201949512623;3136.34136831268;872.912708729122;877.7147427086095;888.782606962786;934.1219253901447;938.9859152112724;27680.86159569189;27931.16206513808;28558.714412855606;28835.71164288372;28953.710462895102;925.893522244937;977.8728765260613;1003.4781913404988;1012.4785735346303;1018.5467466977124;14692.412303507954;15328.208632842216;15366.615834604001;15461.690766184838;15502.379904803907;368770;369800;370265;374123;374688;48471.27293090607;48791.75604121957;48801.755991220525;48884.75557622189;49050;1143.9256448330832;1206.2641788509002;1206.6741979665442;1207.3600991474532;1208.6857417071449;25743.227703168934;26912.730872691805;27509.44981100407;27577.310567235978;27792.722072779823;42879.35680964726;43098.78450607727;43147.13705725931;43159.78420107879;43216.78391608148;301362;302921;303202;303296;305191;22219.888900555394;22905.541889162458;23140.190093346653;24593.13924012651;25291.241262762145;41501.58498414977;41797.58202417937;41901.58098419099;42385.36421953735;42630;34578.12171930727;35120.824395877855;35233;35411;35658.82170589131;32410.675893240765;35684.821575892995;35847.82076089603;35952.10119746922;36302.81848590846;34469;34909.65090349064;35697;35863.46204806982;35869.64130358663;27447.313817153932;28732.71267287384;29028.419431610826;29153.7084629151;29755.404891902475;24516;24891.377715557257;25222.369440763392;25225.08110918353;25665.230043098738 08:43:25 INFO - PROCESS | 4863 | |2;jquery.html;364.978101313921;369.80030783376975;373.4566206170022;379.8244433478383;385.918957019026;16371.836281637181;16503.25735341911;17237.96572205667;17262.654746905053;17314.913425432856;15587.220638968034;16284.185790710477;16535.751963720555;16641.1679416029;16644.417445389412;4972.403311602613;5229.660072095321;5234.555062819665;5236.528712415882;5239.214117882329;3842.923141537168;3979.7413168143976;5154.845354639367;5835.44563266489;6089.725962331683;6195.783147589836;6196.070589411602;6206.441420272175;6206.627602343851;6210.2547694276755;5931.970340148293;6170.96914515429;6174.413430724052;6177;6206.937930620727;5264.499872512105;5368.409474957752;5444.7822087116465;5452.454754524555;5452.91820622691;20648;20910.790892091038;21164.259250926298;21203.36389908305;21273.787262127335;1972.1519746508995;2027.341114137911;2049.5695903860205;2104;2363.586372384843;13026.283554404505;13335;13373.732525349536;13417;13759.79360309596;1712.2551690014884;1777.5289548269718;1795.838374546284;1802.1980218802637;1836.9242755686123;66262;66697.66651166762;66972;67662.3233767661;67856;9553.04469553053;9584.856227156599;9758.853617195748;9871.50642467888;10016.79966400668;13591.52429664957;13598.04813663054;13620.387082581308;13621.662692640168;13630.591082267549;7184.281571842774;7428.331450169402;7525.3227209551405;7672.0409948756405;7673.34776544;7086.149662040588;7155.105611798525;7308.378787803096;7484.850302993909;7486.288802563748;6057.273127224673;6158.7228574714245;6221.3778622138325;6402.135711678957;6742.797716068526;1608.8230294667578;1678.211240716861;1697.4313604942483;1732.159902447312;1768.3280353465857;857.2113655437013;893.9284857211408;899.865020246955;903.9954800225956;944.2870632672426;16574.254158562893;16877.578060548585;17107.071635987446;17711.822881771273;18019.909900450413;858.8411143938266;861.1947828780111;879.4239772948729;881.8456770065213;892.3708785306474;9776;9885.901140988643;10147.7463063424;10160.593576257015;10381.480925953672;289496;296719;296936;398648;399225;48371;63069;66777.66611166912;75163;78446;903.9593218305192;907.9909200908038;924.0805398628273;945.3760518058049;949.8955114937352;15751.212439377756;15993.360265589246;16306;16439.506814795575;16624.418145364853;36081.81959090293;36399.81800090983;36720;37048.814755927124;37223.25553488861;45369;47097.293540596234;48039.75980120077;53680.427294962064;55164.72417637886;6949.3745562899585;6973.965130174317;7069.081019467436;7153.213146553979;7164.678969952771;7518.661660225193;10367.533460994122;11104.333739975627;11143.72140696489;11185.440727963733;7871.48835325702;9778.75553111178;10067.395956242648;10228.590856365661;10280.17758579297;9730.75673108178;9946.850797238192;9985.950070249603;10158.492075396349;10331.276810623183;9512.191463725661;9780.070893265129;9825.754356141153;9851.950740246539;10057;6597.340265973365;6898.758543450955;7032.12098487689;7088.503804733619;7219.747308844166;7392.630368481662;9650.131488166098;9700.175485083564;9815.852762208715;9928.8085429746 08:43:25 INFO - PROCESS | 4863 | |3;mootools.html;1286.2218357893473;1362.7410791949528;1367.8426980897193;1578.9654681136421;1630.5678995066303;6380.680965951707;6613.338666133384;7068.469864760144;7636.350910172635;7638.847223055543;7091.539049961749;7347.044884165064;7350;7545.773626791205;7554.773356799291;2169.2190811307914;2200.064972386729;2201.5376770878133;2203.394066631673;2205.7353117625908;1857.4334827877492;2103.442587714257;2155.0625477917156;2162.567486502698;2172.1094351315965;2169.609470295346;2185.5628874225217;2189.912403503858;2193.5064610462678;2196.7254093238344;2107.1571371451387;2108.11459187141;2194.221051526701;2198.4393979535275;2199.7800219978035;2112.9577408451746;2127.9574408511744;2132.744070711509;2163.2644900733826;2182.552576721784;7402.814929626802;7501.774946751606;7504.849903001964;7504.887426688604;7508.662110205054;4272.764997925113;4383.649308055348;4412.691111622188;4417.602415782595;4423.137488189805;2963.6739958604535;3063.2495038715656;3129.264622813637;3159.9842000790077;3160.083575763026;883.3816328569962;883.5405589093635;897.5108565831638;937.1144268666113;939.7885475767897;9863.112319891172;10218.335808172445;10233;10660.307080039773;10668.466576671135;3890.435886796399;3962.8612998544913;4076.062505623664;4079.3065178919655;4101.5488296287385;7852.175521570267;7852.332551733167;7852.528848269122;7859.803504912308;7860.174681658458;4447.066116115588;4464.977675111603;4482.462104547475;4493.438320209973;4519.276915693539;4044.5955404459905;4134.214499245134;4144.834206631761;4145.025918909054;4147.419361289422;3255.3326568053494;3319.7676162668863;3371.32573485299;3379.915502112467;3492.2666240089357;967.385710074108;1028.1620479309338;1070.4808168038496;1177.4583691501834;1235.3823088455772;779.2947382618626;819.3199644295221;819.512390127873;823.8228780812154;825.5830805443213;4885.340479035356;4931.679440836334;4991.575716064102;5024.397072351341;5282.31329927107;854.594067817794;871.0766587417231;882.5543100734088;892.5849479991834;917.7338571814232;3326.7837590556537;3348.397288488047;3442.087846720621;3450.102973226979;3562.98218508911;9216.709660647515;9662.323637345318;9670.032996700274;9672.516374181263;9697.369670971364;9503.192228660502;9507.286953478517;9513.143817056498;9516.429014259167;9549.427034377959;6980.883058710683;7103.573785572882;7110.751123710749;7260.165081015645;7314;5040.974795126001;5048.72232027242;5068.695878247317;5105.387353517602;5290.6032047597355;8899.777505562413;8910.777230569287;8986.68546600866;9000.459972401677;9007.369484136048;8554.91445085541;8931.151540603632;8937.150970657776;9070.773230669287;9150.22223111043;6361.109444677656;6466.579672321284;6475.870482590416;6491.707873145814;6505.251896032017;7281.854362912606;7310.6710198040155;7348.228436014141;7350.926490735024;7352.742654007084;6639.601623902581;6699.564528305645;6752.628605426748;6754.649070185884;6988.965055174692;6295.559310848196;6358.332375100733;6368.681565921778;6435.002574600944;6522.21733391996;5924.614900031656;5972.25346831646;5975.223220981245;5978;5988.161657367885;4220.873373798791;4221.767802770877;4227.471566054243;4347.434833471629;4423.734575925455;4418.690691651682;4427.092446048617;4485.304777759453;4496;4524.660650451164 08:43:25 INFO - PROCESS | 4863 | |4;prototype.html;298.351086387108;306.6029491808108;308.1725566852999;310.3637543036774;312.86390420167214;4722.622190224783;4770.7853146608395;4782.904341913159;4799.824043109443;4801.590870481962;4614.307853821929;4675.976620116895;4694.929576056354;4698.778317637413;4701.623870090393;3474.4788281757687;3613.765105268162;3672.2288319452946;3722.7952462614544;3725.5343082114737;3721.8511259549587;3738.7756734595873;3743.5133432653715;3760.454734063559;3773.9622603774023;3707.2400157967554;3712.1462063725357;3727.1241258304412;3736.327461057009;3741.850325986957;3540.7875527468436;3607.240461047301;3726.832292546842;3732.861477249438;3736.701063914894;3315.1877789941377;3319.336132773455;3320.435525960568;3323.5180898769786;3363.6790614476176;4551.431071116111;4564.520725323827;4568.931466028012;4576.244919588264;4598.2642777155825;4109.712320137592;4198.790060496994;4216.241076606209;4235.343521754133;4241.957580424187;4831.178699621073;4838.830640927586;4842.903141937141;4849.927251091236;4855.810326470002;3579.1410061585293;3591.407417776064;3594.982025089884;3596.29872174926;3598.5501812273465;5052.520010598987;5060.569851562622;5068;5120.745417372767;5128.82025139318;3527.312174126072;3681.3189559931498;3700.5374328208973;3709.3137769512728;3713.72147088964;3734.7198960078103;3741.3826718591126;3744.9812750936617;3745.6254374562873;3750;4245.469316335458;4246.4691913510815;4252.383404406344;4259.233337999128;4266.935995960063;4722.716637001791;4895.339129217581;4918.3360246367;4925.236588328815;4939.604831613462;1283.9293838838767;1285.7942729163476;1291.709365392798;1297.4430683180221;1302.1536001598847;808.016319934571;832.4630613254417;842;844.8563744163507;851.5401683091185;4230.386593943923;4284.957150428519;4410.274331644204;4429.379886815848;4455.866324010285;5046.139703127111;5047.570956468741;5048.1418158913075;5062.443131255559;5062.531865758962;4402.723210268986;4418.403515525363;4420.093880754438;4423.18171138334;4431.977840110779;2568.4734629400928;2682.919512414631;2688.647433495691;2691.734884604233;2702.9324266893486;4879.536444037811;4907.411110666742;4911.901761964741;4921.753912304442;4925.8029678812445;5208.296879921162;5215.921761173586;5228.163493840967;5229.764660590283;5231.1228824146565;4618.261078227468;4871.878203044881;4915.631327650441;4923.359963204761;4941.53055459738;5100.69395836251;5116.69748613133;5128.974355128201;5130.4100028497205;5187.351581052369;4845.781939812788;5052.065367906949;5053.469385714447;5068.29043933857;5114.744262786771;4870.8310005599105;4873.317735517101;4875.975620121877;4888.144574699484;4929.433115191656;3595.9820200899876;3599.9460008099377;3622.4385220290897;3643.289558536166;3656.3601369759654;5131.384233891957;5141.845744627667;5176.757578181285;5180.114913814639;5189.065968125774;4741;4938.185199442196;4949.6287778416045;4953.439666505039;4973.875653108701;4911.361523001987;4914.975425122851;4921.212605983025;4939.753012349296;4967.304577359245;4867.58625516835;4871.780769865293;4877.756112194447;4897.608191344755;4900.436449808318;4689.7655117244685;4749.382580264543;4837.105135549935;4920.606351491943;4939.950600494093;4859.684120532154;4860.198067318853;4860.708357498562;4861.611071114373;4905.705657660552 08:43:25 INFO - PROCESS | 4863 | |5;yui.html;564.5201578658139;586.5542187937168;633.727497176214;649.5680372552252;658.2258494271362;12415.68960775981;12828.486860525567;12862.807057894139;13599.388027538773;13621;13423.328833558307;13695.041347105707;13710.45158193671;13720.862791372083;13731.656708582266;628.4846425930739;743.3272888036336;755.2334380603692;757.5719718359137;757.6779868555869;738.4350971506775;761.3908872901684;761.4289283037722;761.5659074327635;765.5368502056232;807.0799288810761;810.3719617296583;811.0753740735566;811.37524106438;814.3200427642926;648.9318621544764;795.8726603743402;798.8681867491857;799.1848314718983;799.588212070784;567.3078843810586;585.4584509328896;587.1515659871487;588.5027152056506;588.9852753681149;12701.428435720414;12722.872771272354;12736.554220602235;12743.044271679568;12764;12241.69395765113;12614;12831.807522887164;13056.634247743063;13115.409806558728;10687.358758474438;10694.321713315547;11010.339379637247;11055.336679799238;11064.17018723591;4009.278329900617;4042.818073186684;4073.9185216295805;4261.616454519077;4269.87190384289;63089;63596.682016590086;64631.353686463;65126.348736512504;65863.67068164676;9922.40465572068;9922.652707155215;10116.494175291353;10127.341722788142;10132.848007279898;19571.608567828564;19667.901660491607;19799.703004454946;19869.900650496656;19922.402327929896;6448.226212854487;6588.934110658832;6615.140031795932;6646.468282537386;6858.142732158481;3542.291541691672;3601.1897323102617;3632.9636703632627;3638.381475149231;3668.706503479715;2743.7393447622444;2867.5411934090444;2868.899588514392;2869.297022229567;2878.150945471091;481.0859367202344;484.4283745180721;501.967372120811;523.071548002299;529.9682019078867;560.733651515535;567.9914801277985;572.4962033410573;582.1733138942711;585.7828120563646;7636.465447418738;8087.878681819778;8373.748787536384;8518.957405212934;8599;506.4176197373051;506.8606133313368;563.1890078287254;582.6853499110517;583.5098517245449;3770.472133901256;3786.469894214812;3878.127421330178;3928.4500169976227;4019.8995025124023;99180.91079536747;102188.48905755424;103531.78809271318;106728;107471.46264268785;88374.55812720895;90676;90763;90991.54504227568;91111.54444227736;74540.25459745442;75921.78743019405;77829;81367.59316203381;83749.16250837657;7667.693292268247;7672.309492145734;7701.345385642059;7992.120866704774;8062;44255.557444426435;44586.77706611446;44794.77602611966;45622.31566526571;46086.769566151954;64154;67667.66166169138;68647.31352686608;68924;69040.65479672569;8928;9310.394824336396;9450.149486546245;9471.289653275893;9814.509274536387;9848;9907.554160062671;9909.65316213929;9951.651692190739;9982.201423885926;7542.388522799325;7645.720671282829;10017.298789084694;10041.548130334006;10267.897321026694;10308.948455257676;10540.736481588021;10572.682819515427;10795.6221532246;10995.945020274847;10725.356478610996;11073.11415086775;11341.603043893425;11692.240004399688;11761.823572646588;8772.956135219283;9538.904610953801;9689.12797848197;9712.125908668253;10350.378977261389;9552.474613896302;10026.849597256192;10083.747906302402;10095;10108.444035578113 08:43:25 INFO - PROCESS | 4863 | __end_tp_report 08:43:25 INFO - PROCESS | 4863 | __start_cc_report 08:43:25 INFO - PROCESS | 4863 | _x_x_mozilla_cycle_collect,1022 08:43:25 INFO - PROCESS | 4863 | __end_cc_report 08:43:25 INFO - PROCESS | 4863 | __startTimestamp1471880605471__endTimestamp 08:43:25 INFO - PROCESS | 4863 | 08:43:25 INFO - PROCESS | 4863 | ------- Summary: start ------- 08:43:25 INFO - PROCESS | 4863 | Number of tests: 6 08:43:25 INFO - PROCESS | 4863 | 08:43:25 INFO - PROCESS | 4863 | [#0] dojo.html Cycles:165 Average:4544.44 Median:4688.81 stddev:476.37 (10.2%) stddev-sans-first:451.02 08:43:25 INFO - PROCESS | 4863 | Values: 2535.8 2582.8 2584.9 2586.2 2590.8 4403.5 4460.6 4500.6 4559.2 4577.5 4346.9 4494.6 4495.4 4523.2 4614.2 4246.2 4266.9 4273.7 4303.4 4356.5 4280.2 4307.9 4350.4 4358.5 4359.5 4131.8 4163.1 4174.8 4246.8 4249.1 4230.3 4244.0 4246.9 4270.5 4294.4 4216.9 4223.9 4235.4 4241.3 4289.1 4397.5 4556.6 4593.4 4628.6 4633.6 4945.0 4975.0 4975.1 4976.9 4986.5 4796.2 4950.4 4995.9 5000.1 5009.5 4588.5 4591.9 4601.3 4663.0 4704.3 5084.8 5117.1 5120.7 5131.5 5135.0 4727.4 4881.9 4896.1 4899.8 4906.7 4801.0 4840.8 4843.7 4918.3 4934.9 4866.3 4868.2 4872.4 4873.4 4873.8 4711.4 4860.5 4871.5 4874.1 4874.4 4069.3 4102.4 4112.1 4123.1 4156.9 3618.2 3642.6 3646.9 3648.3 3650.0 4193.3 4289.6 4289.9 4301.8 4305.2 4737.0 4761.4 4766.4 4810.1 4822.2 4208.1 4240.7 4240.8 4244.3 4245.7 4326.9 4378.4 4382.5 4383.9 4385.2 4674.3 4739.5 4741.1 4797.5 4799.6 4970.0 4987.3 4994.1 4996.7 5001.7 4570.1 4780.0 4784.0 4797.6 4801.1 4773.8 4812.9 4838.2 4870.5 4891.4 4937.5 4942.3 4942.6 4944.4 4954.6 4661.4 4810.0 4821.5 4837.8 4846.5 4693.3 4730.6 4734.2 4798.3 4810.1 4712.2 4730.6 4732.0 4734.6 4744.4 4688.8 4830.7 4832.6 4840.0 4840.7 4612.7 4627.5 4639.7 4642.7 4680.9 08:43:25 INFO - PROCESS | 4863 | 08:43:25 INFO - PROCESS | 4863 | [#1] ext.html Cycles:180 Average:43463.87 Median:33060.42 stddev:78185.90 (236.5%) stddev-sans-first:78338.84 08:43:25 INFO - PROCESS | 4863 | Values: 550.4 555.6 564.5 573.3 579.4 28960.4 38767.6 39797.8 39898.4 44000.1 41901.4 42383.4 42412.6 42468.0 42505.6 7683.7 7815.7 7839.5 7844.8 7848.0 7103.8 9826.4 10070.7 10085.6 10520.6 10031.4 10103.4 10108.1 10108.2 10134.5 9979.7 10047.6 10059.8 10063.7 10064.3 9969.7 10031.8 10046.6 10048.0 10052.6 39018.2 39180.6 39399.4 39477.8 39531.4 2968.0 2983.9 3081.3 3262.1 3336.7 29215.4 30015.2 30241.4 30912.1 31488.0 3382.3 3390.8 3403.6 3433.1 3453.7 182824.0 183312.0 183416.0 183585.0 184395.0 26890.7 27880.7 52756.0 52990.7 53093.0 32960.3 33160.5 33298.5 33348.8 33444.3 13178.0 13294.7 13323.9 13328.1 13341.7 9757.6 9999.6 10787.5 10859.4 10867.2 7430.9 7482.3 7539.2 7746.4 7765.8 3018.4 3085.6 3095.3 3119.2 3136.3 872.9 877.7 888.8 934.1 939.0 27680.9 27931.2 28558.7 28835.7 28953.7 925.9 977.9 1003.5 1012.5 1018.5 14692.4 15328.2 15366.6 15461.7 15502.4 368770.0 369800.0 370265.0 374123.0 374688.0 48471.3 48791.8 48801.8 48884.8 49050.0 1143.9 1206.3 1206.7 1207.4 1208.7 25743.2 26912.7 27509.4 27577.3 27792.7 42879.4 43098.8 43147.1 43159.8 43216.8 301362.0 302921.0 303202.0 303296.0 305191.0 22219.9 22905.5 23140.2 24593.1 25291.2 41501.6 41797.6 41901.6 42385.4 42630.0 34578.1 35120.8 35233.0 35411.0 35658.8 32410.7 35684.8 35847.8 35952.1 36302.8 34469.0 34909.7 35697.0 35863.5 35869.6 27447.3 28732.7 29028.4 29153.7 29755.4 24516.0 24891.4 25222.4 25225.1 25665.2 08:43:25 INFO - PROCESS | 4863 | 08:43:25 INFO - PROCESS | 4863 | [#2] jquery.html Cycles:180 Average:22544.17 Median:5251.86 stddev:56246.00 (1071.0%) stddev-sans-first:56379.14 08:43:25 INFO - PROCESS | 4863 | Values: 365.0 369.8 373.5 379.8 385.9 16371.8 16503.3 17238.0 17262.7 17314.9 15587.2 16284.2 16535.8 16641.2 16644.4 4972.4 5229.7 5234.6 5236.5 5239.2 3842.9 3979.7 5154.8 5835.4 6089.7 6195.8 6196.1 6206.4 6206.6 6210.3 5932.0 6171.0 6174.4 6177.0 6206.9 5264.5 5368.4 5444.8 5452.5 5452.9 20648.0 20910.8 21164.3 21203.4 21273.8 1972.2 2027.3 2049.6 2104.0 2363.6 13026.3 13335.0 13373.7 13417.0 13759.8 1712.3 1777.5 1795.8 1802.2 1836.9 66262.0 66697.7 66972.0 67662.3 67856.0 9553.0 9584.9 9758.9 9871.5 10016.8 13591.5 13598.0 13620.4 13621.7 13630.6 7184.3 7428.3 7525.3 7672.0 7673.3 7086.1 7155.1 7308.4 7484.9 7486.3 6057.3 6158.7 6221.4 6402.1 6742.8 1608.8 1678.2 1697.4 1732.2 1768.3 857.2 893.9 899.9 904.0 944.3 16574.3 16877.6 17107.1 17711.8 18019.9 858.8 861.2 879.4 881.8 892.4 9776.0 9885.9 10147.7 10160.6 10381.5 289496.0 296719.0 296936.0 398648.0 399225.0 48371.0 63069.0 66777.7 75163.0 78446.0 904.0 908.0 924.1 945.4 949.9 15751.2 15993.4 16306.0 16439.5 16624.4 36081.8 36399.8 36720.0 37048.8 37223.3 45369.0 47097.3 48039.8 53680.4 55164.7 6949.4 6974.0 7069.1 7153.2 7164.7 7518.7 10367.5 11104.3 11143.7 11185.4 7871.5 9778.8 10067.4 10228.6 10280.2 9730.8 9946.9 9986.0 10158.5 10331.3 9512.2 9780.1 9825.8 9852.0 10057.0 6597.3 6898.8 7032.1 7088.5 7219.7 7392.6 9650.1 9700.2 9815.9 9928.8 08:43:25 INFO - PROCESS | 4863 | 08:43:25 INFO - PROCESS | 4863 | [#3] mootools.html Cycles:180 Average:4969.18 Median:5193.85 stddev:2774.04 (53.4%) stddev-sans-first:2768.01 08:43:25 INFO - PROCESS | 4863 | Values: 1286.2 1362.7 1367.8 1579.0 1630.6 6380.7 6613.3 7068.5 7636.4 7638.8 7091.5 7347.0 7350.0 7545.8 7554.8 2169.2 2200.1 2201.5 2203.4 2205.7 1857.4 2103.4 2155.1 2162.6 2172.1 2169.6 2185.6 2189.9 2193.5 2196.7 2107.2 2108.1 2194.2 2198.4 2199.8 2113.0 2128.0 2132.7 2163.3 2182.6 7402.8 7501.8 7504.8 7504.9 7508.7 4272.8 4383.6 4412.7 4417.6 4423.1 2963.7 3063.2 3129.3 3160.0 3160.1 883.4 883.5 897.5 937.1 939.8 9863.1 10218.3 10233.0 10660.3 10668.5 3890.4 3962.9 4076.1 4079.3 4101.5 7852.2 7852.3 7852.5 7859.8 7860.2 4447.1 4465.0 4482.5 4493.4 4519.3 4044.6 4134.2 4144.8 4145.0 4147.4 3255.3 3319.8 3371.3 3379.9 3492.3 967.4 1028.2 1070.5 1177.5 1235.4 779.3 819.3 819.5 823.8 825.6 4885.3 4931.7 4991.6 5024.4 5282.3 854.6 871.1 882.6 892.6 917.7 3326.8 3348.4 3442.1 3450.1 3563.0 9216.7 9662.3 9670.0 9672.5 9697.4 9503.2 9507.3 9513.1 9516.4 9549.4 6980.9 7103.6 7110.8 7260.2 7314.0 5041.0 5048.7 5068.7 5105.4 5290.6 8899.8 8910.8 8986.7 9000.5 9007.4 8554.9 8931.2 8937.2 9070.8 9150.2 6361.1 6466.6 6475.9 6491.7 6505.3 7281.9 7310.7 7348.2 7350.9 7352.7 6639.6 6699.6 6752.6 6754.6 6989.0 6295.6 6358.3 6368.7 6435.0 6522.2 5924.6 5972.3 5975.2 5978.0 5988.2 4220.9 4221.8 4227.5 4347.4 4423.7 4418.7 4427.1 4485.3 4496.0 4524.7 08:43:25 INFO - PROCESS | 4863 | 08:43:25 INFO - PROCESS | 4863 | [#4] prototype.html Cycles:180 Average:4127.29 Median:4700.20 stddev:1188.85 (25.3%) stddev-sans-first:1156.93 08:43:25 INFO - PROCESS | 4863 | Values: 298.4 306.6 308.2 310.4 312.9 4722.6 4770.8 4782.9 4799.8 4801.6 4614.3 4676.0 4694.9 4698.8 4701.6 3474.5 3613.8 3672.2 3722.8 3725.5 3721.9 3738.8 3743.5 3760.5 3774.0 3707.2 3712.1 3727.1 3736.3 3741.9 3540.8 3607.2 3726.8 3732.9 3736.7 3315.2 3319.3 3320.4 3323.5 3363.7 4551.4 4564.5 4568.9 4576.2 4598.3 4109.7 4198.8 4216.2 4235.3 4242.0 4831.2 4838.8 4842.9 4849.9 4855.8 3579.1 3591.4 3595.0 3596.3 3598.6 5052.5 5060.6 5068.0 5120.7 5128.8 3527.3 3681.3 3700.5 3709.3 3713.7 3734.7 3741.4 3745.0 3745.6 3750.0 4245.5 4246.5 4252.4 4259.2 4266.9 4722.7 4895.3 4918.3 4925.2 4939.6 1283.9 1285.8 1291.7 1297.4 1302.2 808.0 832.5 842.0 844.9 851.5 4230.4 4285.0 4410.3 4429.4 4455.9 5046.1 5047.6 5048.1 5062.4 5062.5 4402.7 4418.4 4420.1 4423.2 4432.0 2568.5 2682.9 2688.6 2691.7 2702.9 4879.5 4907.4 4911.9 4921.8 4925.8 5208.3 5215.9 5228.2 5229.8 5231.1 4618.3 4871.9 4915.6 4923.4 4941.5 5100.7 5116.7 5129.0 5130.4 5187.4 4845.8 5052.1 5053.5 5068.3 5114.7 4870.8 4873.3 4876.0 4888.1 4929.4 3596.0 3599.9 3622.4 3643.3 3656.4 5131.4 5141.8 5176.8 5180.1 5189.1 4741.0 4938.2 4949.6 4953.4 4973.9 4911.4 4915.0 4921.2 4939.8 4967.3 4867.6 4871.8 4877.8 4897.6 4900.4 4689.8 4749.4 4837.1 4920.6 4940.0 4859.7 4860.2 4860.7 4861.6 4905.7 08:43:25 INFO - PROCESS | 4863 | 08:43:25 INFO - PROCESS | 4863 | [#5] yui.html Cycles:180 Average:18224.05 Median:567.65 stddev:27055.63 (4766.3%) stddev-sans-first:27099.03 08:43:25 INFO - PROCESS | 4863 | Values: 564.5 586.6 633.7 649.6 658.2 12415.7 12828.5 12862.8 13599.4 13621.0 13423.3 13695.0 13710.5 13720.9 13731.7 628.5 743.3 755.2 757.6 757.7 738.4 761.4 761.4 761.6 765.5 807.1 810.4 811.1 811.4 814.3 648.9 795.9 798.9 799.2 799.6 567.3 585.5 587.2 588.5 589.0 12701.4 12722.9 12736.6 12743.0 12764.0 12241.7 12614.0 12831.8 13056.6 13115.4 10687.4 10694.3 11010.3 11055.3 11064.2 4009.3 4042.8 4073.9 4261.6 4269.9 63089.0 63596.7 64631.4 65126.3 65863.7 9922.4 9922.7 10116.5 10127.3 10132.8 19571.6 19667.9 19799.7 19869.9 19922.4 6448.2 6588.9 6615.1 6646.5 6858.1 3542.3 3601.2 3633.0 3638.4 3668.7 2743.7 2867.5 2868.9 2869.3 2878.2 481.1 484.4 502.0 523.1 530.0 560.7 568.0 572.5 582.2 585.8 7636.5 8087.9 8373.7 8519.0 8599.0 506.4 506.9 563.2 582.7 583.5 3770.5 3786.5 3878.1 3928.5 4019.9 99180.9 102188.5 103531.8 106728.0 107471.5 88374.6 90676.0 90763.0 90991.5 91111.5 74540.3 75921.8 77829.0 81367.6 83749.2 7667.7 7672.3 7701.3 7992.1 8062.0 44255.6 44586.8 44794.8 45622.3 46086.8 64154.0 67667.7 68647.3 68924.0 69040.7 8928.0 9310.4 9450.1 9471.3 9814.5 9848.0 9907.6 9909.7 9951.7 9982.2 7542.4 7645.7 10017.3 10041.5 10267.9 10308.9 10540.7 10572.7 10795.6 10995.9 10725.4 11073.1 11341.6 11692.2 11761.8 8773.0 9538.9 9689.1 9712.1 10350.4 9552.5 10026.8 10083.7 10095.0 10108.4 08:43:25 INFO - PROCESS | 4863 | -------- Summary: end -------- 08:43:25 INFO - PROCESS | 4863 | 08:43:26 INFO - TEST-INFO | 4863: exit 0 08:43:26 INFO - TEST-OK | dromaeo_css | took 1120881ms 08:43:26 INFO - TEST-START | kraken 08:43:26 INFO - operating with platform_type : linux_ 08:43:26 INFO - Initialising browser for kraken test... 08:43:26 INFO - TEST-INFO | started process 5172 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7fUEl8/profile http://localhost:43775/getInfo.html) 08:43:30 INFO - PROCESS | 5172 | __metrics Screen width/height:1600/1200 08:43:30 INFO - PROCESS | 5172 | colorDepth:24 08:43:30 INFO - PROCESS | 5172 | Browser inner width/height: 1024/697 08:43:30 INFO - PROCESS | 5172 | __metrics 08:43:31 INFO - PROCESS | 5172 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:43:31 INFO - PROCESS | 5172 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:43:32 INFO - PROCESS | 5172 | console.error: PushService: 08:43:32 INFO - PROCESS | 5172 | stateChangeProcessEnqueue: Error transitioning state 08:43:32 INFO - PROCESS | 5172 | UnknownError 08:43:32 INFO - TEST-INFO | 5172: exit 0 08:43:32 INFO - Browser initialized. 08:43:32 INFO - Running cycle 1/1 for kraken test... 08:43:32 INFO - TEST-INFO | started process 5252 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7fUEl8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:43:44 INFO - PROCESS | 5252 | RSS: Main: 175742976 08:43:44 INFO - PROCESS | 5252 | 08:43:47 INFO - PROCESS | 5252 | Cycle 1(1): loaded http://localhost:43775/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43775/tests/kraken/driver.html?testName=audio-beat-detection) 08:43:48 INFO - PROCESS | 5252 | RSS: Main: 235548672 08:43:48 INFO - PROCESS | 5252 | 08:43:51 INFO - PROCESS | 5252 | Cycle 1(1): loaded http://localhost:43775/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43775/tests/kraken/driver.html?testName=audio-dft) 08:43:52 INFO - PROCESS | 5252 | RSS: Main: 226762752 08:43:52 INFO - PROCESS | 5252 | 08:43:55 INFO - PROCESS | 5252 | Cycle 1(1): loaded http://localhost:43775/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43775/tests/kraken/driver.html?testName=audio-fft) 08:43:56 INFO - PROCESS | 5252 | RSS: Main: 302280704 08:43:56 INFO - PROCESS | 5252 | 08:43:58 INFO - PROCESS | 5252 | Cycle 1(1): loaded http://localhost:43775/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43775/tests/kraken/driver.html?testName=audio-oscillator) 08:43:58 INFO - PROCESS | 5252 | RSS: Main: 209793024 08:43:58 INFO - PROCESS | 5252 | 08:44:01 INFO - PROCESS | 5252 | Cycle 1(1): loaded http://localhost:43775/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43775/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:44:01 INFO - PROCESS | 5252 | RSS: Main: 214413312 08:44:01 INFO - PROCESS | 5252 | 08:44:04 INFO - PROCESS | 5252 | Cycle 1(1): loaded http://localhost:43775/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43775/tests/kraken/driver.html?testName=imaging-darkroom) 08:44:05 INFO - PROCESS | 5252 | RSS: Main: 250904576 08:44:05 INFO - PROCESS | 5252 | 08:44:09 INFO - PROCESS | 5252 | Cycle 1(1): loaded http://localhost:43775/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43775/tests/kraken/driver.html?testName=imaging-desaturate) 08:44:09 INFO - PROCESS | 5252 | RSS: Main: 244133888 08:44:09 INFO - PROCESS | 5252 | 08:44:12 INFO - PROCESS | 5252 | Cycle 1(1): loaded http://localhost:43775/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43775/tests/kraken/driver.html?testName=json-parse-financial) 08:44:13 INFO - PROCESS | 5252 | RSS: Main: 247771136 08:44:13 INFO - PROCESS | 5252 | 08:44:15 INFO - PROCESS | 5252 | Cycle 1(1): loaded http://localhost:43775/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43775/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:44:15 INFO - PROCESS | 5252 | RSS: Main: 211361792 08:44:15 INFO - PROCESS | 5252 | 08:44:17 INFO - PROCESS | 5252 | Cycle 1(1): loaded http://localhost:43775/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43775/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:44:18 INFO - PROCESS | 5252 | RSS: Main: 218726400 08:44:18 INFO - PROCESS | 5252 | 08:44:20 INFO - PROCESS | 5252 | Cycle 1(1): loaded http://localhost:43775/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43775/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:44:21 INFO - PROCESS | 5252 | RSS: Main: 223313920 08:44:21 INFO - PROCESS | 5252 | 08:44:23 INFO - PROCESS | 5252 | Cycle 1(1): loaded http://localhost:43775/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43775/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:44:24 INFO - PROCESS | 5252 | RSS: Main: 218787840 08:44:24 INFO - PROCESS | 5252 | 08:44:27 INFO - PROCESS | 5252 | Cycle 1(1): loaded http://localhost:43775/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43775/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:44:28 INFO - PROCESS | 5252 | RSS: Main: 221687808 08:44:28 INFO - PROCESS | 5252 | 08:44:29 INFO - PROCESS | 5252 | Cycle 1(1): loaded http://localhost:43775/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43775/tests/kraken/driver.html?testName=ai-astar) 08:44:30 INFO - PROCESS | 5252 | RSS: Main: 273637376 08:44:30 INFO - PROCESS | 5252 | 08:44:30 INFO - PROCESS | 5252 | __start_tp_report 08:44:30 INFO - PROCESS | 5252 | _x_x_mozilla_page_load 08:44:30 INFO - PROCESS | 5252 | _x_x_mozilla_page_load_details 08:44:30 INFO - PROCESS | 5252 | |i|pagename|runs| 08:44:30 INFO - PROCESS | 5252 | |0;ai-astar;103;117;111;115;115;115;119;114;114;115 08:44:30 INFO - PROCESS | 5252 | |1;audio-beat-detection;151;127;148;193;129;152;155;124;181;124 08:44:30 INFO - PROCESS | 5252 | |2;audio-dft;161;161;161;163;164;162;163;164;163;162 08:44:30 INFO - PROCESS | 5252 | |3;audio-fft;76;74;77;170;76;76;76;120;133;75 08:44:30 INFO - PROCESS | 5252 | |4;audio-oscillator;87;94;155;87;88;86;134;86;86;147 08:44:30 INFO - PROCESS | 5252 | |5;imaging-gaussian-blur;117;116;117;117;117;117;117;117;117;117 08:44:30 INFO - PROCESS | 5252 | |6;imaging-darkroom;145;147;147;146;146;147;146;147;146;146 08:44:30 INFO - PROCESS | 5252 | |7;imaging-desaturate;96;96;95;95;96;96;96;95;95;95 08:44:30 INFO - PROCESS | 5252 | |8;json-parse-financial;64;64;66;66;66;65;66;66;65;66 08:44:30 INFO - PROCESS | 5252 | |9;json-stringify-tinderbox;66;66;66;67;65;65;66;66;67;66 08:44:30 INFO - PROCESS | 5252 | |10;stanford-crypto-aes;82;86;83;82;83;83;82;88;83;83 08:44:30 INFO - PROCESS | 5252 | |11;stanford-crypto-ccm;134;132;133;151;139;141;132;134;153;132 08:44:30 INFO - PROCESS | 5252 | |12;stanford-crypto-pbkdf2;176;176;179;173;176;176;174;176;174;175 08:44:30 INFO - PROCESS | 5252 | |13;stanford-crypto-sha256-iterative;71;70;70;69;69;70;70;71;70;68 08:44:30 INFO - PROCESS | 5252 | __end_tp_report 08:44:30 INFO - PROCESS | 5252 | __start_cc_report 08:44:30 INFO - PROCESS | 5252 | _x_x_mozilla_cycle_collect,1962 08:44:30 INFO - PROCESS | 5252 | __end_cc_report 08:44:30 INFO - PROCESS | 5252 | __startTimestamp1471880670178__endTimestamp 08:44:30 INFO - PROCESS | 5252 | 08:44:30 INFO - PROCESS | 5252 | ------- Summary: start ------- 08:44:30 INFO - PROCESS | 5252 | Number of tests: 14 08:44:30 INFO - PROCESS | 5252 | 08:44:30 INFO - PROCESS | 5252 | [#0] ai-astar Cycles:10 Average:113.80 Median:115.00 stddev:4.32 (3.8%) stddev-sans-first:2.18 08:44:30 INFO - PROCESS | 5252 | Values: 103.0 117.0 111.0 115.0 115.0 115.0 119.0 114.0 114.0 115.0 08:44:30 INFO - PROCESS | 5252 | 08:44:30 INFO - PROCESS | 5252 | [#1] audio-beat-detection Cycles:10 Average:148.40 Median:151.50 stddev:23.90 (15.8%) stddev-sans-first:25.33 08:44:30 INFO - PROCESS | 5252 | Values: 151.0 127.0 148.0 193.0 129.0 152.0 155.0 124.0 181.0 124.0 08:44:30 INFO - PROCESS | 5252 | 08:44:30 INFO - PROCESS | 5252 | [#2] audio-dft Cycles:10 Average:162.40 Median:163.00 stddev:1.17 (0.7%) stddev-sans-first:1.13 08:44:30 INFO - PROCESS | 5252 | Values: 161.0 161.0 161.0 163.0 164.0 162.0 163.0 164.0 163.0 162.0 08:44:30 INFO - PROCESS | 5252 | 08:44:30 INFO - PROCESS | 5252 | [#3] audio-fft Cycles:10 Average:95.30 Median:76.00 stddev:33.83 (44.5%) stddev-sans-first:35.16 08:44:30 INFO - PROCESS | 5252 | Values: 76.0 74.0 77.0 170.0 76.0 76.0 76.0 120.0 133.0 75.0 08:44:30 INFO - PROCESS | 5252 | 08:44:30 INFO - PROCESS | 5252 | [#4] audio-oscillator Cycles:10 Average:105.00 Median:86.50 stddev:28.37 (32.8%) stddev-sans-first:29.34 08:44:30 INFO - PROCESS | 5252 | Values: 87.0 94.0 155.0 87.0 88.0 86.0 134.0 86.0 86.0 147.0 08:44:30 INFO - PROCESS | 5252 | 08:44:30 INFO - PROCESS | 5252 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 08:44:30 INFO - PROCESS | 5252 | Values: 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 08:44:30 INFO - PROCESS | 5252 | 08:44:30 INFO - PROCESS | 5252 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.50 stddev:0.67 (0.5%) stddev-sans-first:0.53 08:44:30 INFO - PROCESS | 5252 | Values: 145.0 147.0 147.0 146.0 146.0 147.0 146.0 147.0 146.0 146.0 08:44:30 INFO - PROCESS | 5252 | 08:44:30 INFO - PROCESS | 5252 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 08:44:30 INFO - PROCESS | 5252 | Values: 96.0 96.0 95.0 95.0 96.0 96.0 96.0 95.0 95.0 95.0 08:44:30 INFO - PROCESS | 5252 | 08:44:30 INFO - PROCESS | 5252 | [#8] json-parse-financial Cycles:10 Average:65.40 Median:66.00 stddev:0.84 (1.3%) stddev-sans-first:0.73 08:44:30 INFO - PROCESS | 5252 | Values: 64.0 64.0 66.0 66.0 66.0 65.0 66.0 66.0 65.0 66.0 08:44:30 INFO - PROCESS | 5252 | 08:44:30 INFO - PROCESS | 5252 | [#9] json-stringify-tinderbox Cycles:10 Average:66.00 Median:66.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 08:44:30 INFO - PROCESS | 5252 | Values: 66.0 66.0 66.0 67.0 65.0 65.0 66.0 66.0 67.0 66.0 08:44:30 INFO - PROCESS | 5252 | 08:44:30 INFO - PROCESS | 5252 | [#10] stanford-crypto-aes Cycles:10 Average:83.50 Median:83.00 stddev:1.96 (2.4%) stddev-sans-first:2.00 08:44:30 INFO - PROCESS | 5252 | Values: 82.0 86.0 83.0 82.0 83.0 83.0 82.0 88.0 83.0 83.0 08:44:30 INFO - PROCESS | 5252 | 08:44:30 INFO - PROCESS | 5252 | [#11] stanford-crypto-ccm Cycles:10 Average:138.10 Median:136.50 stddev:7.95 (5.8%) stddev-sans-first:8.29 08:44:30 INFO - PROCESS | 5252 | Values: 134.0 132.0 133.0 151.0 139.0 141.0 132.0 134.0 153.0 132.0 08:44:30 INFO - PROCESS | 5252 | 08:44:30 INFO - PROCESS | 5252 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.50 Median:176.00 stddev:1.65 (0.9%) stddev-sans-first:1.74 08:44:30 INFO - PROCESS | 5252 | Values: 176.0 176.0 179.0 173.0 176.0 176.0 174.0 176.0 174.0 175.0 08:44:30 INFO - PROCESS | 5252 | 08:44:30 INFO - PROCESS | 5252 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.80 Median:70.00 stddev:0.92 (1.3%) stddev-sans-first:0.87 08:44:30 INFO - PROCESS | 5252 | Values: 71.0 70.0 70.0 69.0 69.0 70.0 70.0 71.0 70.0 68.0 08:44:30 INFO - PROCESS | 5252 | -------- Summary: end -------- 08:44:30 INFO - PROCESS | 5252 | 08:44:31 INFO - TEST-INFO | 5252: exit 0 08:44:31 INFO - TEST-OK | kraken | took 65026ms 08:44:31 INFO - SUITE-END | took 1185s 08:44:31 INFO - Completed test suite (00:19:46) 08:44:31 INFO - javascript benchmark 08:44:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2535.80981426393, 2582.767550920417, 2584.8578328191966, 2586.1853516142414, 2590.753878381553, 4403.515613282536, 4460.6208472279895, 4500.5949464548185, 4559.17934771741, 4577.496475387705, 4346.853201280322, 4494.595486406222, 4495.370648109268, 4523.185826551219, 4614.238650622651, 4246.214450326684, 4266.87199384019, 4273.7008409411355, 4303.419038429819, 4356.455443069616, 4280.186764514732, 4307.870763877073, 4350.434443522354, 4358.476982762073, 4359.4768627764715, 4131.834726610932, 4163.063310755056, 4174.791260436966, 4246.766427846467, 4249.128928569636, 4230.344296634026, 4244.023874508849, 4246.8725938221905, 4270.530241673413, 4294.377315289296, 4216.915661686749, 4223.91552168958, 4235.428217190671, 4241.321388577843, 4289.056407590325, 4397.538258482878, 4556.612687921531, 4593.40285762852, 4628.583427491509, 4633.582977532038, 4945.035718034985, 4975.029869175512, 4975.0796102721115, 4976.925346119811, 4986.4514903360605, 4796.160671882441, 4950.405951285833, 4995.850124496271, 5000.0999820032375, 5009.524095210985, 4588.49526552079, 4591.931121033153, 4601.263797792404, 4663.044075964419, 4704.317873908264, 5084.847454576368, 5117.078925793318, 5120.692758434506, 5131.461196574381, 5135.0, 4727.409073865767, 4881.8535443936735, 4896.069746748178, 4899.755012249373, 4906.681065730716, 4801.039792041605, 4840.782164802592, 4843.733594652257, 4918.262260660858, 4934.925976110361, 4866.294387313819, 4868.172410690191, 4872.4153101628035, 4873.439554451213, 4873.780679869415, 4711.3639658646325, 4860.513948605111, 4871.464138944713, 4874.098291815954, 4874.415070191529, 4069.2675318442966, 4102.364133559303, 4112.115895082572, 4123.092919557693, 4156.875293741193, 3618.203995121069, 3642.581103173116, 3646.9452958205648, 3648.288583726148, 3650.0327413235514, 4193.308104162779, 4289.6139347458875, 4289.871303860889, 4301.827926882952, 4305.225059489322, 4736.952630473651, 4761.428628564525, 4766.356541866804, 4810.093704421541, 4822.214561569152, 4208.116295577902, 4240.724352917051, 4240.787960601958, 4244.342126970325, 4245.702800803914, 4326.935095973563, 4378.430803995524, 4382.474103107647, 4383.890402739957, 4385.166818304512, 4674.275487299542, 4739.502352252964, 4741.075490279362, 4797.496262892346, 4799.616030717604, 4969.975150124226, 4987.326710893983, 4994.101061808909, 4996.675216110941, 5001.749912504433, 4570.063137056962, 4780.043991201704, 4783.9521604784895, 4797.64017698681, 4801.087793319258, 4773.76131193432, 4812.903741925212, 4838.225883858566, 4870.464248932543, 4891.437484689306, 4937.530934561211, 4942.28336891156, 4942.579880710036, 4944.3572335596145, 4954.603631709382, 4661.394018777537, 4809.95190048109, 4821.4696383397095, 4837.806487740451, 4846.466888642176, 4693.296005599187, 4730.597899178609, 4734.21885388907, 4798.304245884257, 4810.11012962603, 4712.198926182488, 4730.550597693214, 4731.976340118277, 4734.621230301499, 4744.430668319824, 4688.812447502198, 4830.734309613005, 4832.589229915356, 4840.0, 4840.7337596432535, 4612.723236605814, 4627.514111018295, 4639.675222734376, 4642.698224615389, 4680.882977925443], "value": 4514.13983786519, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [550.4028129479515, 555.5638823523535, 564.4581202046036, 573.3034363248652, 579.3713820504752, 28960.420791584183, 38767.61232387679, 39797.8010109949, 39898.40152397709, 44000.11999760003, 41901.371479427835, 42383.36424953621, 42412.57587424125, 42468.0, 42505.57494425055, 7683.731069412558, 7815.687372505122, 7839.529628222296, 7844.803879902991, 7848.0, 7103.8224044398785, 9826.361286516389, 10070.69787906364, 10085.596576136946, 10520.631777887775, 10031.398116113056, 10103.393796372204, 10108.140808031327, 10108.191344692406, 10134.493275336241, 9979.700608981742, 10047.648332308407, 10059.849102263472, 10063.748406289827, 10064.345817521838, 9969.700908972742, 10031.849522257173, 10046.648367307109, 10048.045435683598, 10052.64815731446, 39018.21963560713, 39180.60819391798, 39399.40900886489, 39477.802610986764, 39531.40702889459, 2967.985160074207, 2983.8955636552832, 3081.275900163482, 3262.0866157475944, 3336.6830151135846, 29215.41569168605, 30015.249618759488, 30241.395172096436, 30912.0726378209, 31488.0, 3382.2559037012065, 3390.762646614738, 3403.5915690117095, 3433.0902310887636, 3453.706434953032, 182824.0, 183312.0, 183415.99999999866, 183585.0, 184395.0, 26890.731092688824, 27880.72119278822, 52756.0, 52990.67523311871, 53093.0, 32960.340793184485, 33160.50259246113, 33298.500522492184, 33348.83325583405, 33444.33111337759, 13178.0, 13294.66763330905, 13323.866761332456, 13328.133671311527, 13341.733165336833, 9757.560909759079, 9999.550020249106, 10787.514561844735, 10859.402732849769, 10867.184961127947, 7430.888536671954, 7482.289182527651, 7539.208383119803, 7746.419018573517, 7765.844683106307, 3018.3661431099713, 3085.5988721466065, 3095.3035566997696, 3119.2201949512623, 3136.34136831268, 872.912708729122, 877.7147427086095, 888.782606962786, 934.1219253901447, 938.9859152112724, 27680.86159569189, 27931.16206513808, 28558.714412855606, 28835.71164288372, 28953.710462895102, 925.893522244937, 977.8728765260613, 1003.4781913404988, 1012.4785735346303, 1018.5467466977124, 14692.412303507954, 15328.208632842216, 15366.615834604001, 15461.690766184838, 15502.379904803907, 368770.0, 369800.0, 370265.0, 374123.0, 374688.0, 48471.27293090607, 48791.75604121957, 48801.755991220525, 48884.75557622189, 49050.0, 1143.9256448330832, 1206.2641788509002, 1206.6741979665442, 1207.3600991474532, 1208.6857417071449, 25743.227703168934, 26912.730872691805, 27509.44981100407, 27577.310567235978, 27792.722072779823, 42879.35680964726, 43098.78450607727, 43147.13705725931, 43159.78420107879, 43216.78391608148, 301362.0, 302921.0, 303202.0, 303296.0, 305191.0, 22219.888900555394, 22905.541889162458, 23140.190093346653, 24593.13924012651, 25291.241262762145, 41501.58498414977, 41797.58202417937, 41901.58098419099, 42385.36421953735, 42630.0, 34578.12171930727, 35120.824395877855, 35233.0, 35411.0, 35658.82170589131, 32410.675893240765, 35684.821575892995, 35847.82076089603, 35952.10119746922, 36302.81848590846, 34469.0, 34909.65090349064, 35697.0, 35863.46204806982, 35869.64130358663, 27447.313817153932, 28732.71267287384, 29028.419431610826, 29153.7084629151, 29755.404891902475, 24516.0, 24891.377715557257, 25222.369440763392, 25225.08110918353, 25665.230043098738], "value": 16519.175429172352, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [364.978101313921, 369.80030783376975, 373.4566206170022, 379.8244433478383, 385.918957019026, 16371.836281637181, 16503.25735341911, 17237.96572205667, 17262.654746905053, 17314.913425432856, 15587.220638968034, 16284.185790710477, 16535.751963720555, 16641.1679416029, 16644.417445389412, 4972.403311602613, 5229.660072095321, 5234.555062819665, 5236.528712415882, 5239.214117882329, 3842.923141537168, 3979.7413168143976, 5154.845354639367, 5835.44563266489, 6089.725962331683, 6195.783147589836, 6196.070589411602, 6206.441420272175, 6206.627602343851, 6210.2547694276755, 5931.970340148293, 6170.96914515429, 6174.413430724052, 6177.0, 6206.937930620727, 5264.499872512105, 5368.409474957752, 5444.7822087116465, 5452.454754524555, 5452.91820622691, 20648.0, 20910.790892091038, 21164.259250926298, 21203.36389908305, 21273.787262127335, 1972.1519746508995, 2027.341114137911, 2049.5695903860205, 2104.0, 2363.586372384843, 13026.283554404505, 13335.0, 13373.732525349536, 13417.0, 13759.79360309596, 1712.2551690014884, 1777.5289548269718, 1795.838374546284, 1802.1980218802637, 1836.9242755686123, 66262.0, 66697.66651166762, 66972.0, 67662.3233767661, 67856.0, 9553.04469553053, 9584.856227156599, 9758.853617195748, 9871.50642467888, 10016.79966400668, 13591.52429664957, 13598.04813663054, 13620.387082581308, 13621.662692640168, 13630.591082267549, 7184.281571842774, 7428.331450169402, 7525.3227209551405, 7672.0409948756405, 7673.34776544, 7086.149662040588, 7155.105611798525, 7308.378787803096, 7484.850302993909, 7486.288802563748, 6057.273127224673, 6158.7228574714245, 6221.3778622138325, 6402.135711678957, 6742.797716068526, 1608.8230294667578, 1678.211240716861, 1697.4313604942483, 1732.159902447312, 1768.3280353465857, 857.2113655437013, 893.9284857211408, 899.865020246955, 903.9954800225956, 944.2870632672426, 16574.254158562893, 16877.578060548585, 17107.071635987446, 17711.822881771273, 18019.909900450413, 858.8411143938266, 861.1947828780111, 879.4239772948729, 881.8456770065213, 892.3708785306474, 9776.0, 9885.901140988643, 10147.7463063424, 10160.593576257015, 10381.480925953672, 289496.0, 296719.0, 296936.0, 398648.0, 399225.0, 48371.0, 63069.0, 66777.66611166912, 75163.0, 78446.0, 903.9593218305192, 907.9909200908038, 924.0805398628273, 945.3760518058049, 949.8955114937352, 15751.212439377756, 15993.360265589246, 16306.0, 16439.506814795575, 16624.418145364853, 36081.81959090293, 36399.81800090983, 36720.0, 37048.814755927124, 37223.25553488861, 45369.0, 47097.293540596234, 48039.75980120077, 53680.427294962064, 55164.72417637886, 6949.3745562899585, 6973.965130174317, 7069.081019467436, 7153.213146553979, 7164.678969952771, 7518.661660225193, 10367.533460994122, 11104.333739975627, 11143.72140696489, 11185.440727963733, 7871.48835325702, 9778.75553111178, 10067.395956242648, 10228.590856365661, 10280.17758579297, 9730.75673108178, 9946.850797238192, 9985.950070249603, 10158.492075396349, 10331.276810623183, 9512.191463725661, 9780.070893265129, 9825.754356141153, 9851.950740246539, 10057.0, 6597.340265973365, 6898.758543450955, 7032.12098487689, 7088.503804733619, 7219.747308844166, 7392.630368481662, 9650.131488166098, 9700.175485083564, 9815.852762208715, 9928.8085429746], "value": 8284.736066097836, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1286.2218357893473, 1362.7410791949528, 1367.8426980897193, 1578.9654681136421, 1630.5678995066303, 6380.680965951707, 6613.338666133384, 7068.469864760144, 7636.350910172635, 7638.847223055543, 7091.539049961749, 7347.044884165064, 7350.0, 7545.773626791205, 7554.773356799291, 2169.2190811307914, 2200.064972386729, 2201.5376770878133, 2203.394066631673, 2205.7353117625908, 1857.4334827877492, 2103.442587714257, 2155.0625477917156, 2162.567486502698, 2172.1094351315965, 2169.609470295346, 2185.5628874225217, 2189.912403503858, 2193.5064610462678, 2196.7254093238344, 2107.1571371451387, 2108.11459187141, 2194.221051526701, 2198.4393979535275, 2199.7800219978035, 2112.9577408451746, 2127.9574408511744, 2132.744070711509, 2163.2644900733826, 2182.552576721784, 7402.814929626802, 7501.774946751606, 7504.849903001964, 7504.887426688604, 7508.662110205054, 4272.764997925113, 4383.649308055348, 4412.691111622188, 4417.602415782595, 4423.137488189805, 2963.6739958604535, 3063.2495038715656, 3129.264622813637, 3159.9842000790077, 3160.083575763026, 883.3816328569962, 883.5405589093635, 897.5108565831638, 937.1144268666113, 939.7885475767897, 9863.112319891172, 10218.335808172445, 10233.0, 10660.307080039773, 10668.466576671135, 3890.435886796399, 3962.8612998544913, 4076.062505623664, 4079.3065178919655, 4101.5488296287385, 7852.175521570267, 7852.332551733167, 7852.528848269122, 7859.803504912308, 7860.174681658458, 4447.066116115588, 4464.977675111603, 4482.462104547475, 4493.438320209973, 4519.276915693539, 4044.5955404459905, 4134.214499245134, 4144.834206631761, 4145.025918909054, 4147.419361289422, 3255.3326568053494, 3319.7676162668863, 3371.32573485299, 3379.915502112467, 3492.2666240089357, 967.385710074108, 1028.1620479309338, 1070.4808168038496, 1177.4583691501834, 1235.3823088455772, 779.2947382618626, 819.3199644295221, 819.512390127873, 823.8228780812154, 825.5830805443213, 4885.340479035356, 4931.679440836334, 4991.575716064102, 5024.397072351341, 5282.31329927107, 854.594067817794, 871.0766587417231, 882.5543100734088, 892.5849479991834, 917.7338571814232, 3326.7837590556537, 3348.397288488047, 3442.087846720621, 3450.102973226979, 3562.98218508911, 9216.709660647515, 9662.323637345318, 9670.032996700274, 9672.516374181263, 9697.369670971364, 9503.192228660502, 9507.286953478517, 9513.143817056498, 9516.429014259167, 9549.427034377959, 6980.883058710683, 7103.573785572882, 7110.751123710749, 7260.165081015645, 7314.0, 5040.974795126001, 5048.72232027242, 5068.695878247317, 5105.387353517602, 5290.6032047597355, 8899.777505562413, 8910.777230569287, 8986.68546600866, 9000.459972401677, 9007.369484136048, 8554.91445085541, 8931.151540603632, 8937.150970657776, 9070.773230669287, 9150.22223111043, 6361.109444677656, 6466.579672321284, 6475.870482590416, 6491.707873145814, 6505.251896032017, 7281.854362912606, 7310.6710198040155, 7348.228436014141, 7350.926490735024, 7352.742654007084, 6639.601623902581, 6699.564528305645, 6752.628605426748, 6754.649070185884, 6988.965055174692, 6295.559310848196, 6358.332375100733, 6368.681565921778, 6435.002574600944, 6522.21733391996, 5924.614900031656, 5972.25346831646, 5975.223220981245, 5978.0, 5988.161657367885, 4220.873373798791, 4221.767802770877, 4227.471566054243, 4347.434833471629, 4423.734575925455, 4418.690691651682, 4427.092446048617, 4485.304777759453, 4496.0, 4524.660650451164], "value": 4018.534350483782, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [298.351086387108, 306.6029491808108, 308.1725566852999, 310.3637543036774, 312.86390420167214, 4722.622190224783, 4770.7853146608395, 4782.904341913159, 4799.824043109443, 4801.590870481962, 4614.307853821929, 4675.976620116895, 4694.929576056354, 4698.778317637413, 4701.623870090393, 3474.4788281757687, 3613.765105268162, 3672.2288319452946, 3722.7952462614544, 3725.5343082114737, 3721.8511259549587, 3738.7756734595873, 3743.5133432653715, 3760.454734063559, 3773.9622603774023, 3707.2400157967554, 3712.1462063725357, 3727.1241258304412, 3736.327461057009, 3741.850325986957, 3540.7875527468436, 3607.240461047301, 3726.832292546842, 3732.861477249438, 3736.701063914894, 3315.1877789941377, 3319.336132773455, 3320.435525960568, 3323.5180898769786, 3363.6790614476176, 4551.431071116111, 4564.520725323827, 4568.931466028012, 4576.244919588264, 4598.2642777155825, 4109.712320137592, 4198.790060496994, 4216.241076606209, 4235.343521754133, 4241.957580424187, 4831.178699621073, 4838.830640927586, 4842.903141937141, 4849.927251091236, 4855.810326470002, 3579.1410061585293, 3591.407417776064, 3594.982025089884, 3596.29872174926, 3598.5501812273465, 5052.520010598987, 5060.569851562622, 5068.0, 5120.745417372767, 5128.82025139318, 3527.312174126072, 3681.3189559931498, 3700.5374328208973, 3709.3137769512728, 3713.72147088964, 3734.7198960078103, 3741.3826718591126, 3744.9812750936617, 3745.6254374562873, 3750.0, 4245.469316335458, 4246.4691913510815, 4252.383404406344, 4259.233337999128, 4266.935995960063, 4722.716637001791, 4895.339129217581, 4918.3360246367, 4925.236588328815, 4939.604831613462, 1283.9293838838767, 1285.7942729163476, 1291.709365392798, 1297.4430683180221, 1302.1536001598847, 808.016319934571, 832.4630613254417, 842.0, 844.8563744163507, 851.5401683091185, 4230.386593943923, 4284.957150428519, 4410.274331644204, 4429.379886815848, 4455.866324010285, 5046.139703127111, 5047.570956468741, 5048.1418158913075, 5062.443131255559, 5062.531865758962, 4402.723210268986, 4418.403515525363, 4420.093880754438, 4423.18171138334, 4431.977840110779, 2568.4734629400928, 2682.919512414631, 2688.647433495691, 2691.734884604233, 2702.9324266893486, 4879.536444037811, 4907.411110666742, 4911.901761964741, 4921.753912304442, 4925.8029678812445, 5208.296879921162, 5215.921761173586, 5228.163493840967, 5229.764660590283, 5231.1228824146565, 4618.261078227468, 4871.878203044881, 4915.631327650441, 4923.359963204761, 4941.53055459738, 5100.69395836251, 5116.69748613133, 5128.974355128201, 5130.4100028497205, 5187.351581052369, 4845.781939812788, 5052.065367906949, 5053.469385714447, 5068.29043933857, 5114.744262786771, 4870.8310005599105, 4873.317735517101, 4875.975620121877, 4888.144574699484, 4929.433115191656, 3595.9820200899876, 3599.9460008099377, 3622.4385220290897, 3643.289558536166, 3656.3601369759654, 5131.384233891957, 5141.845744627667, 5176.757578181285, 5180.114913814639, 5189.065968125774, 4741.0, 4938.185199442196, 4949.6287778416045, 4953.439666505039, 4973.875653108701, 4911.361523001987, 4914.975425122851, 4921.212605983025, 4939.753012349296, 4967.304577359245, 4867.58625516835, 4871.780769865293, 4877.756112194447, 4897.608191344755, 4900.436449808318, 4689.7655117244685, 4749.382580264543, 4837.105135549935, 4920.606351491943, 4939.950600494093, 4859.684120532154, 4860.198067318853, 4860.708357498562, 4861.611071114373, 4905.705657660552], "value": 3752.5907596945553, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [564.5201578658139, 586.5542187937168, 633.727497176214, 649.5680372552252, 658.2258494271362, 12415.68960775981, 12828.486860525567, 12862.807057894139, 13599.388027538773, 13621.0, 13423.328833558307, 13695.041347105707, 13710.45158193671, 13720.862791372083, 13731.656708582266, 628.4846425930739, 743.3272888036336, 755.2334380603692, 757.5719718359137, 757.6779868555869, 738.4350971506775, 761.3908872901684, 761.4289283037722, 761.5659074327635, 765.5368502056232, 807.0799288810761, 810.3719617296583, 811.0753740735566, 811.37524106438, 814.3200427642926, 648.9318621544764, 795.8726603743402, 798.8681867491857, 799.1848314718983, 799.588212070784, 567.3078843810586, 585.4584509328896, 587.1515659871487, 588.5027152056506, 588.9852753681149, 12701.428435720414, 12722.872771272354, 12736.554220602235, 12743.044271679568, 12764.0, 12241.69395765113, 12614.0, 12831.807522887164, 13056.634247743063, 13115.409806558728, 10687.358758474438, 10694.321713315547, 11010.339379637247, 11055.336679799238, 11064.17018723591, 4009.278329900617, 4042.818073186684, 4073.9185216295805, 4261.616454519077, 4269.87190384289, 63089.0, 63596.682016590086, 64631.353686463, 65126.348736512504, 65863.67068164676, 9922.40465572068, 9922.652707155215, 10116.494175291353, 10127.341722788142, 10132.848007279898, 19571.608567828564, 19667.901660491607, 19799.703004454946, 19869.900650496656, 19922.402327929896, 6448.226212854487, 6588.934110658832, 6615.140031795932, 6646.468282537386, 6858.142732158481, 3542.291541691672, 3601.1897323102617, 3632.9636703632627, 3638.381475149231, 3668.706503479715, 2743.7393447622444, 2867.5411934090444, 2868.899588514392, 2869.297022229567, 2878.150945471091, 481.0859367202344, 484.4283745180721, 501.967372120811, 523.071548002299, 529.9682019078867, 560.733651515535, 567.9914801277985, 572.4962033410573, 582.1733138942711, 585.7828120563646, 7636.465447418738, 8087.878681819778, 8373.748787536384, 8518.957405212934, 8599.0, 506.4176197373051, 506.8606133313368, 563.1890078287254, 582.6853499110517, 583.5098517245449, 3770.472133901256, 3786.469894214812, 3878.127421330178, 3928.4500169976227, 4019.8995025124023, 99180.91079536747, 102188.48905755424, 103531.78809271318, 106728.0, 107471.46264268785, 88374.55812720895, 90676.0, 90763.0, 90991.54504227568, 91111.54444227736, 74540.25459745442, 75921.78743019405, 77829.0, 81367.59316203381, 83749.16250837657, 7667.693292268247, 7672.309492145734, 7701.345385642059, 7992.120866704774, 8062.0, 44255.557444426435, 44586.77706611446, 44794.77602611966, 45622.31566526571, 46086.769566151954, 64154.0, 67667.66166169138, 68647.31352686608, 68924.0, 69040.65479672569, 8928.0, 9310.394824336396, 9450.149486546245, 9471.289653275893, 9814.509274536387, 9848.0, 9907.554160062671, 9909.65316213929, 9951.651692190739, 9982.201423885926, 7542.388522799325, 7645.720671282829, 10017.298789084694, 10041.548130334006, 10267.897321026694, 10308.948455257676, 10540.736481588021, 10572.682819515427, 10795.6221532246, 10995.945020274847, 10725.356478610996, 11073.11415086775, 11341.603043893425, 11692.240004399688, 11761.823572646588, 8772.956135219283, 9538.904610953801, 9689.12797848197, 9712.125908668253, 10350.378977261389, 9552.474613896302, 10026.849597256192, 10083.747906302402, 10095.0, 10108.444035578113], "value": 6431.0968641961545, "unit": "score"}], "name": "dromaeo_css", "value": 6255.508412540756, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 117.0, 111.0, 115.0, 115.0, 115.0, 119.0, 114.0, 114.0, 115.0], "value": 113.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 127.0, 148.0, 193.0, 129.0, 152.0, 155.0, 124.0, 181.0, 124.0], "value": 148.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 163.0, 164.0, 162.0, 163.0, 164.0, 163.0, 162.0], "value": 162.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 77.0, 170.0, 76.0, 76.0, 76.0, 120.0, 133.0, 75.0], "value": 95.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 94.0, 155.0, 87.0, 88.0, 86.0, 134.0, 86.0, 86.0, 147.0], "value": 105.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 147.0, 147.0, 146.0, 146.0, 147.0, 146.0, 147.0, 146.0, 146.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 95.0, 96.0, 96.0, 96.0, 95.0, 95.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 66.0, 66.0, 66.0, 65.0, 66.0, 66.0, 65.0, 66.0], "value": 65.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 67.0, 65.0, 65.0, 66.0, 66.0, 67.0, 66.0], "value": 66.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 86.0, 83.0, 82.0, 83.0, 83.0, 82.0, 88.0, 83.0, 83.0], "value": 83.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 132.0, 133.0, 151.0, 139.0, 141.0, 132.0, 134.0, 153.0, 132.0], "value": 138.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 176.0, 179.0, 173.0, 176.0, 176.0, 174.0, 176.0, 174.0, 175.0], "value": 175.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 70.0, 70.0, 69.0, 69.0, 70.0, 70.0, 71.0, 70.0, 68.0], "value": 69.8, "unit": "score"}], "name": "kraken", "value": 1581.8999999999999, "alertThreshold": 2.0}]} 08:44:31 INFO - Return code: 0 08:44:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:44:31 INFO - # TBPL SUCCESS # 08:44:31 INFO - Running post-action listener: _resource_record_post_action 08:44:31 INFO - [mozharness: 2016-08-22 15:44:31.993097Z] Finished run-tests step (success) 08:44:31 INFO - Running post-run listener: _resource_record_post_run 08:44:32 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 0; Write bytes: 406388736; Read time: 0; Write time: 233852 08:44:32 INFO - TinderboxPrint: CPU usage
13.2% 08:44:32 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 08:44:32 INFO - TinderboxPrint: I/O write bytes / time
406,388,736 / 233,852 08:44:32 INFO - TinderboxPrint: CPU idle
8,327.6 (86.8%) 08:44:32 INFO - TinderboxPrint: CPU user
1,205.6 (12.6%) 08:44:32 INFO - TinderboxPrint: Swap in / out
0 / 0 08:44:32 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 114282496; Read time: 0; Write time: 91012 08:44:32 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 0; Write bytes: 292106240; Read time: 0; Write time: 142840 08:44:32 INFO - Running post-run listener: _upload_blobber_files 08:44:32 INFO - Blob upload gear active. 08:44:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:44:32 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 08:44:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Autoland-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:44:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Autoland-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:44:33 INFO - (blobuploader) - INFO - Open directory for files ... 08:44:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:44:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:44:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:44:36 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:44:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:44:36 INFO - (blobuploader) - INFO - Done attempting. 08:44:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:44:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:44:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:44:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:44:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:44:37 INFO - (blobuploader) - INFO - Done attempting. 08:44:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:44:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:44:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:44:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:44:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:44:38 INFO - (blobuploader) - INFO - Done attempting. 08:44:38 INFO - (blobuploader) - INFO - Iteration through files over. 08:44:38 INFO - Return code: 0 08:44:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:44:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:44:38 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/c9afbac4a6ea6b641ccf617e3968fc9ea7e60fe42144929f8154bb06b7cf240677202f2fd9bdbe740771dc3d520589d7bbb915d1ca1871beee5ef8415c5e17e2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/1f0dfbc208a3f4f6f113038c0f85fc854d542fbdf1dead72ea2406d9bfa4d6508d847d0d120442e33edef8661b6de44cd54384d0a38c87d59ee9940603723225", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/0198a6084137101de6047d91e35407b2ea54ef510edbc28c8a54d16c5377d014296b95e1d9899d32066871707cba55494354e0488d801245b8d54bf9c6f9bf64"} 08:44:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:44:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:44:38 INFO - Contents: 08:44:38 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/c9afbac4a6ea6b641ccf617e3968fc9ea7e60fe42144929f8154bb06b7cf240677202f2fd9bdbe740771dc3d520589d7bbb915d1ca1871beee5ef8415c5e17e2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/1f0dfbc208a3f4f6f113038c0f85fc854d542fbdf1dead72ea2406d9bfa4d6508d847d0d120442e33edef8661b6de44cd54384d0a38c87d59ee9940603723225", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/0198a6084137101de6047d91e35407b2ea54ef510edbc28c8a54d16c5377d014296b95e1d9899d32066871707cba55494354e0488d801245b8d54bf9c6f9bf64"} 08:44:38 INFO - Running post-run listener: copy_logs_to_upload_dir 08:44:38 INFO - Copying logs to upload dir... 08:44:38 INFO - mkdir: /builds/slave/test/build/upload/logs 08:44:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.948069 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-08-22 08:44:38.096311) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-22 08:44:38.099416) ========= 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=41a7e32711b8e08598a63237000001d6-1471879388.635933-1266655020 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/c9afbac4a6ea6b641ccf617e3968fc9ea7e60fe42144929f8154bb06b7cf240677202f2fd9bdbe740771dc3d520589d7bbb915d1ca1871beee5ef8415c5e17e2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/1f0dfbc208a3f4f6f113038c0f85fc854d542fbdf1dead72ea2406d9bfa4d6508d847d0d120442e33edef8661b6de44cd54384d0a38c87d59ee9940603723225", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/0198a6084137101de6047d91e35407b2ea54ef510edbc28c8a54d16c5377d014296b95e1d9899d32066871707cba55494354e0488d801245b8d54bf9c6f9bf64"} build_url:https://queue.taskcluster.net/v1/task/cexWBkXNRqaa8lA5AbWN2w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011141 build_url: 'https://queue.taskcluster.net/v1/task/cexWBkXNRqaa8lA5AbWN2w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/c9afbac4a6ea6b641ccf617e3968fc9ea7e60fe42144929f8154bb06b7cf240677202f2fd9bdbe740771dc3d520589d7bbb915d1ca1871beee5ef8415c5e17e2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/1f0dfbc208a3f4f6f113038c0f85fc854d542fbdf1dead72ea2406d9bfa4d6508d847d0d120442e33edef8661b6de44cd54384d0a38c87d59ee9940603723225", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/0198a6084137101de6047d91e35407b2ea54ef510edbc28c8a54d16c5377d014296b95e1d9899d32066871707cba55494354e0488d801245b8d54bf9c6f9bf64"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-22 08:44:38.124482) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 08:44:38.124809) ========= 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=41a7e32711b8e08598a63237000001d6-1471879388.635933-1266655020 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004444 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 08:44:38.210164) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-22 08:44:38.210501) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-22 08:44:38.210821) ========= ========= Total master_lag: 0.17 =========