builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-049 starttime: 1476300868.43 results: success (0) buildid: 20161012110947 builduid: 5a4e8e270cc04be291230de5a4d9ecc1 revision: 7cb958b68c84f4880c2ed7d73ac2285da86697a3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-12 12:34:28.428092) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-12 12:34:28.428600) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-12 12:34:28.428932) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-12 12:34:28.444091) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 12:34:28.444749) ========= 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=db7e7c15f3ca076d53731445000001ba-1476300867.823101-1744932873 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-12 12:34:28-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.9M=0s 2016-10-12 12:34:28 (46.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.122362 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 12:34:28.586217) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 12:34:28.586938) ========= 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=db7e7c15f3ca076d53731445000001ba-1476300867.823101-1744932873 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016825 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 12:34:28.637774) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 12:34:28.638156) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 7cb958b68c84f4880c2ed7d73ac2285da86697a3 --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 7cb958b68c84f4880c2ed7d73ac2285da86697a3 --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=db7e7c15f3ca076d53731445000001ba-1476300867.823101-1744932873 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-12 12:34:28,842 truncating revision to first 12 chars 2016-10-12 12:34:28,843 Setting DEBUG logging. 2016-10-12 12:34:28,843 attempt 1/10 2016-10-12 12:34:28,843 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/7cb958b68c84?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-12 12:34:29,279 unpacking tar archive at: autoland-7cb958b68c84/testing/mozharness/ program finished with exit code 0 elapsedTime=0.772855 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 12:34:29.425086) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-12 12:34:29.425446) ========= script_repo_revision: 7cb958b68c84f4880c2ed7d73ac2285da86697a3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-12 12:34:29.425939) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-12 12:34:29.426243) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-12 12:34:29.435945) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-10-12 12:34:29.436251) ========= /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=db7e7c15f3ca076d53731445000001ba-1476300867.823101-1744932873 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:34:29 INFO - MultiFileLogger online at 20161012 12:34:29 in /builds/slave/test 12:34:29 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 12:34:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:34:29 INFO - {'append_to_log': False, 12:34:29 INFO - 'base_work_dir': '/builds/slave/test', 12:34:29 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 12:34:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:34:29 INFO - 'branch': 'Autoland-Non-PGO', 12:34:29 INFO - 'buildbot_json_path': 'buildprops.json', 12:34:29 INFO - 'config_files': ('talos/linux_config.py',), 12:34:29 INFO - 'default_actions': ('clobber', 12:34:29 INFO - 'read-buildbot-config', 12:34:29 INFO - 'download-and-extract', 12:34:29 INFO - 'populate-webroot', 12:34:29 INFO - 'create-virtualenv', 12:34:29 INFO - 'install', 12:34:29 INFO - 'run-tests'), 12:34:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:34:29 INFO - 'download_minidump_stackwalk': True, 12:34:29 INFO - 'download_symbols': 'ondemand', 12:34:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:34:29 INFO - 'tooltool.py': '/tools/tooltool.py', 12:34:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:34:29 INFO - '/tools/misc-python/virtualenv.py')}, 12:34:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:34:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:34:29 INFO - 'installer_path': 'installer.exe', 12:34:29 INFO - 'log_level': 'info', 12:34:29 INFO - 'log_name': 'talos', 12:34:29 INFO - 'log_to_console': True, 12:34:29 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:34:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:34:29 INFO - 'opt_config_files': (), 12:34:29 INFO - 'pip_index': False, 12:34:29 INFO - 'sps_profile': False, 12:34:29 INFO - 'sps_profile_interval': 0, 12:34:29 INFO - 'suite': 'dromaeojs', 12:34:29 INFO - 'system_bits': '32', 12:34:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:34:29 INFO - 'title': 'talos-linux64-ix-049', 12:34:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:34:29 INFO - 'use_talos_json': True, 12:34:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:34:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:34:29 INFO - 'work_dir': 'build'} 12:34:29 INFO - [mozharness: 2016-10-12 19:34:29.744926Z] Running clobber step. 12:34:29 INFO - Running pre-action listener: _resource_record_pre_action 12:34:29 INFO - Running main action method: clobber 12:34:29 INFO - rmtree: /builds/slave/test/build 12:34:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:34:30 INFO - Running post-action listener: _resource_record_post_action 12:34:30 INFO - [mozharness: 2016-10-12 19:34:30.726846Z] Finished clobber step (success) 12:34:30 INFO - [mozharness: 2016-10-12 19:34:30.726945Z] Running read-buildbot-config step. 12:34:30 INFO - Running pre-action listener: _resource_record_pre_action 12:34:30 INFO - Running main action method: read_buildbot_config 12:34:30 INFO - Using buildbot properties: 12:34:30 INFO - { 12:34:30 INFO - "project": "", 12:34:30 INFO - "product": "firefox", 12:34:30 INFO - "script_repo_revision": "production", 12:34:30 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 12:34:30 INFO - "repository": "", 12:34:30 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 12:34:30 INFO - "buildid": "20161012110947", 12:34:30 INFO - "pgo_build": "False", 12:34:30 INFO - "basedir": "/builds/slave/test", 12:34:30 INFO - "buildnumber": 792, 12:34:30 INFO - "slavename": "talos-linux64-ix-049", 12:34:30 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 12:34:30 INFO - "platform": "ubuntu64_hw", 12:34:30 INFO - "scheduler": "tests-autoland-linux64-talos", 12:34:30 INFO - "branch": "autoland", 12:34:30 INFO - "repo_path": "integration/autoland", 12:34:30 INFO - "revision": "7cb958b68c84f4880c2ed7d73ac2285da86697a3", 12:34:30 INFO - "stage_platform": "linux64", 12:34:30 INFO - "builduid": "5a4e8e270cc04be291230de5a4d9ecc1", 12:34:30 INFO - "slavebuilddir": "test" 12:34:30 INFO - } 12:34:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/ahOzpdOATQ-VfLPVgGLszQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 12:34:30 INFO - Running post-action listener: _resource_record_post_action 12:34:30 INFO - [mozharness: 2016-10-12 19:34:30.729376Z] Finished read-buildbot-config step (success) 12:34:30 INFO - [mozharness: 2016-10-12 19:34:30.729473Z] Running download-and-extract step. 12:34:30 INFO - Running pre-action listener: _resource_record_pre_action 12:34:30 INFO - Running main action method: download_and_extract 12:34:30 INFO - mkdir: /builds/slave/test/build/tests 12:34:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:34:30 INFO - trying https://queue.taskcluster.net/v1/task/ahOzpdOATQ-VfLPVgGLszQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 12:34:30 INFO - Downloading https://queue.taskcluster.net/v1/task/ahOzpdOATQ-VfLPVgGLszQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 12:34:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ahOzpdOATQ-VfLPVgGLszQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 12:34:31 INFO - Downloaded 1361 bytes. 12:34:31 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 12:34:31 INFO - Using the following test package requirements: 12:34:31 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 12:34:31 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:34:31 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:34:31 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:34:31 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 12:34:31 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:34:31 INFO - u'jsshell-linux-x86_64.zip'], 12:34:31 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:34:31 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:34:31 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 12:34:31 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:34:31 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:34:31 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:34:31 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:34:31 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:34:31 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:34:31 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:34:31 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:34:31 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:34:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ahOzpdOATQ-VfLPVgGLszQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 12:34:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ahOzpdOATQ-VfLPVgGLszQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:34:31 INFO - Fetch https://queue.taskcluster.net/v1/task/ahOzpdOATQ-VfLPVgGLszQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 12:34:32 INFO - Http code: 200 12:34:32 INFO - via: 1.1 9baadab4e4d95afe7af7bcba342b29c6.cloudfront.net (CloudFront) 12:34:32 INFO - x-amz-cf-id: RgKHM76TFyQBln8QJqTaImY6byfdG7Yh213tJC_q7YrLZJdwYljvvA== 12:34:32 INFO - x-amz-version-id: Smk6JaVALMdSEWE1LFcP0Y4HPnkyRPqS 12:34:32 INFO - Expected file size: 20547860 12:34:32 INFO - Obtained file size: 20547860 12:34:36 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 12:34:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ahOzpdOATQ-VfLPVgGLszQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 12:34:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ahOzpdOATQ-VfLPVgGLszQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:34:36 INFO - Fetch https://queue.taskcluster.net/v1/task/ahOzpdOATQ-VfLPVgGLszQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 12:34:36 INFO - Http code: 200 12:34:36 INFO - via: 1.1 e1eb7447ab46f530f6009f1d93917c54.cloudfront.net (CloudFront) 12:34:36 INFO - x-amz-cf-id: nEuCNfpTo1FjU53wkbnPrH9_3hLuTZlCMXpqR4hmXdk9EF-xiZ5sWQ== 12:34:36 INFO - x-amz-version-id: Smk6JaVALMdSEWE1LFcP0Y4HPnkyRPqS 12:34:37 INFO - Expected file size: 20547860 12:34:37 INFO - Obtained file size: 20547860 12:34:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ahOzpdOATQ-VfLPVgGLszQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 12:34:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ahOzpdOATQ-VfLPVgGLszQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 12:34:41 INFO - Fetch https://queue.taskcluster.net/v1/task/ahOzpdOATQ-VfLPVgGLszQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 12:34:42 INFO - Http code: 200 12:34:42 INFO - via: 1.1 ff555a0cc6346f82fe74596f8ed6cc33.cloudfront.net (CloudFront) 12:34:42 INFO - x-amz-cf-id: dC3QEZ_tj9TwtdVRxhNA3ivnM2W5Du-u7aw5XtB7vWUU5SDcAkAoFg== 12:34:42 INFO - x-amz-version-id: OVO.0n58s.L7ffZAkaxzzGiAGGJiAGae 12:34:42 INFO - Expected file size: 14409006 12:34:42 INFO - Obtained file size: 14409006 12:34:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:34:42 INFO - trying https://queue.taskcluster.net/v1/task/ahOzpdOATQ-VfLPVgGLszQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 12:34:42 INFO - Downloading https://queue.taskcluster.net/v1/task/ahOzpdOATQ-VfLPVgGLszQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 12:34:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ahOzpdOATQ-VfLPVgGLszQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 12:34:43 INFO - Downloaded 55928166 bytes. 12:34:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ahOzpdOATQ-VfLPVgGLszQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 12:34:43 INFO - mkdir: /builds/slave/test/properties 12:34:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:34:43 INFO - Writing to file /builds/slave/test/properties/build_url 12:34:43 INFO - Contents: 12:34:43 INFO - build_url:https://queue.taskcluster.net/v1/task/ahOzpdOATQ-VfLPVgGLszQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 12:34:44 INFO - Running post-action listener: _resource_record_post_action 12:34:44 INFO - Running post-action listener: set_extra_try_arguments 12:34:44 INFO - [mozharness: 2016-10-12 19:34:44.341118Z] Finished download-and-extract step (success) 12:34:44 INFO - [mozharness: 2016-10-12 19:34:44.341344Z] Running populate-webroot step. 12:34:44 INFO - Running pre-action listener: _resource_record_pre_action 12:34:44 INFO - Running main action method: populate_webroot 12:34:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:34:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:34:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:34:44 INFO - '--tppagecycles', 12:34:44 INFO - '7'], 12:34:44 INFO - 'tests': ['tsvgm']}}, 12:34:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:34:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:34:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:34:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:34:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:34:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:34:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:34:44 INFO - 'talos_options': ['--disable-e10s'], 12:34:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:34:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:34:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:34:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:34:44 INFO - 'talos_options': ['--disable-e10s'], 12:34:44 INFO - 'tests': ['damp', 'tps']}, 12:34:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:34:44 INFO - 'tests': ['damp', 'tps']}, 12:34:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:34:44 INFO - 'tests': ['dromaeo_dom']}, 12:34:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:34:44 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:34:44 INFO - 'tests': ['basic_compositor_video']}, 12:34:44 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:34:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:34:44 INFO - 'tests': ['a11yr', 12:34:44 INFO - 'ts_paint', 12:34:44 INFO - 'tpaint', 12:34:44 INFO - 'sessionrestore', 12:34:44 INFO - 'sessionrestore_no_auto_restore', 12:34:44 INFO - 'tabpaint']}, 12:34:44 INFO - 'other-e10s': {'tests': ['a11yr', 12:34:44 INFO - 'ts_paint', 12:34:44 INFO - 'tpaint', 12:34:44 INFO - 'sessionrestore', 12:34:44 INFO - 'sessionrestore_no_auto_restore', 12:34:44 INFO - 'tabpaint']}, 12:34:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:34:44 INFO - 'ts_paint', 12:34:44 INFO - 'tpaint', 12:34:44 INFO - 'sessionrestore', 12:34:44 INFO - 'sessionrestore_no_auto_restore', 12:34:44 INFO - 'tabpaint']}, 12:34:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:34:44 INFO - 'ts_paint', 12:34:44 INFO - 'tpaint', 12:34:44 INFO - 'sessionrestore', 12:34:44 INFO - 'sessionrestore_no_auto_restore', 12:34:44 INFO - 'tabpaint']}, 12:34:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:34:44 INFO - 'tests': ['a11yr', 12:34:44 INFO - 'ts_paint', 12:34:44 INFO - 'tpaint', 12:34:44 INFO - 'sessionrestore', 12:34:44 INFO - 'sessionrestore_no_auto_restore', 12:34:44 INFO - 'tabpaint']}, 12:34:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:34:44 INFO - 'tests': ['a11yr', 12:34:44 INFO - 'ts_paint', 12:34:44 INFO - 'tpaint', 12:34:44 INFO - 'sessionrestore', 12:34:44 INFO - 'sessionrestore_no_auto_restore', 12:34:44 INFO - 'tabpaint']}, 12:34:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:34:44 INFO - 'tests': ['tsvgx', 12:34:44 INFO - 'tsvgr_opacity', 12:34:44 INFO - 'tart', 12:34:44 INFO - 'tscrollx', 12:34:44 INFO - 'cart']}, 12:34:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:34:44 INFO - 'tsvgr_opacity', 12:34:44 INFO - 'tart', 12:34:44 INFO - 'tscrollx', 12:34:44 INFO - 'cart']}, 12:34:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:34:44 INFO - 'talos_options': ['--disable-e10s'], 12:34:44 INFO - 'tests': ['tp5o']}, 12:34:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:34:44 INFO - 'tests': ['tp5o']}, 12:34:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:34:44 INFO - 'talos_options': ['--disable-e10s', 12:34:44 INFO - '--xperf_path', 12:34:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:34:44 INFO - 'tests': ['tp5n']}, 12:34:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:34:44 INFO - 'talos_options': ['--xperf_path', 12:34:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:34:44 INFO - 'tests': ['tp5n']}}, 12:34:44 INFO - 'talos.zip': {'path': '', 12:34:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:34:44 INFO - Running post-action listener: _resource_record_post_action 12:34:44 INFO - [mozharness: 2016-10-12 19:34:44.357423Z] Finished populate-webroot step (success) 12:34:44 INFO - [mozharness: 2016-10-12 19:34:44.357531Z] Running create-virtualenv step. 12:34:44 INFO - Running pre-action listener: _resource_record_pre_action 12:34:44 INFO - Running main action method: create_virtualenv 12:34:44 INFO - Creating virtualenv /builds/slave/test/build/venv 12:34:44 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 12:34:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:34:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:34:44 INFO - Using real prefix '/usr' 12:34:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:34:44 INFO - Installing distribute.............................................................................................................................................................................................done. 12:34:46 INFO - Installing pip.................done. 12:34:46 INFO - Return code: 0 12:34:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 12:34:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 12:34:47 INFO - Reading from file tmpfile_stdout 12:34:47 INFO - Output received: 12:34:47 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 12:34:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:34:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:34:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:34:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:34:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:34:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:34:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:34:47 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 0x7f0f16042f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24dc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a6f60>, '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 0x25a7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a81d0>, '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': 'db7e7c15f3ca076d53731445000001ba-1476300867.823101-1744932873', '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 12:34:47 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 12:34:47 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 12:34:47 INFO - Using env: {'DISPLAY': ':0', 12:34:47 INFO - 'HOME': '/home/cltbld', 12:34:47 INFO - 'LANG': 'en_US.UTF-8', 12:34:47 INFO - 'LANGUAGE': 'en_US:en', 12:34:47 INFO - 'LOGNAME': 'cltbld', 12:34:47 INFO - 'MAIL': '/var/mail/cltbld', 12:34:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:34:47 INFO - 'MOZ_NO_REMOTE': '1', 12:34:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:34:47 INFO - 'NO_EM_RESTART': '1', 12:34:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:34:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:34:47 INFO - 'PWD': '/builds/slave/test', 12:34:47 INFO - 'SHELL': '/bin/bash', 12:34:47 INFO - 'SHLVL': '1', 12:34:47 INFO - 'TERM': 'linux', 12:34:47 INFO - 'TMOUT': '86400', 12:34:47 INFO - 'USER': 'cltbld', 12:34:47 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1476300867.823101-1744932873', 12:34:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:34:47 INFO - '_': '/tools/buildbot/bin/python'} 12:34:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:34:47 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 12:34:47 INFO - Cleaning up... 12:34:47 INFO - Return code: 0 12:34:47 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:34:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:34:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:34:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:34:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:34:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:34:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:34:47 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 0x7f0f16042f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24dc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a6f60>, '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 0x25a7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a81d0>, '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': 'db7e7c15f3ca076d53731445000001ba-1476300867.823101-1744932873', '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 12:34:47 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 12:34:47 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 12:34:47 INFO - Using env: {'DISPLAY': ':0', 12:34:47 INFO - 'HOME': '/home/cltbld', 12:34:47 INFO - 'LANG': 'en_US.UTF-8', 12:34:47 INFO - 'LANGUAGE': 'en_US:en', 12:34:47 INFO - 'LOGNAME': 'cltbld', 12:34:47 INFO - 'MAIL': '/var/mail/cltbld', 12:34:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:34:47 INFO - 'MOZ_NO_REMOTE': '1', 12:34:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:34:47 INFO - 'NO_EM_RESTART': '1', 12:34:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:34:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:34:47 INFO - 'PWD': '/builds/slave/test', 12:34:47 INFO - 'SHELL': '/bin/bash', 12:34:47 INFO - 'SHLVL': '1', 12:34:47 INFO - 'TERM': 'linux', 12:34:47 INFO - 'TMOUT': '86400', 12:34:47 INFO - 'USER': 'cltbld', 12:34:47 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1476300867.823101-1744932873', 12:34:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:34:47 INFO - '_': '/tools/buildbot/bin/python'} 12:34:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:34:47 INFO - Downloading/unpacking psutil>=3.1.1 12:34:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:34:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:34:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:34:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:34:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:34:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:34:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:34:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:34:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:34:49 INFO - Installing collected packages: psutil 12:34:49 INFO - Running setup.py install for psutil 12:34:49 INFO - building 'psutil._psutil_linux' extension 12:34:49 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 12:34:49 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 12:34:49 INFO - building 'psutil._psutil_posix' extension 12:34:49 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 12:34:50 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 12:34:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:34:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:34:50 INFO - Successfully installed psutil 12:34:50 INFO - Cleaning up... 12:34:50 INFO - Return code: 0 12:34:50 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:34:50 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')]} 12:34:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:34:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:34:50 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')]} 12:34:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:34:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:34:50 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 0x7f0f16042f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24dc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a6f60>, '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 0x25a7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a81d0>, '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': 'db7e7c15f3ca076d53731445000001ba-1476300867.823101-1744932873', '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 12:34:50 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 12:34:50 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 12:34:50 INFO - Using env: {'DISPLAY': ':0', 12:34:50 INFO - 'HOME': '/home/cltbld', 12:34:50 INFO - 'LANG': 'en_US.UTF-8', 12:34:50 INFO - 'LANGUAGE': 'en_US:en', 12:34:50 INFO - 'LOGNAME': 'cltbld', 12:34:50 INFO - 'MAIL': '/var/mail/cltbld', 12:34:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:34:50 INFO - 'MOZ_NO_REMOTE': '1', 12:34:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:34:50 INFO - 'NO_EM_RESTART': '1', 12:34:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:34:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:34:50 INFO - 'PWD': '/builds/slave/test', 12:34:50 INFO - 'SHELL': '/bin/bash', 12:34:50 INFO - 'SHLVL': '1', 12:34:50 INFO - 'TERM': 'linux', 12:34:50 INFO - 'TMOUT': '86400', 12:34:50 INFO - 'USER': 'cltbld', 12:34:50 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1476300867.823101-1744932873', 12:34:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:34:50 INFO - '_': '/tools/buildbot/bin/python'} 12:34:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:34:50 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:34:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:34:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:34:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:34:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:34:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:34:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:34:52 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:34:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:34:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:34:52 INFO - Installing collected packages: mozsystemmonitor 12:34:52 INFO - Running setup.py install for mozsystemmonitor 12:34:52 INFO - Successfully installed mozsystemmonitor 12:34:52 INFO - Cleaning up... 12:34:52 INFO - Return code: 0 12:34:52 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:34:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:34:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:34:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:34:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:34:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:34:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:34:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0f16042f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24dc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a6f60>, '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 0x25a7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a81d0>, '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': 'db7e7c15f3ca076d53731445000001ba-1476300867.823101-1744932873', '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 12:34:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 12:34:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 12:34:52 INFO - Using env: {'DISPLAY': ':0', 12:34:52 INFO - 'HOME': '/home/cltbld', 12:34:52 INFO - 'LANG': 'en_US.UTF-8', 12:34:52 INFO - 'LANGUAGE': 'en_US:en', 12:34:52 INFO - 'LOGNAME': 'cltbld', 12:34:52 INFO - 'MAIL': '/var/mail/cltbld', 12:34:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:34:52 INFO - 'MOZ_NO_REMOTE': '1', 12:34:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:34:52 INFO - 'NO_EM_RESTART': '1', 12:34:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:34:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:34:52 INFO - 'PWD': '/builds/slave/test', 12:34:52 INFO - 'SHELL': '/bin/bash', 12:34:52 INFO - 'SHLVL': '1', 12:34:52 INFO - 'TERM': 'linux', 12:34:52 INFO - 'TMOUT': '86400', 12:34:52 INFO - 'USER': 'cltbld', 12:34:52 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1476300867.823101-1744932873', 12:34:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:34:52 INFO - '_': '/tools/buildbot/bin/python'} 12:34:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:34:52 INFO - Downloading/unpacking jsonschema==2.5.1 12:34:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:34:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:34:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:34:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:34:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:34:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:34:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:34:54 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:34:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:34:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:34:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:34:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:34:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:34:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:34:54 INFO - Downloading functools32-3.2.3-2.tar.gz 12:34:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:34:55 INFO - warning: no files found matching '*.txt' 12:34:55 INFO - no previously-included directories found matching 'build' 12:34:55 INFO - no previously-included directories found matching 'dist' 12:34:55 INFO - no previously-included directories found matching '.git*' 12:34:55 INFO - Installing collected packages: jsonschema, functools32 12:34:55 INFO - Running setup.py install for functools32 12:34:55 INFO - warning: no files found matching '*.txt' 12:34:55 INFO - no previously-included directories found matching 'build' 12:34:55 INFO - no previously-included directories found matching 'dist' 12:34:55 INFO - no previously-included directories found matching '.git*' 12:34:55 INFO - Successfully installed jsonschema functools32 12:34:55 INFO - Cleaning up... 12:34:55 INFO - Return code: 0 12:34:55 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:34:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:34:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:34:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:34:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:34:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:34:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:34:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f0f16042f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24dc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a6f60>, '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 0x25a7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a81d0>, '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': 'db7e7c15f3ca076d53731445000001ba-1476300867.823101-1744932873', '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 12:34:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 12:34:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 12:34:55 INFO - Using env: {'DISPLAY': ':0', 12:34:55 INFO - 'HOME': '/home/cltbld', 12:34:55 INFO - 'LANG': 'en_US.UTF-8', 12:34:55 INFO - 'LANGUAGE': 'en_US:en', 12:34:55 INFO - 'LOGNAME': 'cltbld', 12:34:55 INFO - 'MAIL': '/var/mail/cltbld', 12:34:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:34:55 INFO - 'MOZ_NO_REMOTE': '1', 12:34:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:34:55 INFO - 'NO_EM_RESTART': '1', 12:34:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:34:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:34:55 INFO - 'PWD': '/builds/slave/test', 12:34:55 INFO - 'SHELL': '/bin/bash', 12:34:55 INFO - 'SHLVL': '1', 12:34:55 INFO - 'TERM': 'linux', 12:34:55 INFO - 'TMOUT': '86400', 12:34:55 INFO - 'USER': 'cltbld', 12:34:55 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1476300867.823101-1744932873', 12:34:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:34:55 INFO - '_': '/tools/buildbot/bin/python'} 12:34:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:34:55 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:34:55 INFO - Cleaning up... 12:34:55 INFO - Return code: 0 12:34:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:34:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:34:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:34:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:34:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:34:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:34:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:34:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f0f16042f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24dc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a6f60>, '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 0x25a7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a81d0>, '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': 'db7e7c15f3ca076d53731445000001ba-1476300867.823101-1744932873', '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 12:34:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:34:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 12:34:55 INFO - Using env: {'DISPLAY': ':0', 12:34:55 INFO - 'HOME': '/home/cltbld', 12:34:55 INFO - 'LANG': 'en_US.UTF-8', 12:34:55 INFO - 'LANGUAGE': 'en_US:en', 12:34:55 INFO - 'LOGNAME': 'cltbld', 12:34:55 INFO - 'MAIL': '/var/mail/cltbld', 12:34:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:34:55 INFO - 'MOZ_NO_REMOTE': '1', 12:34:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:34:55 INFO - 'NO_EM_RESTART': '1', 12:34:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:34:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:34:55 INFO - 'PWD': '/builds/slave/test', 12:34:55 INFO - 'SHELL': '/bin/bash', 12:34:55 INFO - 'SHLVL': '1', 12:34:55 INFO - 'TERM': 'linux', 12:34:55 INFO - 'TMOUT': '86400', 12:34:55 INFO - 'USER': 'cltbld', 12:34:55 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1476300867.823101-1744932873', 12:34:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:34:55 INFO - '_': '/tools/buildbot/bin/python'} 12:34:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:34:55 INFO - Downloading/unpacking blobuploader==1.2.4 12:34:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:34:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:34:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:34:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:34:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:34:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:34:57 INFO - Downloading blobuploader-1.2.4.tar.gz 12:34:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:34:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:34:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:34:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:34:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:34:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:34:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:34:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:34:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:34:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:34:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:34:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:34:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:34:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:34:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:34:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:34:58 INFO - Downloading docopt-0.6.1.tar.gz 12:34:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:34:58 INFO - Installing collected packages: blobuploader, requests, docopt 12:34:58 INFO - Running setup.py install for blobuploader 12:34:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:34:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:34:58 INFO - Running setup.py install for requests 12:34:58 INFO - Running setup.py install for docopt 12:34:58 INFO - Successfully installed blobuploader requests docopt 12:34:58 INFO - Cleaning up... 12:34:58 INFO - Return code: 0 12:34:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:34: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')]} 12:34:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:34:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:34: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')]} 12:34:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:34:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:34:59 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 0x7f0f16042f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24dc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a6f60>, '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 0x25a7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a81d0>, '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': 'db7e7c15f3ca076d53731445000001ba-1476300867.823101-1744932873', '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 12:34:59 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 12:34:59 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 12:34:59 INFO - Using env: {'DISPLAY': ':0', 12:34:59 INFO - 'HOME': '/home/cltbld', 12:34:59 INFO - 'LANG': 'en_US.UTF-8', 12:34:59 INFO - 'LANGUAGE': 'en_US:en', 12:34:59 INFO - 'LOGNAME': 'cltbld', 12:34:59 INFO - 'MAIL': '/var/mail/cltbld', 12:34:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:34:59 INFO - 'MOZ_NO_REMOTE': '1', 12:34:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:34:59 INFO - 'NO_EM_RESTART': '1', 12:34:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:34:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:34:59 INFO - 'PWD': '/builds/slave/test', 12:34:59 INFO - 'SHELL': '/bin/bash', 12:34:59 INFO - 'SHLVL': '1', 12:34:59 INFO - 'TERM': 'linux', 12:34:59 INFO - 'TMOUT': '86400', 12:34:59 INFO - 'USER': 'cltbld', 12:34:59 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1476300867.823101-1744932873', 12:34:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:34:59 INFO - '_': '/tools/buildbot/bin/python'} 12:34:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:34:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:34:59 INFO - Running setup.py (path:/tmp/pip-PjIdhZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:34:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:34:59 INFO - Running setup.py (path:/tmp/pip-UHqFDd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:34:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:34:59 INFO - Running setup.py (path:/tmp/pip-sh1QJv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:34:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:34:59 INFO - Running setup.py (path:/tmp/pip-Y5ixrO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:34:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:34:59 INFO - Running setup.py (path:/tmp/pip-Vjx9wC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:34:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:34:59 INFO - Running setup.py (path:/tmp/pip-kRfN1A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:34:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:34:59 INFO - Running setup.py (path:/tmp/pip-3hO4OP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:34:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:34:59 INFO - Running setup.py (path:/tmp/pip-ZFYmx4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:34:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:34:59 INFO - Running setup.py (path:/tmp/pip-XPPWCl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:34:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:34:59 INFO - Running setup.py (path:/tmp/pip-pfPvOO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:34:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:34:59 INFO - Running setup.py (path:/tmp/pip-_7xWVm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:34:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:34:59 INFO - Running setup.py (path:/tmp/pip-3jdXm_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:35:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:35:00 INFO - Running setup.py (path:/tmp/pip-aKbd6e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:35:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:35:00 INFO - Running setup.py (path:/tmp/pip-G7aRY4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:35:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:35:00 INFO - Running setup.py (path:/tmp/pip-qrThIa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:35:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:35:00 INFO - Running setup.py (path:/tmp/pip-WrnLSf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:35:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:35:00 INFO - Running setup.py (path:/tmp/pip-lkWERz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:35:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:35:00 INFO - Running setup.py install for manifestparser 12:35:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:35:00 INFO - Running setup.py install for mozcrash 12:35:00 INFO - Running setup.py install for mozdebug 12:35:00 INFO - Running setup.py install for mozdevice 12:35:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:35:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:35:00 INFO - Running setup.py install for mozfile 12:35:00 INFO - Running setup.py install for mozhttpd 12:35:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:35:01 INFO - Running setup.py install for mozinfo 12:35:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:35:01 INFO - Running setup.py install for mozInstall 12:35:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:35:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:35:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:35:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:35:01 INFO - Running setup.py install for mozleak 12:35:01 INFO - Running setup.py install for mozlog 12:35:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:35:01 INFO - Running setup.py install for moznetwork 12:35:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:35:01 INFO - Running setup.py install for mozprocess 12:35:01 INFO - Running setup.py install for mozprofile 12:35:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:35:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:35:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:35:01 INFO - Running setup.py install for mozrunner 12:35:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:35:01 INFO - Running setup.py install for mozscreenshot 12:35:01 INFO - Running setup.py install for moztest 12:35:02 INFO - Running setup.py install for mozversion 12:35:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:35:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:35:02 INFO - Cleaning up... 12:35:02 INFO - Return code: 0 12:35:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:35:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:35:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:35:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:35:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:35:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:35:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:35:02 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 0x7f0f16042f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24dc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a6f60>, '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 0x25a7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a81d0>, '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': 'db7e7c15f3ca076d53731445000001ba-1476300867.823101-1744932873', '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 12:35:02 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 12:35:02 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 12:35:02 INFO - Using env: {'DISPLAY': ':0', 12:35:02 INFO - 'HOME': '/home/cltbld', 12:35:02 INFO - 'LANG': 'en_US.UTF-8', 12:35:02 INFO - 'LANGUAGE': 'en_US:en', 12:35:02 INFO - 'LOGNAME': 'cltbld', 12:35:02 INFO - 'MAIL': '/var/mail/cltbld', 12:35:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:35:02 INFO - 'MOZ_NO_REMOTE': '1', 12:35:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:35:02 INFO - 'NO_EM_RESTART': '1', 12:35:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:35:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:35:02 INFO - 'PWD': '/builds/slave/test', 12:35:02 INFO - 'SHELL': '/bin/bash', 12:35:02 INFO - 'SHLVL': '1', 12:35:02 INFO - 'TERM': 'linux', 12:35:02 INFO - 'TMOUT': '86400', 12:35:02 INFO - 'USER': 'cltbld', 12:35:02 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1476300867.823101-1744932873', 12:35:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:35:02 INFO - '_': '/tools/buildbot/bin/python'} 12:35:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:35:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:35:02 INFO - Running setup.py (path:/tmp/pip-LQe7yJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:35:02 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)) 12:35:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:35:02 INFO - Running setup.py (path:/tmp/pip-S4tPeF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:35:02 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)) 12:35:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:35:02 INFO - Running setup.py (path:/tmp/pip-eddLZt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:35:02 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)) 12:35:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:35:02 INFO - Running setup.py (path:/tmp/pip-ejRYpM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:35:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:35:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:35:02 INFO - Running setup.py (path:/tmp/pip-T1a269-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:35:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 12:35:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:35:02 INFO - Running setup.py (path:/tmp/pip-w6FUNE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:35:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 12:35:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:35:02 INFO - Running setup.py (path:/tmp/pip-5FkhNs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:35:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 12:35:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:35:02 INFO - Running setup.py (path:/tmp/pip-pmFqV3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:35:03 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)) 12:35:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:35:03 INFO - Running setup.py (path:/tmp/pip-kPd1wX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:35:03 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)) 12:35:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:35:03 INFO - Running setup.py (path:/tmp/pip-A6YXhm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:35:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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)) 12:35:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:35:03 INFO - Running setup.py (path:/tmp/pip-cJIr3t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:35:03 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)) 12:35:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:35:03 INFO - Running setup.py (path:/tmp/pip-B0fjFb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:35:03 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)) 12:35:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:35:03 INFO - Running setup.py (path:/tmp/pip-p3Uo3v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:35:03 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)) 12:35:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:35:03 INFO - Running setup.py (path:/tmp/pip-0OS7Xa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:35:03 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)) 12:35:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:35:03 INFO - Running setup.py (path:/tmp/pip-PyXTNL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:35:03 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)) 12:35:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:35:03 INFO - Running setup.py (path:/tmp/pip-8JT4Ry-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:35:03 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)) 12:35:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:35:03 INFO - Running setup.py (path:/tmp/pip-XDnUD0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:35:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 12:35:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:35:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:35:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 12:35:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:35:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:35:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:35:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:35:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:35:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:35:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:35:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:35:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:35:05 INFO - Downloading blessings-1.6.tar.gz 12:35:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:35:05 INFO - Installing collected packages: blessings 12:35:05 INFO - Running setup.py install for blessings 12:35:05 INFO - Successfully installed blessings 12:35:05 INFO - Cleaning up... 12:35:05 INFO - Return code: 0 12:35:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:35:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:35:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:35:06 INFO - Reading from file tmpfile_stdout 12:35:06 INFO - Current package versions: 12:35:06 INFO - argparse == 1.2.1 12:35:06 INFO - blessings == 1.6 12:35:06 INFO - blobuploader == 1.2.4 12:35:06 INFO - docopt == 0.6.1 12:35:06 INFO - functools32 == 3.2.3-2 12:35:06 INFO - jsonschema == 2.5.1 12:35:06 INFO - manifestparser == 1.1 12:35:06 INFO - mozInstall == 1.12 12:35:06 INFO - mozcrash == 0.17 12:35:06 INFO - mozdebug == 0.1 12:35:06 INFO - mozdevice == 0.48 12:35:06 INFO - mozfile == 1.2 12:35:06 INFO - mozhttpd == 0.7 12:35:06 INFO - mozinfo == 0.9 12:35:06 INFO - mozleak == 0.1 12:35:06 INFO - mozlog == 3.4 12:35:06 INFO - moznetwork == 0.27 12:35:06 INFO - mozprocess == 0.23 12:35:06 INFO - mozprofile == 0.28 12:35:06 INFO - mozrunner == 6.12 12:35:06 INFO - mozscreenshot == 0.1 12:35:06 INFO - mozsystemmonitor == 0.3 12:35:06 INFO - moztest == 0.7 12:35:06 INFO - mozversion == 1.4 12:35:06 INFO - psutil == 3.1.1 12:35:06 INFO - requests == 1.2.3 12:35:06 INFO - wsgiref == 0.1.2 12:35:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:35:06 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')]} 12:35:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:35:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:35:06 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')]} 12:35:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:35:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:35:06 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 0x7f0f16042f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24dc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a6f60>, '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 0x25a7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a81d0>, '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': 'db7e7c15f3ca076d53731445000001ba-1476300867.823101-1744932873', '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 12:35:06 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 12:35:06 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 12:35:06 INFO - Using env: {'DISPLAY': ':0', 12:35:06 INFO - 'HOME': '/home/cltbld', 12:35:06 INFO - 'LANG': 'en_US.UTF-8', 12:35:06 INFO - 'LANGUAGE': 'en_US:en', 12:35:06 INFO - 'LOGNAME': 'cltbld', 12:35:06 INFO - 'MAIL': '/var/mail/cltbld', 12:35:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:35:06 INFO - 'MOZ_NO_REMOTE': '1', 12:35:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:35:06 INFO - 'NO_EM_RESTART': '1', 12:35:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:35:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:35:06 INFO - 'PWD': '/builds/slave/test', 12:35:06 INFO - 'SHELL': '/bin/bash', 12:35:06 INFO - 'SHLVL': '1', 12:35:06 INFO - 'TERM': 'linux', 12:35:06 INFO - 'TMOUT': '86400', 12:35:06 INFO - 'USER': 'cltbld', 12:35:06 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1476300867.823101-1744932873', 12:35:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:35:06 INFO - '_': '/tools/buildbot/bin/python'} 12:35:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:35:06 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)) 12:35:06 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)) 12:35:06 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)) 12:35:06 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)) 12:35:06 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)) 12:35:06 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)) 12:35:06 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)) 12:35:06 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)) 12:35:06 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)) 12:35:06 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)) 12:35:06 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)) 12:35:06 INFO - Cleaning up... 12:35:06 INFO - Return code: 0 12:35:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:35:06 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')]} 12:35:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:35:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:35:06 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')]} 12:35:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:35:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:35:06 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 0x7f0f16042f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24dc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a6f60>, '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 0x25a7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a81d0>, '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': 'db7e7c15f3ca076d53731445000001ba-1476300867.823101-1744932873', '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 12:35:06 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 12:35:06 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 12:35:06 INFO - Using env: {'DISPLAY': ':0', 12:35:06 INFO - 'HOME': '/home/cltbld', 12:35:06 INFO - 'LANG': 'en_US.UTF-8', 12:35:06 INFO - 'LANGUAGE': 'en_US:en', 12:35:06 INFO - 'LOGNAME': 'cltbld', 12:35:06 INFO - 'MAIL': '/var/mail/cltbld', 12:35:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:35:06 INFO - 'MOZ_NO_REMOTE': '1', 12:35:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:35:06 INFO - 'NO_EM_RESTART': '1', 12:35:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:35:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:35:06 INFO - 'PWD': '/builds/slave/test', 12:35:06 INFO - 'SHELL': '/bin/bash', 12:35:06 INFO - 'SHLVL': '1', 12:35:06 INFO - 'TERM': 'linux', 12:35:06 INFO - 'TMOUT': '86400', 12:35:06 INFO - 'USER': 'cltbld', 12:35:06 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1476300867.823101-1744932873', 12:35:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:35:06 INFO - '_': '/tools/buildbot/bin/python'} 12:35:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:35:06 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:35:06 INFO - Cleaning up... 12:35:06 INFO - Return code: 0 12:35:06 INFO - Running post-action listener: _resource_record_post_action 12:35:06 INFO - Running post-action listener: _start_resource_monitoring 12:35:06 INFO - Starting resource monitoring. 12:35:06 INFO - [mozharness: 2016-10-12 19:35:06.550134Z] Finished create-virtualenv step (success) 12:35:06 INFO - [mozharness: 2016-10-12 19:35:06.550651Z] Running install step. 12:35:06 INFO - Running pre-action listener: _resource_record_pre_action 12:35:06 INFO - Running main action method: install 12:35:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:35:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:35:06 INFO - Reading from file tmpfile_stdout 12:35:06 INFO - Detecting whether we're running mozinstall >=1.0... 12:35:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:35:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:35:06 INFO - Reading from file tmpfile_stdout 12:35:06 INFO - Output received: 12:35:06 INFO - Usage: mozinstall [options] installer 12:35:06 INFO - Options: 12:35:06 INFO - -h, --help show this help message and exit 12:35:06 INFO - -d DEST, --destination=DEST 12:35:06 INFO - Directory to install application into. [default: 12:35:06 INFO - "/builds/slave/test"] 12:35:06 INFO - --app=APP Application being installed. [default: firefox] 12:35:06 INFO - mkdir: /builds/slave/test/build/application 12:35:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 12:35:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 12:35:23 INFO - Reading from file tmpfile_stdout 12:35:23 INFO - Output received: 12:35:23 INFO - /builds/slave/test/build/application/firefox/firefox 12:35:23 INFO - Running post-action listener: _resource_record_post_action 12:35:23 INFO - [mozharness: 2016-10-12 19:35:23.009801Z] Finished install step (success) 12:35:23 INFO - [mozharness: 2016-10-12 19:35:23.010048Z] Running run-tests step. 12:35:23 INFO - Running pre-action listener: _resource_record_pre_action 12:35:23 INFO - Running main action method: run_tests 12:35:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:35:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:35:23 INFO - Python 2.7.3 12:35:23 INFO - Return code: 0 12:35:23 INFO - grabbing minidump binary from tooltool 12:35:23 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')]} 12:35:23 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 0x25a6f60>, '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 0x25a7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a81d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:35:23 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 12:35:23 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 12:35:23 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 12:35:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:35:23 INFO - Return code: 0 12:35:23 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:35:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:35:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:35:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:35:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:35:23 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/ahOzpdOATQ-VfLPVgGLszQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--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 12:35:23 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/ahOzpdOATQ-VfLPVgGLszQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-049 --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 12:35:23 INFO - Using env: {'DISPLAY': ':0', 12:35:23 INFO - 'HOME': '/home/cltbld', 12:35:23 INFO - 'LANG': 'en_US.UTF-8', 12:35:23 INFO - 'LANGUAGE': 'en_US:en', 12:35:23 INFO - 'LOGNAME': 'cltbld', 12:35:23 INFO - 'MAIL': '/var/mail/cltbld', 12:35:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:35:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:35:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:35:23 INFO - 'MOZ_NO_REMOTE': '1', 12:35:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:35:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:35:23 INFO - 'NO_EM_RESTART': '1', 12:35:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:35:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:35:23 INFO - 'PWD': '/builds/slave/test', 12:35:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:35:23 INFO - 'SHELL': '/bin/bash', 12:35:23 INFO - 'SHLVL': '1', 12:35:23 INFO - 'TERM': 'linux', 12:35:23 INFO - 'TMOUT': '86400', 12:35:23 INFO - 'USER': 'cltbld', 12:35:23 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1476300867.823101-1744932873', 12:35:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:35:23 INFO - '_': '/tools/buildbot/bin/python'} 12:35:23 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/ahOzpdOATQ-VfLPVgGLszQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--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 12:35:23 INFO - mozversion application_buildid: 20161012110947 12:35:23 INFO - mozversion application_changeset: 7cb958b68c84f4880c2ed7d73ac2285da86697a3 12:35:23 INFO - mozversion application_display_name: Nightly 12:35:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:35:23 INFO - mozversion application_name: Firefox 12:35:23 INFO - mozversion application_remotingname: firefox 12:35:23 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 12:35:23 INFO - mozversion application_vendor: Mozilla 12:35:23 INFO - mozversion application_version: 52.0a1 12:35:23 INFO - mozversion platform_buildid: 20161012110947 12:35:23 INFO - mozversion platform_changeset: 7cb958b68c84f4880c2ed7d73ac2285da86697a3 12:35:23 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 12:35:23 INFO - mozversion platform_version: 52.0a1 12:35:23 INFO - using testdate: 1476300923 12:35:23 INFO - actual date: 1476300923 12:35:23 INFO - starting webserver on 'localhost:46579' 12:35:23 INFO - SUITE-START | Running 2 tests 12:35:23 INFO - TEST-START | dromaeo_css 12:35:23 INFO - operating with platform_type : linux_ 12:35:23 INFO - Initialising browser for dromaeo_css test... 12:35:23 INFO - TEST-INFO | started process 7746 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeWlFgr/profile http://localhost:46579/getInfo.html) 12:35:27 INFO - PROCESS | 7746 | __metrics Screen width/height:1600/1200 12:35:27 INFO - PROCESS | 7746 | colorDepth:24 12:35:27 INFO - PROCESS | 7746 | Browser inner width/height: 1024/697 12:35:27 INFO - PROCESS | 7746 | __metrics 12:35:28 INFO - PROCESS | 7746 | 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" 12:35:28 INFO - PROCESS | 7746 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:35:29 INFO - TEST-INFO | 7746: exit 0 12:35:29 INFO - Browser initialized. 12:35:29 INFO - Running cycle 1/1 for dromaeo_css test... 12:35:29 INFO - TEST-INFO | started process 7825 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeWlFgr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:35:41 INFO - PROCESS | 7825 | RSS: Main: 174010368 12:35:41 INFO - PROCESS | 7825 | 12:36:32 INFO - PROCESS | 7825 | 1476300992814 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] 12:38:47 INFO - PROCESS | 7825 | Cycle 1(1): loaded http://localhost:46579/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46579/tests/dromaeo/cssquery-ext.html) 12:38:48 INFO - PROCESS | 7825 | RSS: Main: 300531712 12:38:48 INFO - PROCESS | 7825 | 12:41:51 INFO - PROCESS | 7825 | Cycle 1(1): loaded http://localhost:46579/tests/dromaeo/cssquery-ext.html (next: http://localhost:46579/tests/dromaeo/cssquery-jquery.html) 12:41:52 INFO - PROCESS | 7825 | RSS: Main: 279416832 12:41:52 INFO - PROCESS | 7825 | 12:44:54 INFO - PROCESS | 7825 | Cycle 1(1): loaded http://localhost:46579/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46579/tests/dromaeo/cssquery-mootools.html) 12:44:54 INFO - PROCESS | 7825 | RSS: Main: 255967232 12:44:54 INFO - PROCESS | 7825 | 12:47:57 INFO - PROCESS | 7825 | Cycle 1(1): loaded http://localhost:46579/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46579/tests/dromaeo/cssquery-prototype.html) 12:47:57 INFO - PROCESS | 7825 | RSS: Main: 221282304 12:47:57 INFO - PROCESS | 7825 | 12:51:00 INFO - PROCESS | 7825 | Cycle 1(1): loaded http://localhost:46579/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46579/tests/dromaeo/cssquery-yui.html) 12:51:01 INFO - PROCESS | 7825 | RSS: Main: 220545024 12:51:01 INFO - PROCESS | 7825 | 12:54:04 INFO - PROCESS | 7825 | Cycle 1(1): loaded http://localhost:46579/tests/dromaeo/cssquery-yui.html (next: http://localhost:46579/tests/dromaeo/cssquery-dojo.html) 12:54:05 INFO - PROCESS | 7825 | RSS: Main: 312418304 12:54:05 INFO - PROCESS | 7825 | 12:54:05 INFO - PROCESS | 7825 | __start_tp_report 12:54:05 INFO - PROCESS | 7825 | _x_x_mozilla_page_load 12:54:05 INFO - PROCESS | 7825 | _x_x_mozilla_page_load_details 12:54:05 INFO - PROCESS | 7825 | |i|pagename|runs| 12:54:05 INFO - PROCESS | 7825 | |0;dojo.html;2589.75397337253;2614.738526147384;2651.2443953473257;2662.227953893371;2675.3980354420246;4664.416947881515;4735.0766600512825;4743.478217396084;4840.128776820171;4878.243872199806;4767.690100143488;4822.30076638888;4855.247436647316;4896.314515967767;4944.456109827916;4378.452693413324;4390;4430.822767089328;4441.000774825655;4465.598096171344;4399.922019105324;4526.479454862683;4533.886652833673;4542.38677778499;4569.29175977724;4330.631896288819;4463.754493502856;4467.262901621229;4467.932981005288;4564.680472366936;4359.782010899442;4420.8452704155525;4431.49037860647;4433.733975961421;4438.689291749579;4218.957810421887;4234.513031001413;4256.106217694288;4388.363687265329;4393.824247030115;4601.2637977923705;4655.371524844137;4659.301104834268;4659.976700116512;4675.719456832601;4910.484399138075;4917.041176970492;4917.803287868481;4925.408950925912;4991.32617096691;4939.135651261015;4943.209086546135;4948.901021979576;5003.049420610108;5033.345665063555;4749.026449577863;4803.855884323476;4811.855644330676;4849.127157111754;4851.75741212945;5272.657277276965;5311.521963023347;5323.574114070865;5327.973360133252;5377.032134215879;5079.466656001066;5083.669561478492;5093.644078280061;5095.847124586268;5114.43741188469;4975.253711943237;5015.348004759431;5021.096202683479;5037.722925239147;5170.560502357342;5039.647224694309;5066.138756411346;5125.538701516807;5141.151709967889;5142.04872098663;5045.672031317952;5050.292958985745;5059.544640982329;5063.189889617717;5114.488551144856;4226.873193804191;4268.743875367488;4324.027093903846;4337.631301339421;4377.4528183977;3750.062484378905;3775.9056023599082;3779.3764028934916;3786.2238241160494;3832.846686132579;4416.977915110404;4421.292593185075;4428.402165707653;4429.955700443019;4477.395551600493;5091.261767043758;5124.231365295235;5133.717645529532;5140.1004824155625;5200.583953283804;4343.804528796211;4382.035952090535;4387.934180987288;4406.030673251879;4457.398251236106;4611.123886461562;4623.491415944243;4625.283081122431;4648.279516674921;4652.232381656989;4844.176489996779;4845.685030473008;4904.58311043551;4904.6321525885705;4905.0189962007025;5170.482951704799;5178.870528236825;5179.792808287626;5184.403793563638;5251.606129540376;4658.67389282747;4709.858704238878;4836.637252206028;4839.975800120977;4897.363342765418;4888.462269150462;4896.583790377857;4933.753312334441;4965;5009.499050094962;5000.149974504416;5054.620903432331;5064.7467626619255;5067.5185857343495;5121.8463446096675;4917.631177661761;4929.186684197068;4930.531599498042;4932.3341348918875;4987.875303117451;4838.927416088691;4847.636427267898;4894.926576101432;4924.753762311799;4931.260310953386;4984.6261530384645;4999.350084488993;5004.87487812793;5033.572146367454;5069.569086627678;5086.720230387365;5087.821926232564;5088.135017047037;5091.236314552699;5156.40701319338;4777.140114779373;4825.734584597881;4827.106985207748;4956;4957.6281778866005 12:54:05 INFO - PROCESS | 7825 | |1;ext.html;570.7945139749689;575.7092668202557;579.8347470970774;586.7946218823413;590.2415396215862;27052.72947270529;37009.259814803685;38063.80968095159;38066.8096659517;41544.79227603858;39070.218595628074;39249.803750981206;39505.802470987604;39530.60469395312;39557;7537.24627537246;7691.038620172479;7691.269464370528;7695.115061767884;7695.769126926173;7543.660535275898;7630;7630.694772209105;7636;7636.312731854132;7648.2351764823625;7679.923200767977;7694.961525192394;7699.26856948589;7701;7581.924180758177;7631.961840190819;7633.084029916446;7638.8472230555635;7641.617919104023;7578.204288549678;7635.389168866477;7640.80897977555;7641.732539361095;7643.656035478417;36391.81804090989;36686.81656591727;36706.08234794151;36729.26541469182;36742.26515469702;3018.864151113183;3129.264622813637;3212.132724164486;3253.3981213475345;3676.5771936227407;27370.45259094807;27504.79961603087;27844.16467505978;27928;28687.13938581846;3376.6623337666283;3388.423967925459;3419.7264218862433;3463.8268086595567;3545.3972824619877;230228;231751;231887;232808.83595582083;233044;30693.86122775454;31586.526202106987;31665;48463.27305090427;48943;32894.17764555905;32974;32980;33014.17464563405;33027.174320642174;12685.365731713377;12806.871931280753;12817;12826.551070712667;12830.101892867597;10450.320729152581;10528.684139475828;10529.473526323653;10531.368117912949;10536.631217907336;7802.219778022152;7844.882326765103;7856.685732570633;7923.603819809102;7928.8810667840025;3052.9542056869163;3098.597182366278;3102.115896969353;3111.735502482269;3129.8122112673313;815.3314282288467;900.8243392538392;910.3991365698607;965.9034096590285;976.7411635916487;26309.473810523683;26680.866595667285;26823.731762682124;27340.863295683394;27360.905563777225;906.850369688994;924.5331107790523;963.3641796414333;969.2730452160879;990.6037584965927;13891.916212568196;14573;14642.926785366006;14743.41026358955;14777.48278810258;357967;390001;398373;399582;604197;43770.56229437728;44433.555664443586;44450.55549444464;44451.77774111109;44500.332495012604;1056.8414737789394;1111.3498603316827;1159.913006524514;1160.2110564816005;1182.7102359921703;24392.26823195307;26879.731202687723;27325.590116147876;29422.082302676474;29510.852445737633;44607.33089003603;45357.319640206086;45390.54609453995;45413.31880021736;45463;320068;323399;324179;324284;325107;21359.57280854343;21579;21758.486366165682;24590.631140532547;25038.874805625856;33862;37983.430248545745;38953.41569876397;38959.95301472244;39059.80470097745;33391.83304083464;33496.83251583727;33672.49491257584;33967;34100.82949585335;30044.699553005066;33443;34143.82928085344;34557.13607159741;34610.13474663053;25756;28101;29358.119256422342;33558.16104597307;33796.32407351888;27188.864055679594;31159.376812464077;31206.698178522376;31274.208162818326;31386.843065784524;23546.882265588563;24083.518329633658;24253.636195457435;24654.753452465964;24681 12:54:05 INFO - PROCESS | 7825 | |2;jquery.html;344.93273811606747;361.1008588614349;376.72687301706264;376.91896242307905;392.43881249812773;12071.879281207186;12305.753884922296;12961.287129207878;13156.671083222924;16862.156892155406;16232.269547870344;16524.339026438927;16527.173641317917;16663.66672666549;16691.248893799777;4816;4982.078315511633;5055.241713742931;5075.441701412841;5081.339425874631;3472.947905781415;3629.4192929131345;4991.251312303148;5092.592592592584;5097.108006098936;5562.249096371998;5812.389699081599;5846.7076646167525;5894.351621321651;5920;5699.772009119631;5846.795362162326;5870.3836097209605;5893.7053147342895;5921;5162.974185129088;5178.4562620924635;5186.429492755794;5190.636655434121;5192.974035129838;19120.904395477934;20110.899445502826;20252.088656010514;20260.392188234375;20284.290049848183;1930.0639189992842;1964.027806235908;2013.7784843667184;2202.2292197730667;2332.825038122148;11952.880471195263;12743.362831858463;12770.680732981657;12987;13317.800232996417;1689.7634331193642;1748.5278974676767;1752.141450689153;1764.7617571627795;1787.6782179207737;63966.68016659933;65071.99999999953;65625.3437465624;67593;67645.66177169132;9531.332806703464;9829.361091529028;9948.80102397948;9950.648513255492;10155.800922709323;13325.600231993056;13475.865241347461;13482.460701572023;13485.932570337085;13497.325133743274;6601.5378923475855;6649.468042556584;6823.624700641413;6865.347791959756;6922.896156557656;6010.489108425745;6045.879082418327;6265.248170219603;6280.120783090371;6281.7173227204885;4138.958610413857;4280;4302.698811083194;4342.82628694855;4390.385346051556;1640.1635166065394;1690.2900781671729;1700.4133573917227;1724.2154819557072;1738.0527612450992;819.1358117186426;843.8987321521457;845.3026253341018;879.9956000219958;892.683097500391;15614.687706245812;16197.352105915867;16580.17099145038;16612.335506579842;17152.284771522747;836.4521238588734;847.902491213506;877.8551538995994;889.4485419040236;914.3234006835028;8802.823943521094;9418.858717119248;9441.858372124423;9490.430574165572;9518.143367096995;279389;283318;283827;401453;402746;79692.60153699195;83092;83756.58121709352;84691.57654211689;84915.57542212373;912.771807048238;921.1433366968784;948.7485816258697;956.5408603870181;968.801395713877;15197.6200594986;15237.695246094794;15647.452339168074;15857.127857967462;16049.277782499583;33579.328413432086;36297.45553816748;37586.436203456426;38067.80966095152;38084.81067082563;48657.756711216214;51941.7402912983;53287;53984.460155399516;54433;7406.814829629302;7565.924340756742;7659.846803064019;7660.425468090027;7675.654595543102;10293.897061029294;10740.355578665305;11301.208915375844;11415.200935934738;11752.118591105873;9834.360766550151;10048.196144308291;10107.140893024176;10193;10566.894331056592;9172.08279172104;9857.162141218078;9998.400095994264;10090.899091009289;10282.177425806067;9478.715638530855;9524.619015239312;10009.449480278654;10173.38959662393;10364.119049880845;7406.740764073232;7488.138864030706;7539.472236943361;7600.049993750781;7633.1985141559335;8585.570721464026;9909.504524773876;10001.899981000097;10144.847827282449;10244.360902255603 12:54:05 INFO - PROCESS | 7825 | |3;mootools.html;1200.3698058519283;1335.559265442404;1375.456694605631;1381.820363352764;1675.2712570032038;6629.171353580797;7359.816004599881;7592.050993625797;7626.618669066538;7817.374610031198;7633.885491717629;7698;7708.653110610022;7715.6142192890275;7721.498102623325;2161.967570486444;2180.5420861619077;2181.7490988536365;2187.1579441914896;2188.2888061380036;2100.884451355175;2140.8715477071346;2181.923632672857;2182.4980254541465;2182.7271591051117;2089.9791002090014;2094.6857971304275;2095.2561840546614;2097.4127244371525;2201.482651576878;2106.9473263168466;2108.641530939744;2111.3032699209225;2111.6199084164996;2112.23959374625;2081.718967939324;2139.133650871384;2139.6041732279577;2139.8716077035274;2140.8073273405466;7574.091109066947;7699.923000769976;7773.766786996399;7880.684772609089;7888.447808653396;4528.5245049270015;4655.697379670344;4658.277966915133;4658.534146585348;4665.463471700764;2736.3022429280404;2853.629028226338;2883.6539615246097;2898.3333833218267;2900.0719769673715;864.7319331007345;870.9651613935436;883.6465413834453;884.8893888263967;895.6104094718818;10039.447830369327;10094.343867648653;10111.89888101117;10174.745631359201;10177.236707246986;3922.7057970651745;4126.174765047002;4200.957990420118;4228.365745138192;4231.322988321916;8115.75652730419;8116.188381161836;8120.269175774209;8121.228483294078;8132.1867813218205;4596.379488768974;4603.562661547147;4607.378003969488;4607.976960115178;4611.838585649486;3677.8712745053795;3796.37359835624;4080.6531444827524;4260.147970405869;4262.360645903077;3264.8041117533025;3320.9169770755443;3400.9659903400648;3405.7956522608724;3409.90882917469;1005.2862467647906;1019.4902548725637;1031.783325501653;1032.442481060219;1039.719275795531;765.5559775330295;785.9449838511364;833.8499070167306;841.0748177005368;857.6955180910811;5194.0910340690225;5216.686998780086;5270.710110943858;5315.6013299002725;5426.077566813651;406.50203500711984;409.5679058593213;424.1453471255423;425.85520922886366;428.7117212775652;3392.8812491562676;3472.5138480612736;3609.314230296235;3712.7747843211673;3743.4010558311084;8808.251298639687;9138.17756401927;9148.542572871329;9176.265898728087;9210.125038121369;9109.954450227706;9120.179183873483;9145.725628231165;9153.084691530927;9159.313051521163;7102.573845569283;7128.180259270147;7159.176694680074;7160.212376638461;7169.24722904098;4990.80036798524;5014.498550144956;5039.899202016012;5132.820351287687;5387.81142660005;8559.945613052947;8604.913950860662;8675.262602678842;8696.17386348296;8764.824703505767;8626.870596940926;8864.955675221583;8882.911170888208;8928.375013749235;8928.687495937611;5569.55443564522;5970.880582388415;6011.969940150271;6065.545084118797;6072.666003369857;6462.644554549545;6746.224184218878;6943;6961.75633852833;7165.677544510614;6342.714577843916;6361.681915904093;6427.58220715652;6563.901541476977;6591;6370.299267080525;6408.679566021773;6438.29178790342;6454.870902582016;6459.386358295955;6031;6136.631802091889;6158.969205153946;6179.938200618116;6190.907136393048;4607.815687372467;4647.581717645428;4755.762211889322;4760.428748550196;4803.087413391444;4658.976705116588;4719.4100737407825;4738.147133516;4806.134895718804;4881.585065269492 12:54:05 INFO - PROCESS | 7825 | |4;prototype.html;286.30713672911565;300.07726241806444;307.3300205551896;307.41437561445446;309.10051749409223;4645.396098507189;4810.44679861816;4817.470078291394;4842.9031419371595;4864.367632207813;4551;4675.649326300532;4689.9296510552285;4719.457262414823;4799.064182484417;3764.3036038333;3822.140018495844;3826.1582451860545;3826.712996525258;3832.405977073558;3549.485324627927;3693.0057768804813;3779.8866034019024;3784.735068545203;3798.183390571027;3599.8380072896784;3739.6260373962523;3746.5201245508006;3755.718321125913;3773.9622603774023;3727.552693676776;3749.850005999757;3760.3795373763296;3771.07608635886;3784.6593806557266;3324.16895776056;3325.617553981299;3325.8004519728893;3337.1490269981;3340.7828491148;4471.932921006188;4603.470600880908;4650.697704649187;4655.255159174516;4670.085265041351;4237.745735255895;4243.448351714288;4264.722793018444;4267.125239325931;4267.829286828523;4900.289458028566;4919.163742163841;4937.604991600663;4955.256711493269;4973.776180071905;3361.277325375056;3568.357695614788;3634.9636503635156;3640.6541378568995;3648.343298206322;5193.584513238894;5235.293235413209;5242.580593552507;5243.79024839006;5248.71132087735;3659.9268014639556;3662.853485860536;3669.2478042001326;3670.3943849265106;3672.8347224374966;3726.5900750917376;3727.869524566627;3730.2353017631863;3745.5879853216125;3745.700343972476;4143.02638879863;4171.478565179353;4181.958180418157;4209.137126888981;4249.553796851348;4993.950060499421;4995.275685025651;5002.972013126784;5006.19900815875;5019.447860735316;1196.252342286071;1227.613301809945;1269.2511418263268;1271.586734311334;1283.582835578422;854.5684429363256;880.7489865388462;883.5361435246418;883.9734807955772;894.4767311123065;4463.709858859163;4468.776561171993;4470.396496472999;4471.674729140894;4481.395011673382;5154.226865970135;5169.198774190007;5170.560502357342;5171.844844654666;5175.378954525406;4318.438602981592;4459.487158976694;4520.254158063948;4533.478649955231;4570.7257564546235;2752.683441404264;2773.2650847525424;2774.417372351829;2778.208210659993;2786.676328743871;4907.165781817028;4911.649296443436;4924.852254432372;4927.852164435073;4928.186849169847;5114;5240.554552862973;5256.9737151314;5277.868053298698;5304.496072873071;4854.271859221074;4856.514348565115;4865.781039853215;4875.68308059975;4890.779914903838;5050.671706339076;5177.637565370388;5188.636795424284;5211.9478805212975;5227.2420499028185;5051.520105589963;5060.01329740697;5069.695818250917;5078.238264260391;5110.310108135503;4866.853994380174;4870.05034018363;4888.633352498506;4909.299885063272;4946.332245146859;3674.761140525857;3685.133993511469;3691.151035261851;3696.7227457940226;3705.018170184957;5073.543381095719;5149.716765577929;5179.249008893765;5179.378474583074;5224.190250511177;4985.5762260208285;5015.523525265094;5017.197248440232;5040.57155141817;5041.697498150123;4890.193118135468;5057.089723849743;5067.5185857343495;5071.54356107952;5099.69401835891;4707.741074240949;4849.975750121227;4940.530649588283;4955.281484184845;4993.27597498368;4872.733089396712;4997.525235102659;5002.549770520671;5013.448520662651;5021.774020169174;4897.95102048975;4920.8769780755765;4930.556249937523;4933.309336692938;4949.133901567283 12:54:05 INFO - PROCESS | 7825 | |5;yui.html;585.9979435165866;594.3195041677279;628.4689437425379;654.9665818187231;681.5263391942602;10774.138068954484;11163.553457861695;12075.758484830298;13209.603711888647;13228.801567976465;9869.802603947917;10987.39569323687;13413;13655.453781848713;13744.312784360793;750.7034721285103;765.3800421658447;774.6088225446142;775.2092865277414;775.3099741230282;619.3589634728057;634.2325785799188;778.3850757901251;781.4178437064395;781.7889169924117;668.4184759259451;670.5038271678972;670.8255853478082;783.8549868274359;807.3379828540599;796.9960150199241;801.5471258738852;801.5631480842897;801.7033697531892;801.7714951238898;588.6644612570793;588.9587728858982;589.2545929399313;589.2634207240949;589.4783116941537;11712.824307635392;11728.589499367567;11738.237014594024;11738.647840564796;11749.06007519405;12167.756644867053;12379.62861114168;12633.557825476157;12729.490820367175;12921;11251.774964500746;11507.309561426342;11800.114991375596;11897.702557436134;11936.224145430519;4058.6955978301744;4102.528209255914;4111.588841115894;4250.404943307939;4279.7218180818145;42070.579294206975;43536.78231608853;50352.496475035514;64481.67759161174;64735.763211839694;9932;9938;9963.202943764481;10109.191264698953;10148.838976019797;19271.421857344303;19441.31955381555;19573.51066223356;19660.21359145618;19668.21327146898;6764.864702706017;6855.383015528626;6880.58716477003;6980.616066116412;6993.300669933068;3578.5526809148855;3612.8012959286966;3615.493830863681;3662.1577037281572;3664.72514561409;2922.5616157576533;3026.0921723482866;3033.0294305821926;3038.316378814749;3040.346325539975;487.98668223718397;491.5698763581866;499.8550420378122;501.58869726823656;504.9924251136236;581.2066529187629;584.6579750845802;600.6576251536669;601.8525461262019;612.0757655939564;7206.495545311883;7253.419726421979;7572.962135189399;7622.58075805836;7640.579768112807;479.61630695443506;499.40321316027723;575.0712599152339;580.9041508151192;590.3977942498627;3556.5732112146707;3594.5866225383893;3596.3166998270244;3610.5667319921777;3756.586775454698;100823.49588252012;102542;103007;103458;107862.46068769606;50249.49750502521;50381;61927.6903615479;86673;88137;71505.64247178835;83789.58105209557;83791;84607;84868.57565712255;6950.721971121301;7150.606716630636;7269.091363579552;7410.777676669709;7566.167721550515;47697.76151119222;48640;48788;49196.26205606991;49897.00823934149;37706.245875082896;52846.471535285695;54788.452115478336;55777.44222557722;55882.1617675727;10160.390376577134;10243.38539687621;10374.118199953089;10443.373397596168;10968.670939871816;11931;12171.817422738843;13104.968729846889;13118.672033199246;13193.736125277632;10592.735181620214;11116.333020018501;11318.094552435621;11997;12005.939970300093;11168.66494005181;11508.194426390073;11571.074314055024;12000.75998480043;12181.33002684861;10508.474576271308;10617.89382106169;10943.781124377627;11232.494537745657;11507.942460287644;8858.715486254587;9029.593668284811;9207.352698836112;10022.398656080659;10029.548670309707;9320.95339523298;9460.95269523648;9491.620335186792;10289.794204115726;10304.484775761031 12:54:05 INFO - PROCESS | 7825 | __end_tp_report 12:54:05 INFO - PROCESS | 7825 | __start_cc_report 12:54:05 INFO - PROCESS | 7825 | _x_x_mozilla_cycle_collect,1255 12:54:05 INFO - PROCESS | 7825 | __end_cc_report 12:54:05 INFO - PROCESS | 7825 | __startTimestamp1476302045003__endTimestamp 12:54:05 INFO - PROCESS | 7825 | 12:54:05 INFO - PROCESS | 7825 | ------- Summary: start ------- 12:54:05 INFO - PROCESS | 7825 | Number of tests: 6 12:54:05 INFO - PROCESS | 7825 | 12:54:05 INFO - PROCESS | 7825 | [#0] dojo.html Cycles:165 Average:4719.63 Median:4855.25 stddev:495.58 (10.2%) stddev-sans-first:468.09 12:54:05 INFO - PROCESS | 7825 | Values: 2589.8 2614.7 2651.2 2662.2 2675.4 4664.4 4735.1 4743.5 4840.1 4878.2 4767.7 4822.3 4855.2 4896.3 4944.5 4378.5 4390.0 4430.8 4441.0 4465.6 4399.9 4526.5 4533.9 4542.4 4569.3 4330.6 4463.8 4467.3 4467.9 4564.7 4359.8 4420.8 4431.5 4433.7 4438.7 4219.0 4234.5 4256.1 4388.4 4393.8 4601.3 4655.4 4659.3 4660.0 4675.7 4910.5 4917.0 4917.8 4925.4 4991.3 4939.1 4943.2 4948.9 5003.0 5033.3 4749.0 4803.9 4811.9 4849.1 4851.8 5272.7 5311.5 5323.6 5328.0 5377.0 5079.5 5083.7 5093.6 5095.8 5114.4 4975.3 5015.3 5021.1 5037.7 5170.6 5039.6 5066.1 5125.5 5141.2 5142.0 5045.7 5050.3 5059.5 5063.2 5114.5 4226.9 4268.7 4324.0 4337.6 4377.5 3750.1 3775.9 3779.4 3786.2 3832.8 4417.0 4421.3 4428.4 4430.0 4477.4 5091.3 5124.2 5133.7 5140.1 5200.6 4343.8 4382.0 4387.9 4406.0 4457.4 4611.1 4623.5 4625.3 4648.3 4652.2 4844.2 4845.7 4904.6 4904.6 4905.0 5170.5 5178.9 5179.8 5184.4 5251.6 4658.7 4709.9 4836.6 4840.0 4897.4 4888.5 4896.6 4933.8 4965.0 5009.5 5000.1 5054.6 5064.7 5067.5 5121.8 4917.6 4929.2 4930.5 4932.3 4987.9 4838.9 4847.6 4894.9 4924.8 4931.3 4984.6 4999.4 5004.9 5033.6 5069.6 5086.7 5087.8 5088.1 5091.2 5156.4 4777.1 4825.7 4827.1 4956.0 4957.6 12:54:05 INFO - PROCESS | 7825 | 12:54:05 INFO - PROCESS | 7825 | [#1] ext.html Cycles:180 Average:45851.69 Median:18677.71 stddev:90944.11 (486.9%) stddev-sans-first:91135.69 12:54:05 INFO - PROCESS | 7825 | Values: 570.8 575.7 579.8 586.8 590.2 27052.7 37009.3 38063.8 38066.8 41544.8 39070.2 39249.8 39505.8 39530.6 39557.0 7537.2 7691.0 7691.3 7695.1 7695.8 7543.7 7630.0 7630.7 7636.0 7636.3 7648.2 7679.9 7695.0 7699.3 7701.0 7581.9 7632.0 7633.1 7638.8 7641.6 7578.2 7635.4 7640.8 7641.7 7643.7 36391.8 36686.8 36706.1 36729.3 36742.3 3018.9 3129.3 3212.1 3253.4 3676.6 27370.5 27504.8 27844.2 27928.0 28687.1 3376.7 3388.4 3419.7 3463.8 3545.4 230228.0 231751.0 231887.0 232808.8 233044.0 30693.9 31586.5 31665.0 48463.3 48943.0 32894.2 32974.0 32980.0 33014.2 33027.2 12685.4 12806.9 12817.0 12826.6 12830.1 10450.3 10528.7 10529.5 10531.4 10536.6 7802.2 7844.9 7856.7 7923.6 7928.9 3053.0 3098.6 3102.1 3111.7 3129.8 815.3 900.8 910.4 965.9 976.7 26309.5 26680.9 26823.7 27340.9 27360.9 906.9 924.5 963.4 969.3 990.6 13891.9 14573.0 14642.9 14743.4 14777.5 357967.0 390001.0 398373.0 399582.0 604197.0 43770.6 44433.6 44450.6 44451.8 44500.3 1056.8 1111.3 1159.9 1160.2 1182.7 24392.3 26879.7 27325.6 29422.1 29510.9 44607.3 45357.3 45390.5 45413.3 45463.0 320068.0 323399.0 324179.0 324284.0 325107.0 21359.6 21579.0 21758.5 24590.6 25038.9 33862.0 37983.4 38953.4 38960.0 39059.8 33391.8 33496.8 33672.5 33967.0 34100.8 30044.7 33443.0 34143.8 34557.1 34610.1 25756.0 28101.0 29358.1 33558.2 33796.3 27188.9 31159.4 31206.7 31274.2 31386.8 23546.9 24083.5 24253.6 24654.8 24681.0 12:54:05 INFO - PROCESS | 7825 | 12:54:05 INFO - PROCESS | 7825 | [#2] jquery.html Cycles:180 Average:22612.71 Median:26736.88 stddev:55989.36 (209.4%) stddev-sans-first:56121.46 12:54:05 INFO - PROCESS | 7825 | Values: 344.9 361.1 376.7 376.9 392.4 12071.9 12305.8 12961.3 13156.7 16862.2 16232.3 16524.3 16527.2 16663.7 16691.2 4816.0 4982.1 5055.2 5075.4 5081.3 3472.9 3629.4 4991.3 5092.6 5097.1 5562.2 5812.4 5846.7 5894.4 5920.0 5699.8 5846.8 5870.4 5893.7 5921.0 5163.0 5178.5 5186.4 5190.6 5193.0 19120.9 20110.9 20252.1 20260.4 20284.3 1930.1 1964.0 2013.8 2202.2 2332.8 11952.9 12743.4 12770.7 12987.0 13317.8 1689.8 1748.5 1752.1 1764.8 1787.7 63966.7 65072.0 65625.3 67593.0 67645.7 9531.3 9829.4 9948.8 9950.6 10155.8 13325.6 13475.9 13482.5 13485.9 13497.3 6601.5 6649.5 6823.6 6865.3 6922.9 6010.5 6045.9 6265.2 6280.1 6281.7 4139.0 4280.0 4302.7 4342.8 4390.4 1640.2 1690.3 1700.4 1724.2 1738.1 819.1 843.9 845.3 880.0 892.7 15614.7 16197.4 16580.2 16612.3 17152.3 836.5 847.9 877.9 889.4 914.3 8802.8 9418.9 9441.9 9490.4 9518.1 279389.0 283318.0 283827.0 401453.0 402746.0 79692.6 83092.0 83756.6 84691.6 84915.6 912.8 921.1 948.7 956.5 968.8 15197.6 15237.7 15647.5 15857.1 16049.3 33579.3 36297.5 37586.4 38067.8 38084.8 48657.8 51941.7 53287.0 53984.5 54433.0 7406.8 7565.9 7659.8 7660.4 7675.7 10293.9 10740.4 11301.2 11415.2 11752.1 9834.4 10048.2 10107.1 10193.0 10566.9 9172.1 9857.2 9998.4 10090.9 10282.2 9478.7 9524.6 10009.4 10173.4 10364.1 7406.7 7488.1 7539.5 7600.0 7633.2 8585.6 9909.5 10001.9 10144.8 10244.4 12:54:05 INFO - PROCESS | 7825 | 12:54:05 INFO - PROCESS | 7825 | [#3] mootools.html Cycles:180 Average:4947.33 Median:5002.65 stddev:2747.45 (54.9%) stddev-sans-first:2740.73 12:54:05 INFO - PROCESS | 7825 | Values: 1200.4 1335.6 1375.5 1381.8 1675.3 6629.2 7359.8 7592.1 7626.6 7817.4 7633.9 7698.0 7708.7 7715.6 7721.5 2162.0 2180.5 2181.7 2187.2 2188.3 2100.9 2140.9 2181.9 2182.5 2182.7 2090.0 2094.7 2095.3 2097.4 2201.5 2106.9 2108.6 2111.3 2111.6 2112.2 2081.7 2139.1 2139.6 2139.9 2140.8 7574.1 7699.9 7773.8 7880.7 7888.4 4528.5 4655.7 4658.3 4658.5 4665.5 2736.3 2853.6 2883.7 2898.3 2900.1 864.7 871.0 883.6 884.9 895.6 10039.4 10094.3 10111.9 10174.7 10177.2 3922.7 4126.2 4201.0 4228.4 4231.3 8115.8 8116.2 8120.3 8121.2 8132.2 4596.4 4603.6 4607.4 4608.0 4611.8 3677.9 3796.4 4080.7 4260.1 4262.4 3264.8 3320.9 3401.0 3405.8 3409.9 1005.3 1019.5 1031.8 1032.4 1039.7 765.6 785.9 833.8 841.1 857.7 5194.1 5216.7 5270.7 5315.6 5426.1 406.5 409.6 424.1 425.9 428.7 3392.9 3472.5 3609.3 3712.8 3743.4 8808.3 9138.2 9148.5 9176.3 9210.1 9110.0 9120.2 9145.7 9153.1 9159.3 7102.6 7128.2 7159.2 7160.2 7169.2 4990.8 5014.5 5039.9 5132.8 5387.8 8559.9 8604.9 8675.3 8696.2 8764.8 8626.9 8865.0 8882.9 8928.4 8928.7 5569.6 5970.9 6012.0 6065.5 6072.7 6462.6 6746.2 6943.0 6961.8 7165.7 6342.7 6361.7 6427.6 6563.9 6591.0 6370.3 6408.7 6438.3 6454.9 6459.4 6031.0 6136.6 6159.0 6179.9 6190.9 4607.8 4647.6 4755.8 4760.4 4803.1 4659.0 4719.4 4738.1 4806.1 4881.6 12:54:05 INFO - PROCESS | 7825 | 12:54:05 INFO - PROCESS | 7825 | [#4] prototype.html Cycles:180 Average:4173.18 Median:4759.26 stddev:1205.10 (25.3%) stddev-sans-first:1172.64 12:54:05 INFO - PROCESS | 7825 | Values: 286.3 300.1 307.3 307.4 309.1 4645.4 4810.4 4817.5 4842.9 4864.4 4551.0 4675.6 4689.9 4719.5 4799.1 3764.3 3822.1 3826.2 3826.7 3832.4 3549.5 3693.0 3779.9 3784.7 3798.2 3599.8 3739.6 3746.5 3755.7 3774.0 3727.6 3749.9 3760.4 3771.1 3784.7 3324.2 3325.6 3325.8 3337.1 3340.8 4471.9 4603.5 4650.7 4655.3 4670.1 4237.7 4243.4 4264.7 4267.1 4267.8 4900.3 4919.2 4937.6 4955.3 4973.8 3361.3 3568.4 3635.0 3640.7 3648.3 5193.6 5235.3 5242.6 5243.8 5248.7 3659.9 3662.9 3669.2 3670.4 3672.8 3726.6 3727.9 3730.2 3745.6 3745.7 4143.0 4171.5 4182.0 4209.1 4249.6 4994.0 4995.3 5003.0 5006.2 5019.4 1196.3 1227.6 1269.3 1271.6 1283.6 854.6 880.7 883.5 884.0 894.5 4463.7 4468.8 4470.4 4471.7 4481.4 5154.2 5169.2 5170.6 5171.8 5175.4 4318.4 4459.5 4520.3 4533.5 4570.7 2752.7 2773.3 2774.4 2778.2 2786.7 4907.2 4911.6 4924.9 4927.9 4928.2 5114.0 5240.6 5257.0 5277.9 5304.5 4854.3 4856.5 4865.8 4875.7 4890.8 5050.7 5177.6 5188.6 5211.9 5227.2 5051.5 5060.0 5069.7 5078.2 5110.3 4866.9 4870.1 4888.6 4909.3 4946.3 3674.8 3685.1 3691.2 3696.7 3705.0 5073.5 5149.7 5179.2 5179.4 5224.2 4985.6 5015.5 5017.2 5040.6 5041.7 4890.2 5057.1 5067.5 5071.5 5099.7 4707.7 4850.0 4940.5 4955.3 4993.3 4872.7 4997.5 5002.5 5013.4 5021.8 4898.0 4920.9 4930.6 4933.3 4949.1 12:54:05 INFO - PROCESS | 7825 | 12:54:05 INFO - PROCESS | 7825 | [#5] yui.html Cycles:180 Average:17062.72 Median:24563.99 stddev:24812.74 (101.0%) stddev-sans-first:24851.50 12:54:05 INFO - PROCESS | 7825 | Values: 586.0 594.3 628.5 655.0 681.5 10774.1 11163.6 12075.8 13209.6 13228.8 9869.8 10987.4 13413.0 13655.5 13744.3 750.7 765.4 774.6 775.2 775.3 619.4 634.2 778.4 781.4 781.8 668.4 670.5 670.8 783.9 807.3 797.0 801.5 801.6 801.7 801.8 588.7 589.0 589.3 589.3 589.5 11712.8 11728.6 11738.2 11738.6 11749.1 12167.8 12379.6 12633.6 12729.5 12921.0 11251.8 11507.3 11800.1 11897.7 11936.2 4058.7 4102.5 4111.6 4250.4 4279.7 42070.6 43536.8 50352.5 64481.7 64735.8 9932.0 9938.0 9963.2 10109.2 10148.8 19271.4 19441.3 19573.5 19660.2 19668.2 6764.9 6855.4 6880.6 6980.6 6993.3 3578.6 3612.8 3615.5 3662.2 3664.7 2922.6 3026.1 3033.0 3038.3 3040.3 488.0 491.6 499.9 501.6 505.0 581.2 584.7 600.7 601.9 612.1 7206.5 7253.4 7573.0 7622.6 7640.6 479.6 499.4 575.1 580.9 590.4 3556.6 3594.6 3596.3 3610.6 3756.6 100823.5 102542.0 103007.0 103458.0 107862.5 50249.5 50381.0 61927.7 86673.0 88137.0 71505.6 83789.6 83791.0 84607.0 84868.6 6950.7 7150.6 7269.1 7410.8 7566.2 47697.8 48640.0 48788.0 49196.3 49897.0 37706.2 52846.5 54788.5 55777.4 55882.2 10160.4 10243.4 10374.1 10443.4 10968.7 11931.0 12171.8 13105.0 13118.7 13193.7 10592.7 11116.3 11318.1 11997.0 12005.9 11168.7 11508.2 11571.1 12000.8 12181.3 10508.5 10617.9 10943.8 11232.5 11507.9 8858.7 9029.6 9207.4 10022.4 10029.5 9321.0 9461.0 9491.6 10289.8 10304.5 12:54:05 INFO - PROCESS | 7825 | -------- Summary: end -------- 12:54:05 INFO - PROCESS | 7825 | 12:54:06 INFO - TEST-INFO | 7825: exit 0 12:54:06 INFO - TEST-OK | dromaeo_css | took 1122749ms 12:54:06 INFO - TEST-START | kraken 12:54:06 INFO - operating with platform_type : linux_ 12:54:06 INFO - Initialising browser for kraken test... 12:54:06 INFO - TEST-INFO | started process 8132 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqBolNs/profile http://localhost:46579/getInfo.html) 12:54:10 INFO - PROCESS | 8132 | __metrics Screen width/height:1600/1200 12:54:10 INFO - PROCESS | 8132 | colorDepth:24 12:54:10 INFO - PROCESS | 8132 | Browser inner width/height: 1024/697 12:54:10 INFO - PROCESS | 8132 | __metrics 12:54:10 INFO - PROCESS | 8132 | 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" 12:54:10 INFO - PROCESS | 8132 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:54:11 INFO - PROCESS | 8132 | console.error: PushService: 12:54:11 INFO - PROCESS | 8132 | stateChangeProcessEnqueue: Error transitioning state 12:54:11 INFO - PROCESS | 8132 | UnknownError 12:54:12 INFO - TEST-INFO | 8132: exit 0 12:54:12 INFO - Browser initialized. 12:54:12 INFO - Running cycle 1/1 for kraken test... 12:54:12 INFO - TEST-INFO | started process 8215 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqBolNs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:54:24 INFO - PROCESS | 8215 | RSS: Main: 175702016 12:54:24 INFO - PROCESS | 8215 | 12:54:27 INFO - PROCESS | 8215 | Cycle 1(1): loaded http://localhost:46579/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46579/tests/kraken/driver.html?testName=audio-beat-detection) 12:54:28 INFO - PROCESS | 8215 | RSS: Main: 233426944 12:54:28 INFO - PROCESS | 8215 | 12:54:31 INFO - PROCESS | 8215 | Cycle 1(1): loaded http://localhost:46579/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46579/tests/kraken/driver.html?testName=audio-dft) 12:54:31 INFO - PROCESS | 8215 | RSS: Main: 218251264 12:54:31 INFO - PROCESS | 8215 | 12:54:34 INFO - PROCESS | 8215 | Cycle 1(1): loaded http://localhost:46579/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46579/tests/kraken/driver.html?testName=audio-fft) 12:54:35 INFO - PROCESS | 8215 | RSS: Main: 301662208 12:54:35 INFO - PROCESS | 8215 | 12:54:37 INFO - PROCESS | 8215 | Cycle 1(1): loaded http://localhost:46579/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46579/tests/kraken/driver.html?testName=audio-oscillator) 12:54:38 INFO - PROCESS | 8215 | RSS: Main: 212713472 12:54:38 INFO - PROCESS | 8215 | 12:54:40 INFO - PROCESS | 8215 | Cycle 1(1): loaded http://localhost:46579/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46579/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:54:41 INFO - PROCESS | 8215 | RSS: Main: 215273472 12:54:41 INFO - PROCESS | 8215 | 12:54:44 INFO - PROCESS | 8215 | Cycle 1(1): loaded http://localhost:46579/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46579/tests/kraken/driver.html?testName=imaging-darkroom) 12:54:44 INFO - PROCESS | 8215 | RSS: Main: 250654720 12:54:44 INFO - PROCESS | 8215 | 12:54:48 INFO - PROCESS | 8215 | Cycle 1(1): loaded http://localhost:46579/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46579/tests/kraken/driver.html?testName=imaging-desaturate) 12:54:49 INFO - PROCESS | 8215 | RSS: Main: 244338688 12:54:49 INFO - PROCESS | 8215 | 12:54:51 INFO - PROCESS | 8215 | Cycle 1(1): loaded http://localhost:46579/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46579/tests/kraken/driver.html?testName=json-parse-financial) 12:54:52 INFO - PROCESS | 8215 | RSS: Main: 247410688 12:54:52 INFO - PROCESS | 8215 | 12:54:54 INFO - PROCESS | 8215 | Cycle 1(1): loaded http://localhost:46579/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46579/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:54:54 INFO - PROCESS | 8215 | RSS: Main: 211152896 12:54:54 INFO - PROCESS | 8215 | 12:54:56 INFO - PROCESS | 8215 | Cycle 1(1): loaded http://localhost:46579/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46579/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:54:57 INFO - PROCESS | 8215 | RSS: Main: 218202112 12:54:57 INFO - PROCESS | 8215 | 12:54:59 INFO - PROCESS | 8215 | Cycle 1(1): loaded http://localhost:46579/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46579/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:55:00 INFO - PROCESS | 8215 | RSS: Main: 227475456 12:55:00 INFO - PROCESS | 8215 | 12:55:03 INFO - PROCESS | 8215 | Cycle 1(1): loaded http://localhost:46579/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46579/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:55:03 INFO - PROCESS | 8215 | RSS: Main: 235728896 12:55:03 INFO - PROCESS | 8215 | 12:55:06 INFO - PROCESS | 8215 | Cycle 1(1): loaded http://localhost:46579/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46579/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:55:07 INFO - PROCESS | 8215 | RSS: Main: 233103360 12:55:07 INFO - PROCESS | 8215 | 12:55:09 INFO - PROCESS | 8215 | Cycle 1(1): loaded http://localhost:46579/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46579/tests/kraken/driver.html?testName=ai-astar) 12:55:09 INFO - PROCESS | 8215 | RSS: Main: 282759168 12:55:09 INFO - PROCESS | 8215 | 12:55:09 INFO - PROCESS | 8215 | __start_tp_report 12:55:09 INFO - PROCESS | 8215 | _x_x_mozilla_page_load 12:55:09 INFO - PROCESS | 8215 | _x_x_mozilla_page_load_details 12:55:09 INFO - PROCESS | 8215 | |i|pagename|runs| 12:55:09 INFO - PROCESS | 8215 | |0;ai-astar;111;114;113;112;113;114;113;113;113;112 12:55:09 INFO - PROCESS | 8215 | |1;audio-beat-detection;156;128;126;170;131;126;127;131;172;127 12:55:09 INFO - PROCESS | 8215 | |2;audio-dft;162;162;161;162;163;161;162;161;162;160 12:55:09 INFO - PROCESS | 8215 | |3;audio-fft;76;76;76;106;77;75;77;76;98;76 12:55:09 INFO - PROCESS | 8215 | |4;audio-oscillator;84;82;118;83;84;83;111;83;83;124 12:55:09 INFO - PROCESS | 8215 | |5;imaging-gaussian-blur;117;118;117;117;116;117;116;117;117;116 12:55:09 INFO - PROCESS | 8215 | |6;imaging-darkroom;147;146;146;146;146;146;146;146;146;146 12:55:09 INFO - PROCESS | 8215 | |7;imaging-desaturate;96;94;95;95;95;94;95;94;95;95 12:55:09 INFO - PROCESS | 8215 | |8;json-parse-financial;66;66;65;64;64;67;66;66;66;66 12:55:09 INFO - PROCESS | 8215 | |9;json-stringify-tinderbox;66;67;66;66;66;66;66;66;67;67 12:55:09 INFO - PROCESS | 8215 | |10;stanford-crypto-aes;92;84;90;83;82;104;83;83;92;82 12:55:09 INFO - PROCESS | 8215 | |11;stanford-crypto-ccm;157;140;150;139;143;148;152;139;187;136 12:55:09 INFO - PROCESS | 8215 | |12;stanford-crypto-pbkdf2;179;173;174;173;177;174;177;178;184;176 12:55:09 INFO - PROCESS | 8215 | |13;stanford-crypto-sha256-iterative;70;71;72;70;69;72;70;72;68;68 12:55:09 INFO - PROCESS | 8215 | __end_tp_report 12:55:09 INFO - PROCESS | 8215 | __start_cc_report 12:55:09 INFO - PROCESS | 8215 | _x_x_mozilla_cycle_collect,1997 12:55:09 INFO - PROCESS | 8215 | __end_cc_report 12:55:09 INFO - PROCESS | 8215 | __startTimestamp1476302109514__endTimestamp 12:55:09 INFO - PROCESS | 8215 | 12:55:09 INFO - PROCESS | 8215 | ------- Summary: start ------- 12:55:09 INFO - PROCESS | 8215 | Number of tests: 14 12:55:09 INFO - PROCESS | 8215 | 12:55:09 INFO - PROCESS | 8215 | [#0] ai-astar Cycles:10 Average:112.80 Median:113.00 stddev:0.92 (0.8%) stddev-sans-first:0.71 12:55:09 INFO - PROCESS | 8215 | Values: 111.0 114.0 113.0 112.0 113.0 114.0 113.0 113.0 113.0 112.0 12:55:09 INFO - PROCESS | 8215 | 12:55:09 INFO - PROCESS | 8215 | [#1] audio-beat-detection Cycles:10 Average:139.40 Median:131.00 stddev:18.89 (14.4%) stddev-sans-first:19.06 12:55:09 INFO - PROCESS | 8215 | Values: 156.0 128.0 126.0 170.0 131.0 126.0 127.0 131.0 172.0 127.0 12:55:09 INFO - PROCESS | 8215 | 12:55:09 INFO - PROCESS | 8215 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:0.84 (0.5%) stddev-sans-first:0.88 12:55:09 INFO - PROCESS | 8215 | Values: 162.0 162.0 161.0 162.0 163.0 161.0 162.0 161.0 162.0 160.0 12:55:09 INFO - PROCESS | 8215 | 12:55:09 INFO - PROCESS | 8215 | [#3] audio-fft Cycles:10 Average:81.30 Median:76.00 stddev:11.09 (14.6%) stddev-sans-first:11.59 12:55:09 INFO - PROCESS | 8215 | Values: 76.0 76.0 76.0 106.0 77.0 75.0 77.0 76.0 98.0 76.0 12:55:09 INFO - PROCESS | 8215 | 12:55:09 INFO - PROCESS | 8215 | [#4] audio-oscillator Cycles:10 Average:93.50 Median:83.00 stddev:16.97 (20.4%) stddev-sans-first:17.64 12:55:09 INFO - PROCESS | 8215 | Values: 84.0 82.0 118.0 83.0 84.0 83.0 111.0 83.0 83.0 124.0 12:55:09 INFO - PROCESS | 8215 | 12:55:09 INFO - PROCESS | 8215 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 12:55:09 INFO - PROCESS | 8215 | Values: 117.0 118.0 117.0 117.0 116.0 117.0 116.0 117.0 117.0 116.0 12:55:09 INFO - PROCESS | 8215 | 12:55:09 INFO - PROCESS | 8215 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.32 (0.2%) stddev-sans-first:0.00 12:55:09 INFO - PROCESS | 8215 | Values: 147.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 12:55:09 INFO - PROCESS | 8215 | 12:55:09 INFO - PROCESS | 8215 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.50 12:55:09 INFO - PROCESS | 8215 | Values: 96.0 94.0 95.0 95.0 95.0 94.0 95.0 94.0 95.0 95.0 12:55:09 INFO - PROCESS | 8215 | 12:55:09 INFO - PROCESS | 8215 | [#8] json-parse-financial Cycles:10 Average:65.60 Median:66.00 stddev:0.97 (1.5%) stddev-sans-first:1.01 12:55:09 INFO - PROCESS | 8215 | Values: 66.0 66.0 65.0 64.0 64.0 67.0 66.0 66.0 66.0 66.0 12:55:09 INFO - PROCESS | 8215 | 12:55:09 INFO - PROCESS | 8215 | [#9] json-stringify-tinderbox Cycles:10 Average:66.30 Median:66.00 stddev:0.48 (0.7%) stddev-sans-first:0.50 12:55:09 INFO - PROCESS | 8215 | Values: 66.0 67.0 66.0 66.0 66.0 66.0 66.0 66.0 67.0 67.0 12:55:09 INFO - PROCESS | 8215 | 12:55:09 INFO - PROCESS | 8215 | [#10] stanford-crypto-aes Cycles:10 Average:87.50 Median:83.50 stddev:7.09 (8.5%) stddev-sans-first:7.33 12:55:09 INFO - PROCESS | 8215 | Values: 92.0 84.0 90.0 83.0 82.0 104.0 83.0 83.0 92.0 82.0 12:55:09 INFO - PROCESS | 8215 | 12:55:09 INFO - PROCESS | 8215 | [#11] stanford-crypto-ccm Cycles:10 Average:149.10 Median:149.00 stddev:14.93 (10.0%) stddev-sans-first:15.55 12:55:09 INFO - PROCESS | 8215 | Values: 157.0 140.0 150.0 139.0 143.0 148.0 152.0 139.0 187.0 136.0 12:55:09 INFO - PROCESS | 8215 | 12:55:09 INFO - PROCESS | 8215 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.50 Median:177.00 stddev:3.37 (1.9%) stddev-sans-first:3.46 12:55:09 INFO - PROCESS | 8215 | Values: 179.0 173.0 174.0 173.0 177.0 174.0 177.0 178.0 184.0 176.0 12:55:09 INFO - PROCESS | 8215 | 12:55:09 INFO - PROCESS | 8215 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.20 Median:70.50 stddev:1.55 (2.2%) stddev-sans-first:1.64 12:55:09 INFO - PROCESS | 8215 | Values: 70.0 71.0 72.0 70.0 69.0 72.0 70.0 72.0 68.0 68.0 12:55:09 INFO - PROCESS | 8215 | -------- Summary: end -------- 12:55:09 INFO - PROCESS | 8215 | 12:55:10 INFO - TEST-INFO | 8215: exit 0 12:55:10 INFO - TEST-OK | kraken | took 64733ms 12:55:10 INFO - SUITE-END | took 1187s 12:55:11 INFO - Completed test suite (00:19:47) 12:55:11 INFO - javascript benchmark 12:55:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2589.75397337253, 2614.738526147384, 2651.2443953473257, 2662.227953893371, 2675.3980354420246, 4664.416947881515, 4735.0766600512825, 4743.478217396084, 4840.128776820171, 4878.243872199806, 4767.690100143488, 4822.30076638888, 4855.247436647316, 4896.314515967767, 4944.456109827916, 4378.452693413324, 4390.0, 4430.822767089328, 4441.000774825655, 4465.598096171344, 4399.922019105324, 4526.479454862683, 4533.886652833673, 4542.38677778499, 4569.29175977724, 4330.631896288819, 4463.754493502856, 4467.262901621229, 4467.932981005288, 4564.680472366936, 4359.782010899442, 4420.8452704155525, 4431.49037860647, 4433.733975961421, 4438.689291749579, 4218.957810421887, 4234.513031001413, 4256.106217694288, 4388.363687265329, 4393.824247030115, 4601.2637977923705, 4655.371524844137, 4659.301104834268, 4659.976700116512, 4675.719456832601, 4910.484399138075, 4917.041176970492, 4917.803287868481, 4925.408950925912, 4991.32617096691, 4939.135651261015, 4943.209086546135, 4948.901021979576, 5003.049420610108, 5033.345665063555, 4749.026449577863, 4803.855884323476, 4811.855644330676, 4849.127157111754, 4851.75741212945, 5272.657277276965, 5311.521963023347, 5323.574114070865, 5327.973360133252, 5377.032134215879, 5079.466656001066, 5083.669561478492, 5093.644078280061, 5095.847124586268, 5114.43741188469, 4975.253711943237, 5015.348004759431, 5021.096202683479, 5037.722925239147, 5170.560502357342, 5039.647224694309, 5066.138756411346, 5125.538701516807, 5141.151709967889, 5142.04872098663, 5045.672031317952, 5050.292958985745, 5059.544640982329, 5063.189889617717, 5114.488551144856, 4226.873193804191, 4268.743875367488, 4324.027093903846, 4337.631301339421, 4377.4528183977, 3750.062484378905, 3775.9056023599082, 3779.3764028934916, 3786.2238241160494, 3832.846686132579, 4416.977915110404, 4421.292593185075, 4428.402165707653, 4429.955700443019, 4477.395551600493, 5091.261767043758, 5124.231365295235, 5133.717645529532, 5140.1004824155625, 5200.583953283804, 4343.804528796211, 4382.035952090535, 4387.934180987288, 4406.030673251879, 4457.398251236106, 4611.123886461562, 4623.491415944243, 4625.283081122431, 4648.279516674921, 4652.232381656989, 4844.176489996779, 4845.685030473008, 4904.58311043551, 4904.6321525885705, 4905.0189962007025, 5170.482951704799, 5178.870528236825, 5179.792808287626, 5184.403793563638, 5251.606129540376, 4658.67389282747, 4709.858704238878, 4836.637252206028, 4839.975800120977, 4897.363342765418, 4888.462269150462, 4896.583790377857, 4933.753312334441, 4965.0, 5009.499050094962, 5000.149974504416, 5054.620903432331, 5064.7467626619255, 5067.5185857343495, 5121.8463446096675, 4917.631177661761, 4929.186684197068, 4930.531599498042, 4932.3341348918875, 4987.875303117451, 4838.927416088691, 4847.636427267898, 4894.926576101432, 4924.753762311799, 4931.260310953386, 4984.6261530384645, 4999.350084488993, 5004.87487812793, 5033.572146367454, 5069.569086627678, 5086.720230387365, 5087.821926232564, 5088.135017047037, 5091.236314552699, 5156.40701319338, 4777.140114779373, 4825.734584597881, 4827.106985207748, 4956.0, 4957.6281778866005], "value": 4687.665799154239, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [570.7945139749689, 575.7092668202557, 579.8347470970774, 586.7946218823413, 590.2415396215862, 27052.72947270529, 37009.259814803685, 38063.80968095159, 38066.8096659517, 41544.79227603858, 39070.218595628074, 39249.803750981206, 39505.802470987604, 39530.60469395312, 39557.0, 7537.24627537246, 7691.038620172479, 7691.269464370528, 7695.115061767884, 7695.769126926173, 7543.660535275898, 7630.0, 7630.694772209105, 7636.0, 7636.312731854132, 7648.2351764823625, 7679.923200767977, 7694.961525192394, 7699.26856948589, 7701.0, 7581.924180758177, 7631.961840190819, 7633.084029916446, 7638.8472230555635, 7641.617919104023, 7578.204288549678, 7635.389168866477, 7640.80897977555, 7641.732539361095, 7643.656035478417, 36391.81804090989, 36686.81656591727, 36706.08234794151, 36729.26541469182, 36742.26515469702, 3018.864151113183, 3129.264622813637, 3212.132724164486, 3253.3981213475345, 3676.5771936227407, 27370.45259094807, 27504.79961603087, 27844.16467505978, 27928.0, 28687.13938581846, 3376.6623337666283, 3388.423967925459, 3419.7264218862433, 3463.8268086595567, 3545.3972824619877, 230228.0, 231751.0, 231887.0, 232808.83595582083, 233044.0, 30693.86122775454, 31586.526202106987, 31665.0, 48463.27305090427, 48943.0, 32894.17764555905, 32974.0, 32980.0, 33014.17464563405, 33027.174320642174, 12685.365731713377, 12806.871931280753, 12817.0, 12826.551070712667, 12830.101892867597, 10450.320729152581, 10528.684139475828, 10529.473526323653, 10531.368117912949, 10536.631217907336, 7802.219778022152, 7844.882326765103, 7856.685732570633, 7923.603819809102, 7928.8810667840025, 3052.9542056869163, 3098.597182366278, 3102.115896969353, 3111.735502482269, 3129.8122112673313, 815.3314282288467, 900.8243392538392, 910.3991365698607, 965.9034096590285, 976.7411635916487, 26309.473810523683, 26680.866595667285, 26823.731762682124, 27340.863295683394, 27360.905563777225, 906.850369688994, 924.5331107790523, 963.3641796414333, 969.2730452160879, 990.6037584965927, 13891.916212568196, 14573.0, 14642.926785366006, 14743.41026358955, 14777.48278810258, 357967.0, 390001.0, 398373.0, 399582.0, 604197.0, 43770.56229437728, 44433.555664443586, 44450.55549444464, 44451.77774111109, 44500.332495012604, 1056.8414737789394, 1111.3498603316827, 1159.913006524514, 1160.2110564816005, 1182.7102359921703, 24392.26823195307, 26879.731202687723, 27325.590116147876, 29422.082302676474, 29510.852445737633, 44607.33089003603, 45357.319640206086, 45390.54609453995, 45413.31880021736, 45463.0, 320068.0, 323399.0, 324179.0, 324284.0, 325107.0, 21359.57280854343, 21579.0, 21758.486366165682, 24590.631140532547, 25038.874805625856, 33862.0, 37983.430248545745, 38953.41569876397, 38959.95301472244, 39059.80470097745, 33391.83304083464, 33496.83251583727, 33672.49491257584, 33967.0, 34100.82949585335, 30044.699553005066, 33443.0, 34143.82928085344, 34557.13607159741, 34610.13474663053, 25756.0, 28101.0, 29358.119256422342, 33558.16104597307, 33796.32407351888, 27188.864055679594, 31159.376812464077, 31206.698178522376, 31274.208162818326, 31386.843065784524, 23546.882265588563, 24083.518329633658, 24253.636195457435, 24654.753452465964, 24681.0], "value": 15832.822295733167, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [344.93273811606747, 361.1008588614349, 376.72687301706264, 376.91896242307905, 392.43881249812773, 12071.879281207186, 12305.753884922296, 12961.287129207878, 13156.671083222924, 16862.156892155406, 16232.269547870344, 16524.339026438927, 16527.173641317917, 16663.66672666549, 16691.248893799777, 4816.0, 4982.078315511633, 5055.241713742931, 5075.441701412841, 5081.339425874631, 3472.947905781415, 3629.4192929131345, 4991.251312303148, 5092.592592592584, 5097.108006098936, 5562.249096371998, 5812.389699081599, 5846.7076646167525, 5894.351621321651, 5920.0, 5699.772009119631, 5846.795362162326, 5870.3836097209605, 5893.7053147342895, 5921.0, 5162.974185129088, 5178.4562620924635, 5186.429492755794, 5190.636655434121, 5192.974035129838, 19120.904395477934, 20110.899445502826, 20252.088656010514, 20260.392188234375, 20284.290049848183, 1930.0639189992842, 1964.027806235908, 2013.7784843667184, 2202.2292197730667, 2332.825038122148, 11952.880471195263, 12743.362831858463, 12770.680732981657, 12987.0, 13317.800232996417, 1689.7634331193642, 1748.5278974676767, 1752.141450689153, 1764.7617571627795, 1787.6782179207737, 63966.68016659933, 65071.99999999953, 65625.3437465624, 67593.0, 67645.66177169132, 9531.332806703464, 9829.361091529028, 9948.80102397948, 9950.648513255492, 10155.800922709323, 13325.600231993056, 13475.865241347461, 13482.460701572023, 13485.932570337085, 13497.325133743274, 6601.5378923475855, 6649.468042556584, 6823.624700641413, 6865.347791959756, 6922.896156557656, 6010.489108425745, 6045.879082418327, 6265.248170219603, 6280.120783090371, 6281.7173227204885, 4138.958610413857, 4280.0, 4302.698811083194, 4342.82628694855, 4390.385346051556, 1640.1635166065394, 1690.2900781671729, 1700.4133573917227, 1724.2154819557072, 1738.0527612450992, 819.1358117186426, 843.8987321521457, 845.3026253341018, 879.9956000219958, 892.683097500391, 15614.687706245812, 16197.352105915867, 16580.17099145038, 16612.335506579842, 17152.284771522747, 836.4521238588734, 847.902491213506, 877.8551538995994, 889.4485419040236, 914.3234006835028, 8802.823943521094, 9418.858717119248, 9441.858372124423, 9490.430574165572, 9518.143367096995, 279389.0, 283318.0, 283827.0, 401453.0, 402746.0, 79692.60153699195, 83092.0, 83756.58121709352, 84691.57654211689, 84915.57542212373, 912.771807048238, 921.1433366968784, 948.7485816258697, 956.5408603870181, 968.801395713877, 15197.6200594986, 15237.695246094794, 15647.452339168074, 15857.127857967462, 16049.277782499583, 33579.328413432086, 36297.45553816748, 37586.436203456426, 38067.80966095152, 38084.81067082563, 48657.756711216214, 51941.7402912983, 53287.0, 53984.460155399516, 54433.0, 7406.814829629302, 7565.924340756742, 7659.846803064019, 7660.425468090027, 7675.654595543102, 10293.897061029294, 10740.355578665305, 11301.208915375844, 11415.200935934738, 11752.118591105873, 9834.360766550151, 10048.196144308291, 10107.140893024176, 10193.0, 10566.894331056592, 9172.08279172104, 9857.162141218078, 9998.400095994264, 10090.899091009289, 10282.177425806067, 9478.715638530855, 9524.619015239312, 10009.449480278654, 10173.38959662393, 10364.119049880845, 7406.740764073232, 7488.138864030706, 7539.472236943361, 7600.049993750781, 7633.1985141559335, 8585.570721464026, 9909.504524773876, 10001.899981000097, 10144.847827282449, 10244.360902255603], "value": 8071.155275191362, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1200.3698058519283, 1335.559265442404, 1375.456694605631, 1381.820363352764, 1675.2712570032038, 6629.171353580797, 7359.816004599881, 7592.050993625797, 7626.618669066538, 7817.374610031198, 7633.885491717629, 7698.0, 7708.653110610022, 7715.6142192890275, 7721.498102623325, 2161.967570486444, 2180.5420861619077, 2181.7490988536365, 2187.1579441914896, 2188.2888061380036, 2100.884451355175, 2140.8715477071346, 2181.923632672857, 2182.4980254541465, 2182.7271591051117, 2089.9791002090014, 2094.6857971304275, 2095.2561840546614, 2097.4127244371525, 2201.482651576878, 2106.9473263168466, 2108.641530939744, 2111.3032699209225, 2111.6199084164996, 2112.23959374625, 2081.718967939324, 2139.133650871384, 2139.6041732279577, 2139.8716077035274, 2140.8073273405466, 7574.091109066947, 7699.923000769976, 7773.766786996399, 7880.684772609089, 7888.447808653396, 4528.5245049270015, 4655.697379670344, 4658.277966915133, 4658.534146585348, 4665.463471700764, 2736.3022429280404, 2853.629028226338, 2883.6539615246097, 2898.3333833218267, 2900.0719769673715, 864.7319331007345, 870.9651613935436, 883.6465413834453, 884.8893888263967, 895.6104094718818, 10039.447830369327, 10094.343867648653, 10111.89888101117, 10174.745631359201, 10177.236707246986, 3922.7057970651745, 4126.174765047002, 4200.957990420118, 4228.365745138192, 4231.322988321916, 8115.75652730419, 8116.188381161836, 8120.269175774209, 8121.228483294078, 8132.1867813218205, 4596.379488768974, 4603.562661547147, 4607.378003969488, 4607.976960115178, 4611.838585649486, 3677.8712745053795, 3796.37359835624, 4080.6531444827524, 4260.147970405869, 4262.360645903077, 3264.8041117533025, 3320.9169770755443, 3400.9659903400648, 3405.7956522608724, 3409.90882917469, 1005.2862467647906, 1019.4902548725637, 1031.783325501653, 1032.442481060219, 1039.719275795531, 765.5559775330295, 785.9449838511364, 833.8499070167306, 841.0748177005368, 857.6955180910811, 5194.0910340690225, 5216.686998780086, 5270.710110943858, 5315.6013299002725, 5426.077566813651, 406.50203500711984, 409.5679058593213, 424.1453471255423, 425.85520922886366, 428.7117212775652, 3392.8812491562676, 3472.5138480612736, 3609.314230296235, 3712.7747843211673, 3743.4010558311084, 8808.251298639687, 9138.17756401927, 9148.542572871329, 9176.265898728087, 9210.125038121369, 9109.954450227706, 9120.179183873483, 9145.725628231165, 9153.084691530927, 9159.313051521163, 7102.573845569283, 7128.180259270147, 7159.176694680074, 7160.212376638461, 7169.24722904098, 4990.80036798524, 5014.498550144956, 5039.899202016012, 5132.820351287687, 5387.81142660005, 8559.945613052947, 8604.913950860662, 8675.262602678842, 8696.17386348296, 8764.824703505767, 8626.870596940926, 8864.955675221583, 8882.911170888208, 8928.375013749235, 8928.687495937611, 5569.55443564522, 5970.880582388415, 6011.969940150271, 6065.545084118797, 6072.666003369857, 6462.644554549545, 6746.224184218878, 6943.0, 6961.75633852833, 7165.677544510614, 6342.714577843916, 6361.681915904093, 6427.58220715652, 6563.901541476977, 6591.0, 6370.299267080525, 6408.679566021773, 6438.29178790342, 6454.870902582016, 6459.386358295955, 6031.0, 6136.631802091889, 6158.969205153946, 6179.938200618116, 6190.907136393048, 4607.815687372467, 4647.581717645428, 4755.762211889322, 4760.428748550196, 4803.087413391444, 4658.976705116588, 4719.4100737407825, 4738.147133516, 4806.134895718804, 4881.585065269492], "value": 3927.946432589002, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [286.30713672911565, 300.07726241806444, 307.3300205551896, 307.41437561445446, 309.10051749409223, 4645.396098507189, 4810.44679861816, 4817.470078291394, 4842.9031419371595, 4864.367632207813, 4551.0, 4675.649326300532, 4689.9296510552285, 4719.457262414823, 4799.064182484417, 3764.3036038333, 3822.140018495844, 3826.1582451860545, 3826.712996525258, 3832.405977073558, 3549.485324627927, 3693.0057768804813, 3779.8866034019024, 3784.735068545203, 3798.183390571027, 3599.8380072896784, 3739.6260373962523, 3746.5201245508006, 3755.718321125913, 3773.9622603774023, 3727.552693676776, 3749.850005999757, 3760.3795373763296, 3771.07608635886, 3784.6593806557266, 3324.16895776056, 3325.617553981299, 3325.8004519728893, 3337.1490269981, 3340.7828491148, 4471.932921006188, 4603.470600880908, 4650.697704649187, 4655.255159174516, 4670.085265041351, 4237.745735255895, 4243.448351714288, 4264.722793018444, 4267.125239325931, 4267.829286828523, 4900.289458028566, 4919.163742163841, 4937.604991600663, 4955.256711493269, 4973.776180071905, 3361.277325375056, 3568.357695614788, 3634.9636503635156, 3640.6541378568995, 3648.343298206322, 5193.584513238894, 5235.293235413209, 5242.580593552507, 5243.79024839006, 5248.71132087735, 3659.9268014639556, 3662.853485860536, 3669.2478042001326, 3670.3943849265106, 3672.8347224374966, 3726.5900750917376, 3727.869524566627, 3730.2353017631863, 3745.5879853216125, 3745.700343972476, 4143.02638879863, 4171.478565179353, 4181.958180418157, 4209.137126888981, 4249.553796851348, 4993.950060499421, 4995.275685025651, 5002.972013126784, 5006.19900815875, 5019.447860735316, 1196.252342286071, 1227.613301809945, 1269.2511418263268, 1271.586734311334, 1283.582835578422, 854.5684429363256, 880.7489865388462, 883.5361435246418, 883.9734807955772, 894.4767311123065, 4463.709858859163, 4468.776561171993, 4470.396496472999, 4471.674729140894, 4481.395011673382, 5154.226865970135, 5169.198774190007, 5170.560502357342, 5171.844844654666, 5175.378954525406, 4318.438602981592, 4459.487158976694, 4520.254158063948, 4533.478649955231, 4570.7257564546235, 2752.683441404264, 2773.2650847525424, 2774.417372351829, 2778.208210659993, 2786.676328743871, 4907.165781817028, 4911.649296443436, 4924.852254432372, 4927.852164435073, 4928.186849169847, 5114.0, 5240.554552862973, 5256.9737151314, 5277.868053298698, 5304.496072873071, 4854.271859221074, 4856.514348565115, 4865.781039853215, 4875.68308059975, 4890.779914903838, 5050.671706339076, 5177.637565370388, 5188.636795424284, 5211.9478805212975, 5227.2420499028185, 5051.520105589963, 5060.01329740697, 5069.695818250917, 5078.238264260391, 5110.310108135503, 4866.853994380174, 4870.05034018363, 4888.633352498506, 4909.299885063272, 4946.332245146859, 3674.761140525857, 3685.133993511469, 3691.151035261851, 3696.7227457940226, 3705.018170184957, 5073.543381095719, 5149.716765577929, 5179.249008893765, 5179.378474583074, 5224.190250511177, 4985.5762260208285, 5015.523525265094, 5017.197248440232, 5040.57155141817, 5041.697498150123, 4890.193118135468, 5057.089723849743, 5067.5185857343495, 5071.54356107952, 5099.69401835891, 4707.741074240949, 4849.975750121227, 4940.530649588283, 4955.281484184845, 4993.27597498368, 4872.733089396712, 4997.525235102659, 5002.549770520671, 5013.448520662651, 5021.774020169174, 4897.95102048975, 4920.8769780755765, 4930.556249937523, 4933.309336692938, 4949.133901567283], "value": 3791.733785759992, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [585.9979435165866, 594.3195041677279, 628.4689437425379, 654.9665818187231, 681.5263391942602, 10774.138068954484, 11163.553457861695, 12075.758484830298, 13209.603711888647, 13228.801567976465, 9869.802603947917, 10987.39569323687, 13413.0, 13655.453781848713, 13744.312784360793, 750.7034721285103, 765.3800421658447, 774.6088225446142, 775.2092865277414, 775.3099741230282, 619.3589634728057, 634.2325785799188, 778.3850757901251, 781.4178437064395, 781.7889169924117, 668.4184759259451, 670.5038271678972, 670.8255853478082, 783.8549868274359, 807.3379828540599, 796.9960150199241, 801.5471258738852, 801.5631480842897, 801.7033697531892, 801.7714951238898, 588.6644612570793, 588.9587728858982, 589.2545929399313, 589.2634207240949, 589.4783116941537, 11712.824307635392, 11728.589499367567, 11738.237014594024, 11738.647840564796, 11749.06007519405, 12167.756644867053, 12379.62861114168, 12633.557825476157, 12729.490820367175, 12921.0, 11251.774964500746, 11507.309561426342, 11800.114991375596, 11897.702557436134, 11936.224145430519, 4058.6955978301744, 4102.528209255914, 4111.588841115894, 4250.404943307939, 4279.7218180818145, 42070.579294206975, 43536.78231608853, 50352.496475035514, 64481.67759161174, 64735.763211839694, 9932.0, 9938.0, 9963.202943764481, 10109.191264698953, 10148.838976019797, 19271.421857344303, 19441.31955381555, 19573.51066223356, 19660.21359145618, 19668.21327146898, 6764.864702706017, 6855.383015528626, 6880.58716477003, 6980.616066116412, 6993.300669933068, 3578.5526809148855, 3612.8012959286966, 3615.493830863681, 3662.1577037281572, 3664.72514561409, 2922.5616157576533, 3026.0921723482866, 3033.0294305821926, 3038.316378814749, 3040.346325539975, 487.98668223718397, 491.5698763581866, 499.8550420378122, 501.58869726823656, 504.9924251136236, 581.2066529187629, 584.6579750845802, 600.6576251536669, 601.8525461262019, 612.0757655939564, 7206.495545311883, 7253.419726421979, 7572.962135189399, 7622.58075805836, 7640.579768112807, 479.61630695443506, 499.40321316027723, 575.0712599152339, 580.9041508151192, 590.3977942498627, 3556.5732112146707, 3594.5866225383893, 3596.3166998270244, 3610.5667319921777, 3756.586775454698, 100823.49588252012, 102542.0, 103007.0, 103458.0, 107862.46068769606, 50249.49750502521, 50381.0, 61927.6903615479, 86673.0, 88137.0, 71505.64247178835, 83789.58105209557, 83791.0, 84607.0, 84868.57565712255, 6950.721971121301, 7150.606716630636, 7269.091363579552, 7410.777676669709, 7566.167721550515, 47697.76151119222, 48640.0, 48788.0, 49196.26205606991, 49897.00823934149, 37706.245875082896, 52846.471535285695, 54788.452115478336, 55777.44222557722, 55882.1617675727, 10160.390376577134, 10243.38539687621, 10374.118199953089, 10443.373397596168, 10968.670939871816, 11931.0, 12171.817422738843, 13104.968729846889, 13118.672033199246, 13193.736125277632, 10592.735181620214, 11116.333020018501, 11318.094552435621, 11997.0, 12005.939970300093, 11168.66494005181, 11508.194426390073, 11571.074314055024, 12000.75998480043, 12181.33002684861, 10508.474576271308, 10617.89382106169, 10943.781124377627, 11232.494537745657, 11507.942460287644, 8858.715486254587, 9029.593668284811, 9207.352698836112, 10022.398656080659, 10029.548670309707, 9320.95339523298, 9460.95269523648, 9491.620335186792, 10289.794204115726, 10304.484775761031], "value": 6353.3791503900275, "unit": "score"}], "name": "dromaeo_css", "value": 6197.991260607142, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 114.0, 113.0, 112.0, 113.0, 114.0, 113.0, 113.0, 113.0, 112.0], "value": 112.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 128.0, 126.0, 170.0, 131.0, 126.0, 127.0, 131.0, 172.0, 127.0], "value": 139.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 161.0, 162.0, 163.0, 161.0, 162.0, 161.0, 162.0, 160.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 106.0, 77.0, 75.0, 77.0, 76.0, 98.0, 76.0], "value": 81.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 82.0, 118.0, 83.0, 84.0, 83.0, 111.0, 83.0, 83.0, 124.0], "value": 93.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 116.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 94.0, 95.0, 95.0, 95.0, 94.0, 95.0, 94.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 65.0, 64.0, 64.0, 67.0, 66.0, 66.0, 66.0, 66.0], "value": 65.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 66.0, 66.0, 66.0, 66.0, 66.0, 66.0, 67.0, 67.0], "value": 66.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 84.0, 90.0, 83.0, 82.0, 104.0, 83.0, 83.0, 92.0, 82.0], "value": 87.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 140.0, 150.0, 139.0, 143.0, 148.0, 152.0, 139.0, 187.0, 136.0], "value": 149.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 173.0, 174.0, 173.0, 177.0, 174.0, 177.0, 178.0, 184.0, 176.0], "value": 176.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 71.0, 72.0, 70.0, 69.0, 72.0, 70.0, 72.0, 68.0, 68.0], "value": 70.2, "unit": "score"}], "name": "kraken", "value": 1561.4999999999998, "alertThreshold": 2.0}]} 12:55:11 INFO - Return code: 0 12:55:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:55:11 INFO - # TBPL SUCCESS # 12:55:11 INFO - Running post-action listener: _resource_record_post_action 12:55:11 INFO - [mozharness: 2016-10-12 19:55:11.317743Z] Finished run-tests step (success) 12:55:11 INFO - Running post-run listener: _resource_record_post_run 12:55:11 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 0; Write bytes: 393359360; Read time: 0; Write time: 265748 12:55:11 INFO - TinderboxPrint: CPU usage
13.0% 12:55:11 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 12:55:11 INFO - TinderboxPrint: I/O write bytes / time
393,359,360 / 265,748 12:55:11 INFO - TinderboxPrint: CPU idle
8,354.5 (87.0%) 12:55:11 INFO - TinderboxPrint: CPU user
1,204.2 (12.5%) 12:55:11 INFO - TinderboxPrint: Swap in / out
0 / 0 12:55:11 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99540992; Read time: 0; Write time: 84680 12:55:11 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 291508224; Read time: 0; Write time: 180880 12:55:11 INFO - Running post-run listener: _upload_blobber_files 12:55:11 INFO - Blob upload gear active. 12:55:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:55:11 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 12:55:11 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'] 12:55:11 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 12:55:12 INFO - (blobuploader) - INFO - Open directory for files ... 12:55:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:55:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:55:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:55:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:55:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:55:13 INFO - (blobuploader) - INFO - Done attempting. 12:55:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:55:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:55:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:55:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:55:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:55:14 INFO - (blobuploader) - INFO - Done attempting. 12:55:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:55:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:55:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:55:18 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:55:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:55:18 INFO - (blobuploader) - INFO - Done attempting. 12:55:18 INFO - (blobuploader) - INFO - Iteration through files over. 12:55:18 INFO - Return code: 0 12:55:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:55:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:55:18 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/c447dffc00880a0a3853138580a2cc997638ae59cdf1e2f1a1e5b68a1b3890fcd76b18cb2686408ecb1dab970edb50d18e1dff46b7918a8c8db0808db2652702", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/f7643959f292557f241df4d29de3b1d6ba8967b939c924a93118204f76a6e45404f527f4a05fb343430c7d03b29313e6aa340ed7dd894ef3f761d7a82113b40f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/3b0e4c7b1502dcaa3095ec52967d1128545f103b092c954c8d676116f7b8ac20a43b7e383748e673f2bebf24c9f47541b1c0b92c9dbd8ce039d5a6a508747d82"} 12:55:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:55:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:55:18 INFO - Contents: 12:55:18 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/c447dffc00880a0a3853138580a2cc997638ae59cdf1e2f1a1e5b68a1b3890fcd76b18cb2686408ecb1dab970edb50d18e1dff46b7918a8c8db0808db2652702", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/f7643959f292557f241df4d29de3b1d6ba8967b939c924a93118204f76a6e45404f527f4a05fb343430c7d03b29313e6aa340ed7dd894ef3f761d7a82113b40f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/3b0e4c7b1502dcaa3095ec52967d1128545f103b092c954c8d676116f7b8ac20a43b7e383748e673f2bebf24c9f47541b1c0b92c9dbd8ce039d5a6a508747d82"} 12:55:18 INFO - Running post-run listener: copy_logs_to_upload_dir 12:55:18 INFO - Copying logs to upload dir... 12:55:18 INFO - mkdir: /builds/slave/test/build/upload/logs 12:55:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.691100 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-10-12 12:55:18.138177) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-12 12:55:18.142102) ========= 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=db7e7c15f3ca076d53731445000001ba-1476300867.823101-1744932873 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/c447dffc00880a0a3853138580a2cc997638ae59cdf1e2f1a1e5b68a1b3890fcd76b18cb2686408ecb1dab970edb50d18e1dff46b7918a8c8db0808db2652702", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/f7643959f292557f241df4d29de3b1d6ba8967b939c924a93118204f76a6e45404f527f4a05fb343430c7d03b29313e6aa340ed7dd894ef3f761d7a82113b40f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/3b0e4c7b1502dcaa3095ec52967d1128545f103b092c954c8d676116f7b8ac20a43b7e383748e673f2bebf24c9f47541b1c0b92c9dbd8ce039d5a6a508747d82"} build_url:https://queue.taskcluster.net/v1/task/ahOzpdOATQ-VfLPVgGLszQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011297 build_url: 'https://queue.taskcluster.net/v1/task/ahOzpdOATQ-VfLPVgGLszQ/artifacts/public/build/firefox-52.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/c447dffc00880a0a3853138580a2cc997638ae59cdf1e2f1a1e5b68a1b3890fcd76b18cb2686408ecb1dab970edb50d18e1dff46b7918a8c8db0808db2652702", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/f7643959f292557f241df4d29de3b1d6ba8967b939c924a93118204f76a6e45404f527f4a05fb343430c7d03b29313e6aa340ed7dd894ef3f761d7a82113b40f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/3b0e4c7b1502dcaa3095ec52967d1128545f103b092c954c8d676116f7b8ac20a43b7e383748e673f2bebf24c9f47541b1c0b92c9dbd8ce039d5a6a508747d82"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-12 12:55:18.168064) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 12:55:18.168409) ========= 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=db7e7c15f3ca076d53731445000001ba-1476300867.823101-1744932873 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004455 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 12:55:18.251441) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-12 12:55:18.251800) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-12 12:55:18.252135) ========= ========= Total master_lag: 0.17 =========