builder: autoland_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-031 starttime: 1470633411.0 results: success (0) buildid: 20160807205552 builduid: 9c518ae8cb2f4230946c565c1cd36042 revision: 513d42e7a166bab34785c7f727704bf8d32c1a36 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-07 22:16:50.998437) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-07 22:16:50.998892) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-07 22:16:50.999194) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-07 22:16:51.017356) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 22:16:51.017609) ========= 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=db0483c52d987ecb441a263b000001ad-1470632956.631379-321176434 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-07 22:16:51-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 41.0M=0s 2016-08-07 22:16:51 (41.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.124804 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 22:16:51.155976) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 22:16:51.156296) ========= 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=db0483c52d987ecb441a263b000001ad-1470632956.631379-321176434 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017609 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 22:16:51.206290) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 22:16:51.206645) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 513d42e7a166bab34785c7f727704bf8d32c1a36 --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 513d42e7a166bab34785c7f727704bf8d32c1a36 --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=db0483c52d987ecb441a263b000001ad-1470632956.631379-321176434 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-07 22:16:51,372 truncating revision to first 12 chars 2016-08-07 22:16:51,372 Setting DEBUG logging. 2016-08-07 22:16:51,372 attempt 1/10 2016-08-07 22:16:51,373 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/513d42e7a166?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-07 22:16:51,694 unpacking tar archive at: autoland-513d42e7a166/testing/mozharness/ program finished with exit code 0 elapsedTime=0.651150 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 22:16:51.870967) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-07 22:16:51.871248) ========= script_repo_revision: 513d42e7a166bab34785c7f727704bf8d32c1a36 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-07 22:16:51.871620) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-07 22:16:51.874736) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-07 22:16:51.892745) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-08-07 22:16:51.893015) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=db0483c52d987ecb441a263b000001ad-1470632956.631379-321176434 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:16:52 INFO - MultiFileLogger online at 20160807 22:16:52 in /builds/slave/test 22:16:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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 22:16:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:16:52 INFO - {'append_to_log': False, 22:16:52 INFO - 'base_work_dir': '/builds/slave/test', 22:16:52 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 22:16:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:16:52 INFO - 'branch': 'Autoland-Non-PGO', 22:16:52 INFO - 'buildbot_json_path': 'buildprops.json', 22:16:52 INFO - 'config_files': ('talos/linux_config.py',), 22:16:52 INFO - 'default_actions': ('clobber', 22:16:52 INFO - 'read-buildbot-config', 22:16:52 INFO - 'download-and-extract', 22:16:52 INFO - 'populate-webroot', 22:16:52 INFO - 'create-virtualenv', 22:16:52 INFO - 'install', 22:16:52 INFO - 'run-tests'), 22:16:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:16:52 INFO - 'download_minidump_stackwalk': True, 22:16:52 INFO - 'download_symbols': 'ondemand', 22:16:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:16:52 INFO - 'tooltool.py': '/tools/tooltool.py', 22:16:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:16:52 INFO - '/tools/misc-python/virtualenv.py')}, 22:16:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:16:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:16:52 INFO - 'installer_path': 'installer.exe', 22:16:52 INFO - 'log_level': 'info', 22:16:52 INFO - 'log_name': 'talos', 22:16:52 INFO - 'log_to_console': True, 22:16:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:16:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:16:52 INFO - 'opt_config_files': (), 22:16:52 INFO - 'pip_index': False, 22:16:52 INFO - 'sps_profile': False, 22:16:52 INFO - 'sps_profile_interval': 0, 22:16:52 INFO - 'suite': 'dromaeojs-e10s', 22:16:52 INFO - 'system_bits': '32', 22:16:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:16:52 INFO - 'title': 'talos-linux64-ix-031', 22:16:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:16:52 INFO - 'use_talos_json': True, 22:16:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:16:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:16:52 INFO - 'work_dir': 'build'} 22:16:52 INFO - [mozharness: 2016-08-08 05:16:52.152954Z] Running clobber step. 22:16:52 INFO - Running pre-action listener: _resource_record_pre_action 22:16:52 INFO - Running main action method: clobber 22:16:52 INFO - rmtree: /builds/slave/test/build 22:16:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:16:52 INFO - Running post-action listener: _resource_record_post_action 22:16:52 INFO - [mozharness: 2016-08-08 05:16:52.606633Z] Finished clobber step (success) 22:16:52 INFO - [mozharness: 2016-08-08 05:16:52.606733Z] Running read-buildbot-config step. 22:16:52 INFO - Running pre-action listener: _resource_record_pre_action 22:16:52 INFO - Running main action method: read_buildbot_config 22:16:52 INFO - Using buildbot properties: 22:16:52 INFO - { 22:16:52 INFO - "project": "", 22:16:52 INFO - "product": "firefox", 22:16:52 INFO - "script_repo_revision": "production", 22:16:52 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs-e10s", 22:16:52 INFO - "repository": "", 22:16:52 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs-e10s", 22:16:52 INFO - "buildid": "20160807205552", 22:16:52 INFO - "pgo_build": "False", 22:16:52 INFO - "basedir": "/builds/slave/test", 22:16:52 INFO - "buildnumber": 236, 22:16:52 INFO - "slavename": "talos-linux64-ix-031", 22:16:52 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 22:16:52 INFO - "platform": "ubuntu64_hw", 22:16:52 INFO - "scheduler": "tests-autoland-linux64-talos", 22:16:52 INFO - "branch": "autoland", 22:16:52 INFO - "repo_path": "integration/autoland", 22:16:52 INFO - "revision": "513d42e7a166bab34785c7f727704bf8d32c1a36", 22:16:52 INFO - "stage_platform": "linux64", 22:16:52 INFO - "builduid": "9c518ae8cb2f4230946c565c1cd36042", 22:16:52 INFO - "slavebuilddir": "test" 22:16:52 INFO - } 22:16:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/Rnk5KSAQT8u2mUUaU9BysA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 22:16:52 INFO - Running post-action listener: _resource_record_post_action 22:16:52 INFO - [mozharness: 2016-08-08 05:16:52.609186Z] Finished read-buildbot-config step (success) 22:16:52 INFO - [mozharness: 2016-08-08 05:16:52.609275Z] Running download-and-extract step. 22:16:52 INFO - Running pre-action listener: _resource_record_pre_action 22:16:52 INFO - Running main action method: download_and_extract 22:16:52 INFO - mkdir: /builds/slave/test/build/tests 22:16: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')]} 22:16:52 INFO - trying https://queue.taskcluster.net/v1/task/Rnk5KSAQT8u2mUUaU9BysA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 22:16:52 INFO - Downloading https://queue.taskcluster.net/v1/task/Rnk5KSAQT8u2mUUaU9BysA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 22:16:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Rnk5KSAQT8u2mUUaU9BysA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 22:16:53 INFO - Downloaded 1361 bytes. 22:16:53 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 22:16:53 INFO - Using the following test package requirements: 22:16:53 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 22:16:53 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 22:16:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:16:53 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 22:16:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:16:53 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 22:16:53 INFO - u'jsshell-linux-x86_64.zip'], 22:16:53 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 22:16:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:16:53 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 22:16:53 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 22:16:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:16:53 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 22:16:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:16:53 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 22:16:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:16:53 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 22:16:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:16:53 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:16:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:16:53 INFO - trying https://queue.taskcluster.net/v1/task/Rnk5KSAQT8u2mUUaU9BysA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 22:16:53 INFO - Downloading https://queue.taskcluster.net/v1/task/Rnk5KSAQT8u2mUUaU9BysA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 22:16:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Rnk5KSAQT8u2mUUaU9BysA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:16:54 INFO - Downloaded 20257815 bytes. 22:16:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:16:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 22:16:55 INFO - Return code: 0 22:16:55 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 22:16: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')]} 22:16:55 INFO - trying https://queue.taskcluster.net/v1/task/Rnk5KSAQT8u2mUUaU9BysA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 22:16:55 INFO - Downloading https://queue.taskcluster.net/v1/task/Rnk5KSAQT8u2mUUaU9BysA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 22:16:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Rnk5KSAQT8u2mUUaU9BysA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:16:56 INFO - Downloaded 20257815 bytes. 22:16:56 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:16:56 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 22:16:57 INFO - Return code: 0 22:16:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:16:57 INFO - trying https://queue.taskcluster.net/v1/task/Rnk5KSAQT8u2mUUaU9BysA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 22:16:57 INFO - Downloading https://queue.taskcluster.net/v1/task/Rnk5KSAQT8u2mUUaU9BysA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 22:16:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Rnk5KSAQT8u2mUUaU9BysA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 22:16:58 INFO - Downloaded 14413723 bytes. 22:16:58 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:16:58 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 22:16:59 INFO - Return code: 0 22:16:59 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')]} 22:16:59 INFO - trying https://queue.taskcluster.net/v1/task/Rnk5KSAQT8u2mUUaU9BysA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 22:16:59 INFO - Downloading https://queue.taskcluster.net/v1/task/Rnk5KSAQT8u2mUUaU9BysA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 22:16:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Rnk5KSAQT8u2mUUaU9BysA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 22:17:01 INFO - Downloaded 56140008 bytes. 22:17:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Rnk5KSAQT8u2mUUaU9BysA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 22:17:01 INFO - mkdir: /builds/slave/test/properties 22:17:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:17:01 INFO - Writing to file /builds/slave/test/properties/build_url 22:17:01 INFO - Contents: 22:17:01 INFO - build_url:https://queue.taskcluster.net/v1/task/Rnk5KSAQT8u2mUUaU9BysA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 22:17:02 INFO - Running post-action listener: _resource_record_post_action 22:17:02 INFO - Running post-action listener: set_extra_try_arguments 22:17:02 INFO - [mozharness: 2016-08-08 05:17:02.082808Z] Finished download-and-extract step (success) 22:17:02 INFO - [mozharness: 2016-08-08 05:17:02.083040Z] Running populate-webroot step. 22:17:02 INFO - Running pre-action listener: _resource_record_pre_action 22:17:02 INFO - Running main action method: populate_webroot 22:17:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:17:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:17:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:17:02 INFO - '--tppagecycles', 22:17:02 INFO - '7'], 22:17:02 INFO - 'tests': ['tsvgm']}}, 22:17:02 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:17:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:17:02 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:17:02 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:17:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:17:02 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:17:02 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:17:02 INFO - 'talos_options': ['--disable-e10s'], 22:17:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:17:02 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:17:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:17:02 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:17:02 INFO - 'talos_options': ['--disable-e10s'], 22:17:02 INFO - 'tests': ['damp', 'tps']}, 22:17:02 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:17:02 INFO - 'tests': ['damp', 'tps']}, 22:17:02 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:17:02 INFO - 'tests': ['dromaeo_dom']}, 22:17:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:17:02 INFO - 'g4': {'talos_options': ['--disable-e10s'], 22:17:02 INFO - 'tests': ['basic_compositor_video']}, 22:17:02 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 22:17:02 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:17:02 INFO - 'tests': ['a11yr', 22:17:02 INFO - 'ts_paint', 22:17:02 INFO - 'tpaint', 22:17:02 INFO - 'sessionrestore', 22:17:02 INFO - 'sessionrestore_no_auto_restore', 22:17:02 INFO - 'tabpaint']}, 22:17:02 INFO - 'other-e10s': {'tests': ['a11yr', 22:17:02 INFO - 'ts_paint', 22:17:02 INFO - 'tpaint', 22:17:02 INFO - 'sessionrestore', 22:17:02 INFO - 'sessionrestore_no_auto_restore', 22:17:02 INFO - 'tabpaint']}, 22:17:02 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:17:02 INFO - 'ts_paint', 22:17:02 INFO - 'tpaint', 22:17:02 INFO - 'sessionrestore', 22:17:02 INFO - 'sessionrestore_no_auto_restore', 22:17:02 INFO - 'tabpaint']}, 22:17:02 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:17:02 INFO - 'ts_paint', 22:17:02 INFO - 'tpaint', 22:17:02 INFO - 'sessionrestore', 22:17:02 INFO - 'sessionrestore_no_auto_restore', 22:17:02 INFO - 'tabpaint']}, 22:17:02 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:17:02 INFO - 'tests': ['a11yr', 22:17:02 INFO - 'ts_paint', 22:17:02 INFO - 'tpaint', 22:17:02 INFO - 'sessionrestore', 22:17:02 INFO - 'sessionrestore_no_auto_restore', 22:17:02 INFO - 'tabpaint']}, 22:17:02 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:17:02 INFO - 'tests': ['a11yr', 22:17:02 INFO - 'ts_paint', 22:17:02 INFO - 'tpaint', 22:17:02 INFO - 'sessionrestore', 22:17:02 INFO - 'sessionrestore_no_auto_restore', 22:17:02 INFO - 'tabpaint']}, 22:17:02 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:17:02 INFO - 'tests': ['tsvgx', 22:17:02 INFO - 'tsvgr_opacity', 22:17:02 INFO - 'tart', 22:17:02 INFO - 'tscrollx', 22:17:02 INFO - 'cart']}, 22:17:02 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:17:02 INFO - 'tsvgr_opacity', 22:17:02 INFO - 'tart', 22:17:02 INFO - 'tscrollx', 22:17:02 INFO - 'cart']}, 22:17:02 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:17:02 INFO - 'talos_options': ['--disable-e10s'], 22:17:02 INFO - 'tests': ['tp5o']}, 22:17:02 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:17:02 INFO - 'tests': ['tp5o']}, 22:17:02 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:17:02 INFO - 'talos_options': ['--disable-e10s', 22:17:02 INFO - '--xperf_path', 22:17:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:17:02 INFO - 'tests': ['tp5n']}, 22:17:02 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:17:02 INFO - 'talos_options': ['--xperf_path', 22:17:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:17:02 INFO - 'tests': ['tp5n']}}, 22:17:02 INFO - 'talos.zip': {'path': '', 22:17:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:17:02 INFO - Running post-action listener: _resource_record_post_action 22:17:02 INFO - [mozharness: 2016-08-08 05:17:02.099328Z] Finished populate-webroot step (success) 22:17:02 INFO - [mozharness: 2016-08-08 05:17:02.099417Z] Running create-virtualenv step. 22:17:02 INFO - Running pre-action listener: _resource_record_pre_action 22:17:02 INFO - Running main action method: create_virtualenv 22:17:02 INFO - Creating virtualenv /builds/slave/test/build/venv 22:17:02 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 22:17:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:17:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:17:02 INFO - Using real prefix '/usr' 22:17:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:17:02 INFO - Installing distribute.............................................................................................................................................................................................done. 22:17:04 INFO - Installing pip.................done. 22:17:04 INFO - Return code: 0 22:17:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:17:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:17:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:17:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:17:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:17:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:17:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:17:04 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 0x18cf030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1afe400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b8d570>, '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 0x1b8e470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b8e900>, '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': 'db0483c52d987ecb441a263b000001ad-1470632956.631379-321176434', '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 22:17:04 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 22:17:04 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 22:17:04 INFO - Using env: {'DISPLAY': ':0', 22:17:04 INFO - 'HOME': '/home/cltbld', 22:17:04 INFO - 'LANG': 'en_US.UTF-8', 22:17:04 INFO - 'LANGUAGE': 'en_US:en', 22:17:04 INFO - 'LOGNAME': 'cltbld', 22:17:04 INFO - 'MAIL': '/var/mail/cltbld', 22:17:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:17:04 INFO - 'MOZ_NO_REMOTE': '1', 22:17:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:17:04 INFO - 'NO_EM_RESTART': '1', 22:17:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:17:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:17:04 INFO - 'PWD': '/builds/slave/test', 22:17:04 INFO - 'SHELL': '/bin/bash', 22:17:04 INFO - 'SHLVL': '1', 22:17:04 INFO - 'TERM': 'linux', 22:17:04 INFO - 'TMOUT': '86400', 22:17:04 INFO - 'USER': 'cltbld', 22:17:04 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1470632956.631379-321176434', 22:17:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:17:04 INFO - '_': '/tools/buildbot/bin/python'} 22:17:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:17:04 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 22:17:04 INFO - Cleaning up... 22:17:04 INFO - Return code: 0 22:17:04 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 22:17:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:17:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:17:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:17:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:17:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:17:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:17:04 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 0x18cf030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1afe400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b8d570>, '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 0x1b8e470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b8e900>, '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': 'db0483c52d987ecb441a263b000001ad-1470632956.631379-321176434', '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 22:17:04 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 22:17:04 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 22:17:04 INFO - Using env: {'DISPLAY': ':0', 22:17:04 INFO - 'HOME': '/home/cltbld', 22:17:04 INFO - 'LANG': 'en_US.UTF-8', 22:17:04 INFO - 'LANGUAGE': 'en_US:en', 22:17:04 INFO - 'LOGNAME': 'cltbld', 22:17:04 INFO - 'MAIL': '/var/mail/cltbld', 22:17:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:17:04 INFO - 'MOZ_NO_REMOTE': '1', 22:17:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:17:04 INFO - 'NO_EM_RESTART': '1', 22:17:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:17:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:17:04 INFO - 'PWD': '/builds/slave/test', 22:17:04 INFO - 'SHELL': '/bin/bash', 22:17:04 INFO - 'SHLVL': '1', 22:17:04 INFO - 'TERM': 'linux', 22:17:04 INFO - 'TMOUT': '86400', 22:17:04 INFO - 'USER': 'cltbld', 22:17:04 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1470632956.631379-321176434', 22:17:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:17:04 INFO - '_': '/tools/buildbot/bin/python'} 22:17:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:17:05 INFO - Downloading/unpacking psutil>=3.1.1 22:17:05 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 22:17:05 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 22:17:05 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 22:17:05 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 22:17:05 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 22:17:05 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 22:17:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:17:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:17:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:17:07 INFO - Installing collected packages: psutil 22:17:07 INFO - Running setup.py install for psutil 22:17:07 INFO - building 'psutil._psutil_linux' extension 22:17:07 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 22:17:07 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 22:17:07 INFO - building 'psutil._psutil_posix' extension 22:17:07 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 22:17:07 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 22:17:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:17:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:17:07 INFO - Successfully installed psutil 22:17:07 INFO - Cleaning up... 22:17:07 INFO - Return code: 0 22:17:07 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 22:17:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:17:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:17:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:17:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:17:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:17:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:17:07 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 0x18cf030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1afe400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b8d570>, '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 0x1b8e470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b8e900>, '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': 'db0483c52d987ecb441a263b000001ad-1470632956.631379-321176434', '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 22:17:07 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 22:17:07 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 22:17:07 INFO - Using env: {'DISPLAY': ':0', 22:17:07 INFO - 'HOME': '/home/cltbld', 22:17:07 INFO - 'LANG': 'en_US.UTF-8', 22:17:07 INFO - 'LANGUAGE': 'en_US:en', 22:17:07 INFO - 'LOGNAME': 'cltbld', 22:17:07 INFO - 'MAIL': '/var/mail/cltbld', 22:17:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:17:07 INFO - 'MOZ_NO_REMOTE': '1', 22:17:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:17:07 INFO - 'NO_EM_RESTART': '1', 22:17:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:17:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:17:07 INFO - 'PWD': '/builds/slave/test', 22:17:07 INFO - 'SHELL': '/bin/bash', 22:17:07 INFO - 'SHLVL': '1', 22:17:07 INFO - 'TERM': 'linux', 22:17:07 INFO - 'TMOUT': '86400', 22:17:07 INFO - 'USER': 'cltbld', 22:17:07 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1470632956.631379-321176434', 22:17:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:17:07 INFO - '_': '/tools/buildbot/bin/python'} 22:17:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:17:07 INFO - Downloading/unpacking mozsystemmonitor==0.3 22:17:07 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 22:17:07 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 22:17:07 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 22:17:07 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 22:17:07 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 22:17:07 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 22:17:09 INFO - Downloading mozsystemmonitor-0.3.tar.gz 22:17:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:17:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 22:17:09 INFO - Installing collected packages: mozsystemmonitor 22:17:09 INFO - Running setup.py install for mozsystemmonitor 22:17:09 INFO - Successfully installed mozsystemmonitor 22:17:09 INFO - Cleaning up... 22:17:09 INFO - Return code: 0 22:17:09 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 22:17:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:17:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:17:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:17:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:17:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:17:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:17:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x18cf030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1afe400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b8d570>, '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 0x1b8e470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b8e900>, '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': 'db0483c52d987ecb441a263b000001ad-1470632956.631379-321176434', '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 22:17:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 22:17:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 22:17:09 INFO - Using env: {'DISPLAY': ':0', 22:17:09 INFO - 'HOME': '/home/cltbld', 22:17:09 INFO - 'LANG': 'en_US.UTF-8', 22:17:09 INFO - 'LANGUAGE': 'en_US:en', 22:17:09 INFO - 'LOGNAME': 'cltbld', 22:17:09 INFO - 'MAIL': '/var/mail/cltbld', 22:17:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:17:09 INFO - 'MOZ_NO_REMOTE': '1', 22:17:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:17:09 INFO - 'NO_EM_RESTART': '1', 22:17:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:17:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:17:09 INFO - 'PWD': '/builds/slave/test', 22:17:09 INFO - 'SHELL': '/bin/bash', 22:17:09 INFO - 'SHLVL': '1', 22:17:09 INFO - 'TERM': 'linux', 22:17:09 INFO - 'TMOUT': '86400', 22:17:09 INFO - 'USER': 'cltbld', 22:17:09 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1470632956.631379-321176434', 22:17:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:17:09 INFO - '_': '/tools/buildbot/bin/python'} 22:17:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:17:10 INFO - Downloading/unpacking jsonschema==2.5.1 22:17:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:17:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:17:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:17:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:17:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:17:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:17:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:17:12 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 22:17:12 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 22:17:12 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 22:17:12 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 22:17:12 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 22:17:12 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 22:17:12 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 22:17:12 INFO - Downloading functools32-3.2.3-2.tar.gz 22:17:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:17:12 INFO - warning: no files found matching '*.txt' 22:17:12 INFO - no previously-included directories found matching 'build' 22:17:12 INFO - no previously-included directories found matching 'dist' 22:17:12 INFO - no previously-included directories found matching '.git*' 22:17:12 INFO - Installing collected packages: jsonschema, functools32 22:17:12 INFO - Running setup.py install for functools32 22:17:12 INFO - warning: no files found matching '*.txt' 22:17:12 INFO - no previously-included directories found matching 'build' 22:17:12 INFO - no previously-included directories found matching 'dist' 22:17:12 INFO - no previously-included directories found matching '.git*' 22:17:12 INFO - Successfully installed jsonschema functools32 22:17:12 INFO - Cleaning up... 22:17:12 INFO - Return code: 0 22:17:12 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 22:17:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:17:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:17:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:17:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:17:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:17:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:17:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x18cf030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1afe400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b8d570>, '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 0x1b8e470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b8e900>, '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': 'db0483c52d987ecb441a263b000001ad-1470632956.631379-321176434', '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 22:17:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 22:17:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 22:17:12 INFO - Using env: {'DISPLAY': ':0', 22:17:12 INFO - 'HOME': '/home/cltbld', 22:17:12 INFO - 'LANG': 'en_US.UTF-8', 22:17:12 INFO - 'LANGUAGE': 'en_US:en', 22:17:12 INFO - 'LOGNAME': 'cltbld', 22:17:12 INFO - 'MAIL': '/var/mail/cltbld', 22:17:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:17:12 INFO - 'MOZ_NO_REMOTE': '1', 22:17:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:17:12 INFO - 'NO_EM_RESTART': '1', 22:17:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:17:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:17:12 INFO - 'PWD': '/builds/slave/test', 22:17:12 INFO - 'SHELL': '/bin/bash', 22:17:12 INFO - 'SHLVL': '1', 22:17:12 INFO - 'TERM': 'linux', 22:17:12 INFO - 'TMOUT': '86400', 22:17:12 INFO - 'USER': 'cltbld', 22:17:12 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1470632956.631379-321176434', 22:17:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:17:12 INFO - '_': '/tools/buildbot/bin/python'} 22:17:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:17:12 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 22:17:12 INFO - Cleaning up... 22:17:12 INFO - Return code: 0 22:17:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:17:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:17:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:17:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:17:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:17:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:17:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:17:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x18cf030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1afe400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b8d570>, '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 0x1b8e470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b8e900>, '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': 'db0483c52d987ecb441a263b000001ad-1470632956.631379-321176434', '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 22:17:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 22:17:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 22:17:12 INFO - Using env: {'DISPLAY': ':0', 22:17:12 INFO - 'HOME': '/home/cltbld', 22:17:12 INFO - 'LANG': 'en_US.UTF-8', 22:17:12 INFO - 'LANGUAGE': 'en_US:en', 22:17:12 INFO - 'LOGNAME': 'cltbld', 22:17:12 INFO - 'MAIL': '/var/mail/cltbld', 22:17:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:17:12 INFO - 'MOZ_NO_REMOTE': '1', 22:17:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:17:12 INFO - 'NO_EM_RESTART': '1', 22:17:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:17:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:17:12 INFO - 'PWD': '/builds/slave/test', 22:17:12 INFO - 'SHELL': '/bin/bash', 22:17:12 INFO - 'SHLVL': '1', 22:17:12 INFO - 'TERM': 'linux', 22:17:12 INFO - 'TMOUT': '86400', 22:17:12 INFO - 'USER': 'cltbld', 22:17:12 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1470632956.631379-321176434', 22:17:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:17:12 INFO - '_': '/tools/buildbot/bin/python'} 22:17:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:17:12 INFO - Downloading/unpacking blobuploader==1.2.4 22:17:12 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 22:17:12 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 22:17:12 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 22:17:12 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 22:17:12 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 22:17:12 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 22:17:14 INFO - Downloading blobuploader-1.2.4.tar.gz 22:17:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:17:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:17:14 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 22:17:14 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 22:17:14 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 22:17:14 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 22:17:14 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 22:17:14 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 22:17:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:17:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:17:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:17:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:17:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:17:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:17:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:17:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:17:15 INFO - Downloading docopt-0.6.1.tar.gz 22:17:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:17:15 INFO - Installing collected packages: blobuploader, requests, docopt 22:17:15 INFO - Running setup.py install for blobuploader 22:17:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:17:15 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:17:15 INFO - Running setup.py install for requests 22:17:16 INFO - Running setup.py install for docopt 22:17:16 INFO - Successfully installed blobuploader requests docopt 22:17:16 INFO - Cleaning up... 22:17:16 INFO - Return code: 0 22:17:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:17:16 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')]} 22:17:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:17:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:17:16 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')]} 22:17:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:17:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:17:16 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 0x18cf030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1afe400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b8d570>, '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 0x1b8e470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b8e900>, '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': 'db0483c52d987ecb441a263b000001ad-1470632956.631379-321176434', '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 22:17:16 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 22:17:16 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 22:17:16 INFO - Using env: {'DISPLAY': ':0', 22:17:16 INFO - 'HOME': '/home/cltbld', 22:17:16 INFO - 'LANG': 'en_US.UTF-8', 22:17:16 INFO - 'LANGUAGE': 'en_US:en', 22:17:16 INFO - 'LOGNAME': 'cltbld', 22:17:16 INFO - 'MAIL': '/var/mail/cltbld', 22:17:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:17:16 INFO - 'MOZ_NO_REMOTE': '1', 22:17:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:17:16 INFO - 'NO_EM_RESTART': '1', 22:17:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:17:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:17:16 INFO - 'PWD': '/builds/slave/test', 22:17:16 INFO - 'SHELL': '/bin/bash', 22:17:16 INFO - 'SHLVL': '1', 22:17:16 INFO - 'TERM': 'linux', 22:17:16 INFO - 'TMOUT': '86400', 22:17:16 INFO - 'USER': 'cltbld', 22:17:16 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1470632956.631379-321176434', 22:17:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:17:16 INFO - '_': '/tools/buildbot/bin/python'} 22:17:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:17:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:17:16 INFO - Running setup.py (path:/tmp/pip-DoDjxJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:17:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:17:16 INFO - Running setup.py (path:/tmp/pip-lWMZ6D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:17:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:17:16 INFO - Running setup.py (path:/tmp/pip-6hqJmh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:17:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:17:16 INFO - Running setup.py (path:/tmp/pip-Sv5cpv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:17:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:17:16 INFO - Running setup.py (path:/tmp/pip-HIV_uD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:17:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:17:16 INFO - Running setup.py (path:/tmp/pip-lEilzm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:17:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:17:16 INFO - Running setup.py (path:/tmp/pip-8Jzees-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:17:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:17:16 INFO - Running setup.py (path:/tmp/pip-NqM1NQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:17:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:17:16 INFO - Running setup.py (path:/tmp/pip-EttM6P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:17:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:17:17 INFO - Running setup.py (path:/tmp/pip-zRs1Eo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:17:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:17:17 INFO - Running setup.py (path:/tmp/pip-WCunDZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:17:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:17:17 INFO - Running setup.py (path:/tmp/pip-MdYd0z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:17:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:17:17 INFO - Running setup.py (path:/tmp/pip-33LICO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:17:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:17:17 INFO - Running setup.py (path:/tmp/pip-e0yE7a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:17:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:17:17 INFO - Running setup.py (path:/tmp/pip-Ulwsni-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:17:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:17:17 INFO - Running setup.py (path:/tmp/pip-dP52XY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:17:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:17:17 INFO - Running setup.py (path:/tmp/pip-WXyuXC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:17:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:17:17 INFO - Running setup.py install for manifestparser 22:17:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:17:17 INFO - Running setup.py install for mozcrash 22:17:17 INFO - Running setup.py install for mozdebug 22:17:17 INFO - Running setup.py install for mozdevice 22:17:18 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:17:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:17:18 INFO - Running setup.py install for mozfile 22:17:18 INFO - Running setup.py install for mozhttpd 22:17:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:17:18 INFO - Running setup.py install for mozinfo 22:17:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:17:18 INFO - Running setup.py install for mozInstall 22:17:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:17:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:17:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:17:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:17:18 INFO - Running setup.py install for mozleak 22:17:18 INFO - Running setup.py install for mozlog 22:17:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:17:18 INFO - Running setup.py install for moznetwork 22:17:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:17:18 INFO - Running setup.py install for mozprocess 22:17:18 INFO - Running setup.py install for mozprofile 22:17:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:17:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:17:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:17:18 INFO - Running setup.py install for mozrunner 22:17:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:17:19 INFO - Running setup.py install for mozscreenshot 22:17:19 INFO - Running setup.py install for moztest 22:17:19 INFO - Running setup.py install for mozversion 22:17:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:17:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:17:19 INFO - Cleaning up... 22:17:19 INFO - Return code: 0 22:17:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:17:19 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')]} 22:17:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:17:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:17:19 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')]} 22:17:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:17:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:17:19 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 0x18cf030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1afe400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b8d570>, '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 0x1b8e470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b8e900>, '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': 'db0483c52d987ecb441a263b000001ad-1470632956.631379-321176434', '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 22:17:19 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 22:17:19 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 22:17:19 INFO - Using env: {'DISPLAY': ':0', 22:17:19 INFO - 'HOME': '/home/cltbld', 22:17:19 INFO - 'LANG': 'en_US.UTF-8', 22:17:19 INFO - 'LANGUAGE': 'en_US:en', 22:17:19 INFO - 'LOGNAME': 'cltbld', 22:17:19 INFO - 'MAIL': '/var/mail/cltbld', 22:17:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:17:19 INFO - 'MOZ_NO_REMOTE': '1', 22:17:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:17:19 INFO - 'NO_EM_RESTART': '1', 22:17:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:17:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:17:19 INFO - 'PWD': '/builds/slave/test', 22:17:19 INFO - 'SHELL': '/bin/bash', 22:17:19 INFO - 'SHLVL': '1', 22:17:19 INFO - 'TERM': 'linux', 22:17:19 INFO - 'TMOUT': '86400', 22:17:19 INFO - 'USER': 'cltbld', 22:17:19 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1470632956.631379-321176434', 22:17:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:17:19 INFO - '_': '/tools/buildbot/bin/python'} 22:17:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:17:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:17:19 INFO - Running setup.py (path:/tmp/pip-BAnP4i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:17:19 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)) 22:17:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:17:19 INFO - Running setup.py (path:/tmp/pip-zUcRnn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:17:19 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)) 22:17:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:17:19 INFO - Running setup.py (path:/tmp/pip-wxoGl3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:17:19 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)) 22:17:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:17:19 INFO - Running setup.py (path:/tmp/pip-n86T2a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:17:19 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)) 22:17:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:17:19 INFO - Running setup.py (path:/tmp/pip-sxZUi1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:17:20 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)) 22:17:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:17:20 INFO - Running setup.py (path:/tmp/pip-UulG9J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:17:20 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)) 22:17:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:17:20 INFO - Running setup.py (path:/tmp/pip-ciA4eq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:17:20 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)) 22:17:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:17:20 INFO - Running setup.py (path:/tmp/pip-OchSmJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:17:20 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)) 22:17:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:17:20 INFO - Running setup.py (path:/tmp/pip-DGmgac-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:17:20 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)) 22:17:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:17:20 INFO - Running setup.py (path:/tmp/pip-_omeOA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:17:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:17:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:17:20 INFO - Running setup.py (path:/tmp/pip-zhjWQI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:17:20 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)) 22:17:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:17:20 INFO - Running setup.py (path:/tmp/pip-aaU8Ws-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:17:20 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)) 22:17:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:17:20 INFO - Running setup.py (path:/tmp/pip-0y_gfG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:17:20 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)) 22:17:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:17:20 INFO - Running setup.py (path:/tmp/pip-ghnZgE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:17:20 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)) 22:17:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:17:20 INFO - Running setup.py (path:/tmp/pip-uRlnKa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:17:20 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)) 22:17:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:17:20 INFO - Running setup.py (path:/tmp/pip-nQmOHR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:17:20 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)) 22:17:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:17:20 INFO - Running setup.py (path:/tmp/pip-qxmK4b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:17:20 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)) 22:17:20 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)) 22:17:20 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)) 22:17:20 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)) 22:17:20 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)) 22:17:20 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)) 22:17:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:17:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:17:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:17:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:17:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:17:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:17:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:17:22 INFO - Downloading blessings-1.6.tar.gz 22:17:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:17:22 INFO - Installing collected packages: blessings 22:17:22 INFO - Running setup.py install for blessings 22:17:22 INFO - Successfully installed blessings 22:17:22 INFO - Cleaning up... 22:17:23 INFO - Return code: 0 22:17:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:17:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:17:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:17:23 INFO - Reading from file tmpfile_stdout 22:17:23 INFO - Current package versions: 22:17:23 INFO - argparse == 1.2.1 22:17:23 INFO - blessings == 1.6 22:17:23 INFO - blobuploader == 1.2.4 22:17:23 INFO - docopt == 0.6.1 22:17:23 INFO - functools32 == 3.2.3-2 22:17:23 INFO - jsonschema == 2.5.1 22:17:23 INFO - manifestparser == 1.1 22:17:23 INFO - mozInstall == 1.12 22:17:23 INFO - mozcrash == 0.17 22:17:23 INFO - mozdebug == 0.1 22:17:23 INFO - mozdevice == 0.48 22:17:23 INFO - mozfile == 1.2 22:17:23 INFO - mozhttpd == 0.7 22:17:23 INFO - mozinfo == 0.9 22:17:23 INFO - mozleak == 0.1 22:17:23 INFO - mozlog == 3.3 22:17:23 INFO - moznetwork == 0.27 22:17:23 INFO - mozprocess == 0.23 22:17:23 INFO - mozprofile == 0.28 22:17:23 INFO - mozrunner == 6.12 22:17:23 INFO - mozscreenshot == 0.1 22:17:23 INFO - mozsystemmonitor == 0.3 22:17:23 INFO - moztest == 0.7 22:17:23 INFO - mozversion == 1.4 22:17:23 INFO - psutil == 3.1.1 22:17:23 INFO - requests == 1.2.3 22:17:23 INFO - wsgiref == 0.1.2 22:17:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:17: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')]} 22:17:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:17:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:17: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')]} 22:17:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:17:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:17:23 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 0x18cf030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1afe400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b8d570>, '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 0x1b8e470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b8e900>, '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': 'db0483c52d987ecb441a263b000001ad-1470632956.631379-321176434', '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 22:17:23 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 22:17:23 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 22:17:23 INFO - Using env: {'DISPLAY': ':0', 22:17:23 INFO - 'HOME': '/home/cltbld', 22:17:23 INFO - 'LANG': 'en_US.UTF-8', 22:17:23 INFO - 'LANGUAGE': 'en_US:en', 22:17:23 INFO - 'LOGNAME': 'cltbld', 22:17:23 INFO - 'MAIL': '/var/mail/cltbld', 22:17:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:17:23 INFO - 'MOZ_NO_REMOTE': '1', 22:17:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:17:23 INFO - 'NO_EM_RESTART': '1', 22:17:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:17:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:17:23 INFO - 'PWD': '/builds/slave/test', 22:17:23 INFO - 'SHELL': '/bin/bash', 22:17:23 INFO - 'SHLVL': '1', 22:17:23 INFO - 'TERM': 'linux', 22:17:23 INFO - 'TMOUT': '86400', 22:17:23 INFO - 'USER': 'cltbld', 22:17:23 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1470632956.631379-321176434', 22:17:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:17:23 INFO - '_': '/tools/buildbot/bin/python'} 22:17:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:17:23 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)) 22:17:23 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)) 22:17:23 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)) 22:17:23 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)) 22:17:23 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)) 22:17:23 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)) 22:17:23 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)) 22:17:23 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)) 22:17:23 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)) 22:17:23 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)) 22:17:23 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)) 22:17:23 INFO - Cleaning up... 22:17:23 INFO - Return code: 0 22:17:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:17: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')]} 22:17:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:17:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:17: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')]} 22:17:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:17:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:17:23 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 0x18cf030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1afe400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b8d570>, '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 0x1b8e470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b8e900>, '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': 'db0483c52d987ecb441a263b000001ad-1470632956.631379-321176434', '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 22:17:23 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 22:17:23 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 22:17:23 INFO - Using env: {'DISPLAY': ':0', 22:17:23 INFO - 'HOME': '/home/cltbld', 22:17:23 INFO - 'LANG': 'en_US.UTF-8', 22:17:23 INFO - 'LANGUAGE': 'en_US:en', 22:17:23 INFO - 'LOGNAME': 'cltbld', 22:17:23 INFO - 'MAIL': '/var/mail/cltbld', 22:17:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:17:23 INFO - 'MOZ_NO_REMOTE': '1', 22:17:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:17:23 INFO - 'NO_EM_RESTART': '1', 22:17:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:17:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:17:23 INFO - 'PWD': '/builds/slave/test', 22:17:23 INFO - 'SHELL': '/bin/bash', 22:17:23 INFO - 'SHLVL': '1', 22:17:23 INFO - 'TERM': 'linux', 22:17:23 INFO - 'TMOUT': '86400', 22:17:23 INFO - 'USER': 'cltbld', 22:17:23 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1470632956.631379-321176434', 22:17:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:17:23 INFO - '_': '/tools/buildbot/bin/python'} 22:17:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:17:23 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 22:17:23 INFO - Cleaning up... 22:17:23 INFO - Return code: 0 22:17:23 INFO - Running post-action listener: _resource_record_post_action 22:17:23 INFO - Running post-action listener: _start_resource_monitoring 22:17:23 INFO - Starting resource monitoring. 22:17:23 INFO - [mozharness: 2016-08-08 05:17:23.671952Z] Finished create-virtualenv step (success) 22:17:23 INFO - [mozharness: 2016-08-08 05:17:23.672382Z] Running install step. 22:17:23 INFO - Running pre-action listener: _resource_record_pre_action 22:17:23 INFO - Running main action method: install 22:17:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:17:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:17:23 INFO - Reading from file tmpfile_stdout 22:17:23 INFO - Detecting whether we're running mozinstall >=1.0... 22:17:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:17:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:17:23 INFO - Reading from file tmpfile_stdout 22:17:23 INFO - Output received: 22:17:23 INFO - Usage: mozinstall [options] installer 22:17:23 INFO - Options: 22:17:23 INFO - -h, --help show this help message and exit 22:17:23 INFO - -d DEST, --destination=DEST 22:17:23 INFO - Directory to install application into. [default: 22:17:23 INFO - "/builds/slave/test"] 22:17:23 INFO - --app=APP Application being installed. [default: firefox] 22:17:23 INFO - mkdir: /builds/slave/test/build/application 22:17:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 22:17:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 22:17:40 INFO - Reading from file tmpfile_stdout 22:17:40 INFO - Output received: 22:17:40 INFO - /builds/slave/test/build/application/firefox/firefox 22:17:40 INFO - Running post-action listener: _resource_record_post_action 22:17:40 INFO - [mozharness: 2016-08-08 05:17:40.245800Z] Finished install step (success) 22:17:40 INFO - [mozharness: 2016-08-08 05:17:40.246048Z] Running run-tests step. 22:17:40 INFO - Running pre-action listener: _resource_record_pre_action 22:17:40 INFO - Running main action method: run_tests 22:17:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:17:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:17:40 INFO - Python 2.7.3 22:17:40 INFO - Return code: 0 22:17:40 INFO - grabbing minidump binary from tooltool 22:17:40 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')]} 22:17:40 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 0x1b8d570>, '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 0x1b8e470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b8e900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:17:40 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 22:17:40 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 22:17:40 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 22:17:40 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:17:40 INFO - Return code: 0 22:17:40 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:17:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:17:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:17:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:17:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:17:40 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Rnk5KSAQT8u2mUUaU9BysA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 22:17:40 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Rnk5KSAQT8u2mUUaU9BysA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-031 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 22:17:40 INFO - Using env: {'DISPLAY': ':0', 22:17:40 INFO - 'HOME': '/home/cltbld', 22:17:40 INFO - 'LANG': 'en_US.UTF-8', 22:17:40 INFO - 'LANGUAGE': 'en_US:en', 22:17:40 INFO - 'LOGNAME': 'cltbld', 22:17:40 INFO - 'MAIL': '/var/mail/cltbld', 22:17:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:17:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:17:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:17:40 INFO - 'MOZ_NO_REMOTE': '1', 22:17:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:17:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:17:40 INFO - 'NO_EM_RESTART': '1', 22:17:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:17:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:17:40 INFO - 'PWD': '/builds/slave/test', 22:17:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:17:40 INFO - 'SHELL': '/bin/bash', 22:17:40 INFO - 'SHLVL': '1', 22:17:40 INFO - 'TERM': 'linux', 22:17:40 INFO - 'TMOUT': '86400', 22:17:40 INFO - 'USER': 'cltbld', 22:17:40 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1470632956.631379-321176434', 22:17:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:17:40 INFO - '_': '/tools/buildbot/bin/python'} 22:17:40 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Rnk5KSAQT8u2mUUaU9BysA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 22:17:40 INFO - mozversion application_buildid: 20160807205552 22:17:40 INFO - mozversion application_changeset: 513d42e7a166bab34785c7f727704bf8d32c1a36 22:17:40 INFO - mozversion application_display_name: Nightly 22:17:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:17:40 INFO - mozversion application_name: Firefox 22:17:40 INFO - mozversion application_remotingname: firefox 22:17:40 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 22:17:40 INFO - mozversion application_vendor: Mozilla 22:17:40 INFO - mozversion application_version: 51.0a1 22:17:40 INFO - mozversion platform_buildid: 20160807205552 22:17:40 INFO - mozversion platform_changeset: 513d42e7a166bab34785c7f727704bf8d32c1a36 22:17:40 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 22:17:40 INFO - mozversion platform_version: 51.0a1 22:17:40 INFO - using testdate: 1470633460 22:17:40 INFO - actual date: 1470633460 22:17:40 INFO - starting webserver on 'localhost:58328' 22:17:40 INFO - SUITE-START | Running 2 tests 22:17:40 INFO - TEST-START | dromaeo_css 22:17:40 INFO - operating with platform_type : linux_ 22:17:40 INFO - Initialising browser for dromaeo_css test... 22:17:40 INFO - TEST-INFO | started process 10457 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpodVbSC/profile http://localhost:58328/getInfo.html) 22:17:45 INFO - PROCESS | 10457 | __metrics Screen width/height:1600/1200 22:17:45 INFO - PROCESS | 10457 | colorDepth:24 22:17:45 INFO - PROCESS | 10457 | Browser inner width/height: 1024/697 22:17:45 INFO - PROCESS | 10457 | __metrics 22:17:45 ERROR - PROCESS | 10457 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 22:17:46 INFO - TEST-INFO | 10457: exit 0 22:17:46 INFO - Browser initialized. 22:17:46 INFO - Running cycle 1/1 for dromaeo_css test... 22:17:46 INFO - TEST-INFO | started process 10574 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpodVbSC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:17:58 INFO - PROCESS | 10574 | RSS: Main: 164716544 22:17:58 INFO - PROCESS | 10574 | 22:18:48 INFO - PROCESS | 10574 | 1470633528210 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] 22:20:59 INFO - PROCESS | 10574 | Cycle 1(1): loaded http://localhost:58328/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58328/tests/dromaeo/cssquery-ext.html) 22:21:01 INFO - PROCESS | 10574 | RSS: Main: 166780928 22:21:01 INFO - PROCESS | 10574 | 22:24:04 INFO - PROCESS | 10574 | Cycle 1(1): loaded http://localhost:58328/tests/dromaeo/cssquery-ext.html (next: http://localhost:58328/tests/dromaeo/cssquery-jquery.html) 22:24:04 INFO - PROCESS | 10574 | RSS: Main: 166862848 22:24:04 INFO - PROCESS | 10574 | 22:27:06 INFO - PROCESS | 10574 | Cycle 1(1): loaded http://localhost:58328/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58328/tests/dromaeo/cssquery-mootools.html) 22:27:07 INFO - PROCESS | 10574 | RSS: Main: 170135552 22:27:07 INFO - PROCESS | 10574 | 22:30:09 INFO - PROCESS | 10574 | Cycle 1(1): loaded http://localhost:58328/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58328/tests/dromaeo/cssquery-prototype.html) 22:30:09 INFO - PROCESS | 10574 | RSS: Main: 164593664 22:30:09 INFO - PROCESS | 10574 | 22:33:12 INFO - PROCESS | 10574 | Cycle 1(1): loaded http://localhost:58328/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58328/tests/dromaeo/cssquery-yui.html) 22:33:13 INFO - PROCESS | 10574 | RSS: Main: 167071744 22:33:13 INFO - PROCESS | 10574 | 22:36:15 INFO - PROCESS | 10574 | Cycle 1(1): loaded http://localhost:58328/tests/dromaeo/cssquery-yui.html (next: http://localhost:58328/tests/dromaeo/cssquery-dojo.html) 22:36:16 INFO - PROCESS | 10574 | RSS: Main: 169861120 22:36:16 INFO - PROCESS | 10574 | 22:36:16 INFO - PROCESS | 10574 | __start_tp_report 22:36:16 INFO - PROCESS | 10574 | _x_x_mozilla_page_load 22:36:16 INFO - PROCESS | 10574 | _x_x_mozilla_page_load_details 22:36:16 INFO - PROCESS | 10574 | |i|pagename|runs| 22:36:16 INFO - PROCESS | 10574 | |0;dojo.html;2667.0665267156496;2669.5728683410657;2693.0574298995352;2700.4869074875774;2706.6616672915884;4708.246680531116;4776;4806.255030470278;4806.711597304165;4836.250381190912;4736.455307639622;4754.144254034272;4776.498467660897;4790.736509491977;4884.365032545764;4337.93493097603;4386.9561304387025;4441.71128876622;4583.266677331628;4585.403897493321;4464.241079016559;4491.1691337102575;4512.819487220508;4527.524609915944;4584.77076146193;4274.187904298174;4368.49762277339;4416.624586910117;4438.3564383164585;4447.421835161441;4343.500497442803;4357.542458041891;4400.7579583122915;4423.51341352451;4435.334699795024;4375.223987576138;4401.053773438694;4402.669799765031;4406.898275431142;4457.6433885289425;4783.593394561466;4821.4696383397795;4822;4825.059113472874;4877.975610121962;5203.947960520384;5211.1922651989;5219.634625576211;5223.425423203445;5257.13257312543;5058.064258112261;5143.099957507421;5189.714565698885;5232.92150617741;5246.658967167122;4809.1583972804965;4851.272309153655;4866.416030076413;4898.21628539432;4909.509049095133;5295;5304.814331498379;5340.06548853949;5343.412224655285;5377.354717433855;4898.828541001048;5026.597872170218;5098.260752190911;5110.310108135429;5116.386033675908;5147.202183661539;5185;5194.636375453758;5238.214267859776;5241.42344342122;5117.078925793393;5125.718085505258;5133.589312854962;5134.255532947702;5176.611754118381;4955.182394904872;5036.420811606712;5110.872228194251;5114.590832733373;5116.360454943132;4316.633086187647;4338.609525142752;4341.15347507233;4375.781210939504;4380.145871555016;3773.9998900291444;3809.2381523694817;3815.7138214634015;3834.405667121601;3844.519435070616;4321.567843215653;4471.530489298641;4479.260921947907;4500.077484115748;4536.138133754642;5182.766775495112;5197.1684530475695;5235.65968212065;5292.603054770908;5295.285136506599;4500.8649740507835;4501.707389019703;4511.413516242933;4512.300593407961;4555.954440455553;4502.572255635775;4592.265237561974;4676.579107880307;4690.484046754854;4725.362076119749;4811.27830825379;4845.8061677533915;4846.636502262415;4885.438174609965;4896.2655601660035;5173.715445650525;5184.377874655065;5191.636585439134;5202.609804264771;5237.397699264633;4624.44506659203;4655.3249778782565;4780.426348838162;4837.4920633332995;4906.484819093944;4920.065187614342;4951.678140920829;4953.2570114483115;4956.157453232887;5043.596512278936;5100.821471248489;5196.090684130338;5196.220566914993;5261;5289.074411977966;4998.87502812418;5014.57376123019;5020.263956143984;5034.521720436553;5069.594432445322;4847.830325938717;4926.8768280793265;5019.548240658358;5030.5221004006025;5043.823466178666;4865.781039853145;4909.239067944474;4946.8763280918265;4947.431045429822;4948.505149485023;4977.676451030671;5035.92446113316;5040.193569028937;5069.112905241642;5128.435872054146;4904.975475122745;4940.431850337257;4946.406431228275;4955.108080545537;4993.5755460784785 22:36:16 INFO - PROCESS | 10574 | |1;ext.html;553.9806106786262;556.6103727390824;559.8432438917105;569.8945695046416;586.6392168816179;33967.32065358691;37885.05287367817;37913.62086379135;37918.62081379185;37925.24149517008;39012;39489.40765888514;39675.603243967555;39710.60289397105;39727.80136099315;7539.208383119776;7691.9230807691765;7698.230176982313;7698.692052317901;7715.421343399239;7633;7686.385089192879;7715.652795624211;7740;7745.767626971172;7668.309852113309;7688.461807673465;7716.074071111474;7716.151223365426;7759.301662850342;7677.155512893577;7689.769306920802;7720.7683769487;7735.381169506426;7744.922550774533;7652.196519365442;7718.575478348688;7737.148913619498;7742.419318551131;7746.728864489773;36585.63414365849;36635.63364366349;36655.450168247495;36801.44797828035;36925.63074369249;2994.910152695401;3172.682731726832;3206.374756922401;3428.2800611871535;3789.8673546425744;28002.859985699943;28289.02965188646;28760.280992975135;28963.85518072417;29654.258643533867;3089.2585779413002;3095.767817413703;3097.04265121118;3107.0074953684407;3175.5871736674317;257377;258033;258640;259235;259375;31300.68699313023;53466;53698.46301536934;53702.46297537053;53731;31805.52291715626;33300.16749581231;33318.50022249668;33334.16664583356;33342.16644583905;12480.81278780819;12543.56097536582;12602.369881505889;12604.81092783609;12647.557335493213;10257.794844103077;10326.535305911102;10343.37939723619;10351.120154786777;10351.948240258902;7630.427717921067;7732.729354472566;7789.941297794732;7851.939988101647;7889.921100788919;3052.0996306089755;3067.2485241115623;3111.2999575095423;3122.469180239365;3145.4809956357403;820.9548474833941;864.9308055355557;872.9519876406731;905.6060613633091;926.2913870888775;26767.464650707265;27398.17805465839;27892.02377916763;28203.294917627223;28319.57520637192;982.0670363155032;995.8406654935176;1001.5593139018808;1015.664830605913;1039.6309310194922;14709.852901471062;14746.11523308605;14833.629159271104;14901.180435075958;14936.477223297132;389407;390101;393222;393709;393741;50004.249936250984;50198.24702629464;50459.74770126126;50498.24252636213;50701.23948140781;1133.7505748735266;1173.0908545877014;1177.6761390617648;1194.8386967759416;1196.4974710621386;26153.869230653723;27425;27446.569178852642;27741.861290693418;27753.44493110167;43076.13847722965;43731.78134109309;43754.12491750211;43763.78118109389;43921.121577568905;337729;338145;338803;339560;341125;24866;25623.359416014748;26039.349016274744;26095.60856587115;26218.60672089882;38481.4227786589;40783;41180.1763964713;41745;41804.372934406616;35570.288594228485;35978.10054748652;36373.818130909174;36897.81551092335;37057;35964.084826886676;36038.27923441569;36595.451068233466;36875.81562092173;37791.433128503646;34275.14312142217;34766;34929;35219.295614088085;35630.821845890605;31046.3293086058;32733;33289.334213315116;33295.66704332926;33448;25149.74850251547;25584.360390990376;25693.871530642227;25794.742052579233;26069.869650651624 22:36:16 INFO - PROCESS | 10574 | |2;jquery.html;348.71579662575;358.9084783380238;363.56553918067914;371.6766413220499;387.407266881671;15695.52913412598;16869.915650421746;17539.03535305559;17703.73444398335;17724.20241089151;14792.482263120794;15070.849291507082;15457.84542154581;15536.689266214697;15587.830912681538;5003.524665156813;5230.372355317368;5238.26664267001;5239.13554263546;5240.68555886648;3705.277470893177;5091.134507133796;5672.319321681383;5939.703014849262;5948.375420580842;5979.46184843364;5987.55093367997;5993.610415323012;5993.640381577097;5999;5899.439553242435;5899.5870289079785;5940.97029514854;5945.613535120204;5945.851353716149;5020.849374518771;5135.717535535544;5138.177891537373;5139.871503212412;5263.736813159365;20125.7924524529;20546.589068218702;20555.794442055536;20683.793162068338;21097;1966.0759443061738;1973.7434133562545;2112.8837913914726;2273.3407311879537;2496.4133428644254;13117.47530098795;13387.330633468386;13691.657708557266;13709.45162193511;14148.575542733735;1721.8424608536752;1728.8271172882737;1746.3014794082342;1763.700170970938;1767.920443580029;68002.65998670025;69161;69909;70124;70710.64644676744;8516.80619767587;8781.692640757543;9002.279817614575;9020.233280171127;9336.95331523338;11912.225705329125;11914.761704765857;11925.10561707858;11955.880441195477;11977.401129943468;6815.420689241371;6862.2976607789515;6930.896036559456;7086.078809754699;7101.218865924744;6607.405333520006;6676.0987266718375;6870.690818913161;6886.070380498669;6890.689918953659;5527.640703354269;5663.801766938137;5697.202391665171;5744.281964754406;5972.193753843176;1588.793456850625;1589.2371661602494;1649.1342045426247;1654.8014238291482;1728.8357606027407;860.5912191709014;921.9216366608779;922.7324076018014;923.5936188077225;951.2390087929629;16672.166391680366;16832.158392080346;17126.571835704206;17507.91246043787;18040.639187216184;814.7515007922641;869.7695110795644;879.349281531662;890.8619164029586;922.5571725571763;9563.713088607354;9648.131668149901;9777;9921.305508614472;10089.899101009043;393925;400915;401982;405523;407234;86200.13799862047;86289.13710862811;86318.56840715757;86995;87331;890.3055616619048;913.488446469979;931.1573026411108;932.883389576303;935.3592788939599;15133.394664213309;15237.3905043797;15633.452829150925;15886.443974460839;16045.358185672443;38726;40065.799671001456;40302;41087.794561027;41771.7911410441;55784.442155577926;57410.42589574051;57602.13596796135;58009.4199058004;58242;7833.334166595903;7958.363330933627;8128.512289262663;8189.181081891763;8214.13751556078;10186.949065254626;11842.644720658394;12169.148159629096;12263.080268979684;12672;10596.258261921592;10602.522886470282;10717.839232411365;10781.245312828027;10940.617078402218;11001.559937602406;11065.557377704801;11091.944540277247;11120.833187502356;11220.99011089006;10040.849387259052;10714.89285107139;10719.088877445505;10852.186086043735;11098.833517497405;7533.962330188533;7901.249381308767;7909.762707118795;7958.0848202457455;8048.154943730824;9042.502662353634;10089.192864570963;10124.69625911224;10296.9743274756;10585.523651435858 22:36:16 INFO - PROCESS | 10574 | |3;mootools.html;1386.1821525300074;1424.6652036771357;1527.4959263443066;1690.9577260568492;1730.498155534894;6429.292777794451;7210.206877243506;7426.480146389755;7796.103448103469;7814.5701986390795;7534.3972482201425;7791.649375778089;7802.063752349712;7809.843803123934;7813.570253636048;2140.967885481723;2190.233418303589;2190.7042549255807;2191.5726433345426;2191.6822060801173;2135.6476181430044;2154.2675490333286;2194.5062360968736;2203.8787866667326;2205.911763529465;2166.1010680567547;2171.3160354488286;2173.5544213436206;2176.880271585062;2176.923807666732;2108.399106254718;2116.333354993172;2118.5868755592664;2119.9364019079453;2121.0561300221407;2071.2439959414855;2110.567333696604;2116.343933380657;2118.406846083099;2118.66101423773;7604.0875094988405;7682.385409167253;7701.807454813675;7706.653200605986;7709.074911010659;4341.066670665822;4427;4459;4464.754438505881;4494.865154045384;2732.0847516082135;2792.854929478904;2839.375337425763;2854.158023383107;2859.79981401302;888.5379602606673;948.8386974214332;966.9758256043585;968.404431274768;970.1995853420956;10153.238507111997;10196.89803101967;10209;10278.897211027943;10279.79440411195;3865.4974853268895;4008.8596899108393;4135.462389889355;4143.109231515239;4148.2947898857265;8791.07693692166;8847.557622118868;8875.822483550422;8888.466691998501;8889;4368.825246990084;4405.889852753643;4410.42664453619;4432.822687092545;4434.955650443519;3256.7231785298513;3853.9421908671393;3935.0949281665376;3952.486176796998;3971.3645816669773;3456.165943926007;3555.253396786652;3559.7864128152396;3611.963880361163;3656.2687462507074;1165.8134698448207;1175.2360965372404;1192.7375977284983;1193.4271549656214;1194.9163558550817;819.7376839411451;825.6674893426095;839.4574745908012;853.0531110467376;857.4512312120248;5120.436751957282;5191.39066889258;5242.423333433319;5293.206019097166;5347.598930080182;869.165601023025;906.1120102299651;926.9258459323238;931.59475628102;947.462932372985;3526.6297038811067;3571.08937221007;3571.6785489305566;3572.8392222350058;3602.4776407420777;9355.204807591432;9521.333506654468;9564.426134431957;9623.374480658735;9639.036096390304;9597.088276613711;9599.568019439143;9600.75998100053;9607.56765945534;9621.855672164924;7381.151167615685;7386.187519372865;7414.851702966019;7464;7494.5128566643;5077.8730531737;5179.093658609653;5203.895922081461;5275.920861187008;5437.3747019091725;8689.435186712843;8756.956215218883;8810.867836982323;8851.513166775632;8919.375643704878;8727.170918762708;9030.90969090327;9138.63445462174;9148.588313526041;9152.633894644407;5596.076647353141;6375.74497020114;6413;6569.310222426577;6603.273639899511;7217.6391180441815;7291.708331666674;7471.514351567131;7478.925210748041;7501.774946751606;6689.2307384651385;6854.0404343390965;6863.725450982104;6876.415504682158;7033.402160816388;6637.966810165918;6678.866422671616;6686.398224159849;6771.3905748482875;6873.347032031949;6246.094316324198;6258.9374106260175;6265.498760099273;6287.2140982377205;6287.71705273273;4404.185225733249;4502.932456013228;4520.683552151318;4625.629949603956;4643.953560464487;4401.911961760683;4459.085887393141;4479.865604031885;4495.550444955609;4618.30725391194 22:36:16 INFO - PROCESS | 10574 | |4;prototype.html;276.1412008653089;283.58879624544403;284.2141478811088;290.99418011639756;292.7643247186016;5056.5701915337195;5112;5113.948860511398;5119.84966314148;5138.332016837806;5002.12462819007;5020.246962955558;5020.297158397827;5082.186850103984;5102.158143906251;3711.109333759892;3787.1289603391238;3838.136419305662;3888.045085734848;3903.8048097595147;3870.283997460465;3874.3994680824517;3874.845006199763;3880.3985382265796;3887.5334959804864;3864.3237433449176;3872.5159355080614;3883.2815929053218;3885.0675837798867;3890.9221815563674;3802.258559580883;3881.2237552489614;3896.162325100117;3900.6294402031904;3909.5894931032117;3375.375555522236;3376.7467439941856;3378.9863041087574;3389.3221355728706;3421.26442814796;4846.164993478819;4868.92883565615;4904.485029071931;4920.532549407801;4926.8768280793265;4346.891327716832;4446.822127114911;4474.619657329131;4485.573870482299;4492.96661767792;5251.264822924793;5265.394479634814;5274.92087618686;5306.681599104066;5317.893642127175;3735.234276973214;3742.791752865795;3747.1194269346684;3747.6252374762307;3748.962510374916;5391.460853914656;5498.900219956025;5531.3362396512675;5555.16686489889;5559.416261292547;3702.8148592570265;3770.849166033383;3772.5472943246436;3804.98335881983;3814.8474061037805;3865.8453661853773;3871.5547712012917;3872.3997780344093;3872.6320999505;3874.651281384689;4421.204183247047;4432.844850430284;4436.179306828247;4443.311286750494;4456.286994080931;4997.350344455271;5203.7918483261;5232.816851410183;5273.182656688219;5303.867403314948;1313.1923866821835;1332.733453309342;1334.1128149780288;1336.2717319061135;1336.3986206207246;813.8616435206029;843.5191940593803;849.6856163219525;853.5177624642057;853.9667002926404;4356;4462.263726485094;4620.491745907947;4633.606143477842;4641.259527677121;5433.483819037185;5452.972735136299;5456.208849716769;5478.45215478457;5484.862878427992;4612.630989520831;4631.907361852812;4633.443986721615;4660.764897302218;4672.836450724276;2756.3798145417522;2860.971390286112;2883.9711602883704;2909.6072030276064;2930.868110935013;5082.898342033139;5091.872703182376;5120.206368012964;5121.718305493159;5152.149895267239;5316;5576.888462230732;5627.859303517363;5633.436656334416;5643.351014633287;5131.538161565477;5137.51193636604;5137.974310128426;5150.270356710875;5174.223866420067;5447.291852059366;5457.808976685797;5499.615026948075;5501.834944951658;5552.69460179694;5190.480951904779;5367.651102678314;5376.327959005124;5417.729113544386;5419.945800541944;5093.2105523643895;5094.617903657315;5128.666636668605;5167.095758242368;5180.7409629517615;3829.234153169433;3852.6725228355904;3858.131920317906;3858.80705964695;3858.9228215436096;5322.760475778677;5452.863678408072;5454.536364408911;5473;5569.610127291051;5258.713304184885;5266.236395722675;5313.973430132824;5326.627136100436;5331.600129990189;5260.842174734764;5275.204141804849;5278.788848446019;5321.2705870591435;5323.973380133075;5022.648414610942;5209.453007434165;5218.295530103387;5223.164293712987;5237.947620523746;5090.287359769709;5168.0697474453455;5286.12778891494;5332.280142180756;5344.732763361739;5207.901298727251;5225.3990791057995;5228.790848366023;5243.790248390174;5245.980297585381 22:36:16 INFO - PROCESS | 10574 | |5;yui.html;589.6888968442197;646.1503123392738;649.3701109923372;659.6602749583963;663.1577896071989;12656.367181640915;13391.866081339183;13622.795658065124;13638.38627261772;14325.713485730279;13579.592612221624;13768;13795.103318284304;13801.861981380183;13829.723405531884;633.3255083336255;757.7082823113113;777.8094366880123;780.9492382995115;781.6560713286136;718.0557566799641;742.283696233135;748.5059860492076;751.5415596486166;751.597895126105;810.1291112054536;812.5246730662569;813.6460639621754;814.1370147643487;815.355868863597;805.6495424490365;807.4791759315239;812.4962523235573;812.7642983534768;813.6379311206515;588.2352941176496;592.8517870532366;592.9673867937262;594.1058706646469;594.2898236607256;12819.807702884464;12821.358932053454;12834.679133021657;12850.485980560767;12907.612771616867;13187.670308242275;13230.27233502157;13850.030497865153;13909.095908765898;14166.858331416657;10324.638637647646;10362.27464077515;10447.68656940293;10549.20880933933;10590.25868189227;3277.131560136566;3316.2704205074847;3323.5845519310087;3350.1289664687356;3372.291818718072;64145.358546414405;64927;65680.3431965679;65904;66703.66648166777;10231.693049208536;10563.577456901792;10626.309289896131;10662.306950048222;10794;20172.495687607927;20186.596268074558;20221.696674549894;20227;20236.89881550583;6624.436922861514;6645.302243264484;6734.427573656294;6750.561213521106;6764;3320.634730179727;3409.607895092096;3472.4964880092243;3563.803990780532;3670.7797532148156;2787.6515435570554;2894.0015694585336;2895.8841646333913;2909.970900291012;2910.4179164167253;474.7673639916485;485.1873112536487;493.37341576198025;498.78053656391074;499.3209235439799;481.91566475866586;492.68221996811855;494.5894907226993;506.2431664661281;520.8099043848968;6997.230304666483;7101.147862256562;7316.670749816271;7401.222871598512;7502.6623801929045;406.8230319810892;427.4315160836081;435.7320248047428;497.1101727907078;517.0976645753185;3435.280258369786;3675.5038069860225;3846.538415390171;3879.8448062077764;3946.151577410813;94975;98108.50945745225;98965.50517247367;99427.50286248667;102799;89897.55051224702;90417.54791226002;91325;92361;97927.51036244773;81910.59044704738;82696;83926;85184;85222.14777852266;7344.375728062961;7530.096388433423;7662.272084151997;7676.501027433199;7770.611469426393;32333;43634.781826090664;43912.780436097615;44089;45059;59303;64317.56824317531;67013.66493167503;67398.3260167392;69540.30459695541;9127.269818414643;9167.954160229156;9588.232941364813;9660.37207581505;9680.273979451711;10805.18961077938;10886.455677216265;10987.945060274647;11080.61217857371;11392.25950313227;9694.224462043161;9767.951160244438;9807.607695692092;10334.483275836328;10627.628033018807;9608.567614457226;9781.804363912539;9829.606815727291;9849.606015759577;9961.252906031932;9616.855747163658;9849.01877090754;9860.408375497493;9943.25425593069;10345.810231823436;8485.448445851;8541.188587084218;8551.230389264996;8759.12408759119;8839.116088391109;8167.83664326722;8707.608157632794;8765.34259930495;8805.42764720291;8885.733427997171 22:36:16 INFO - PROCESS | 10574 | __end_tp_report 22:36:16 INFO - PROCESS | 10574 | __start_cc_report 22:36:16 INFO - PROCESS | 10574 | _x_x_mozilla_cycle_collect,357 22:36:16 INFO - PROCESS | 10574 | __end_cc_report 22:36:16 INFO - PROCESS | 10574 | __startTimestamp1470634576114__endTimestamp 22:36:16 INFO - PROCESS | 10574 | 22:36:16 INFO - PROCESS | 10574 | ------- Summary: start ------- 22:36:16 INFO - PROCESS | 10574 | Number of tests: 6 22:36:16 INFO - PROCESS | 10574 | 22:36:16 INFO - PROCESS | 10574 | [#0] dojo.html Cycles:165 Average:4765.10 Median:4885.44 stddev:504.04 (10.3%) stddev-sans-first:477.96 22:36:16 INFO - PROCESS | 10574 | Values: 2667.1 2669.6 2693.1 2700.5 2706.7 4708.2 4776.0 4806.3 4806.7 4836.3 4736.5 4754.1 4776.5 4790.7 4884.4 4337.9 4387.0 4441.7 4583.3 4585.4 4464.2 4491.2 4512.8 4527.5 4584.8 4274.2 4368.5 4416.6 4438.4 4447.4 4343.5 4357.5 4400.8 4423.5 4435.3 4375.2 4401.1 4402.7 4406.9 4457.6 4783.6 4821.5 4822.0 4825.1 4878.0 5203.9 5211.2 5219.6 5223.4 5257.1 5058.1 5143.1 5189.7 5232.9 5246.7 4809.2 4851.3 4866.4 4898.2 4909.5 5295.0 5304.8 5340.1 5343.4 5377.4 4898.8 5026.6 5098.3 5110.3 5116.4 5147.2 5185.0 5194.6 5238.2 5241.4 5117.1 5125.7 5133.6 5134.3 5176.6 4955.2 5036.4 5110.9 5114.6 5116.4 4316.6 4338.6 4341.2 4375.8 4380.1 3774.0 3809.2 3815.7 3834.4 3844.5 4321.6 4471.5 4479.3 4500.1 4536.1 5182.8 5197.2 5235.7 5292.6 5295.3 4500.9 4501.7 4511.4 4512.3 4556.0 4502.6 4592.3 4676.6 4690.5 4725.4 4811.3 4845.8 4846.6 4885.4 4896.3 5173.7 5184.4 5191.6 5202.6 5237.4 4624.4 4655.3 4780.4 4837.5 4906.5 4920.1 4951.7 4953.3 4956.2 5043.6 5100.8 5196.1 5196.2 5261.0 5289.1 4998.9 5014.6 5020.3 5034.5 5069.6 4847.8 4926.9 5019.5 5030.5 5043.8 4865.8 4909.2 4946.9 4947.4 4948.5 4977.7 5035.9 5040.2 5069.1 5128.4 4905.0 4940.4 4946.4 4955.1 4993.6 22:36:16 INFO - PROCESS | 10574 | 22:36:16 INFO - PROCESS | 10574 | [#1] ext.html Cycles:180 Average:47031.71 Median:35971.09 stddev:88337.77 (245.6%) stddev-sans-first:88516.65 22:36:16 INFO - PROCESS | 10574 | Values: 554.0 556.6 559.8 569.9 586.6 33967.3 37885.1 37913.6 37918.6 37925.2 39012.0 39489.4 39675.6 39710.6 39727.8 7539.2 7691.9 7698.2 7698.7 7715.4 7633.0 7686.4 7715.7 7740.0 7745.8 7668.3 7688.5 7716.1 7716.2 7759.3 7677.2 7689.8 7720.8 7735.4 7744.9 7652.2 7718.6 7737.1 7742.4 7746.7 36585.6 36635.6 36655.5 36801.4 36925.6 2994.9 3172.7 3206.4 3428.3 3789.9 28002.9 28289.0 28760.3 28963.9 29654.3 3089.3 3095.8 3097.0 3107.0 3175.6 257377.0 258033.0 258640.0 259235.0 259375.0 31300.7 53466.0 53698.5 53702.5 53731.0 31805.5 33300.2 33318.5 33334.2 33342.2 12480.8 12543.6 12602.4 12604.8 12647.6 10257.8 10326.5 10343.4 10351.1 10351.9 7630.4 7732.7 7789.9 7851.9 7889.9 3052.1 3067.2 3111.3 3122.5 3145.5 821.0 864.9 873.0 905.6 926.3 26767.5 27398.2 27892.0 28203.3 28319.6 982.1 995.8 1001.6 1015.7 1039.6 14709.9 14746.1 14833.6 14901.2 14936.5 389407.0 390101.0 393222.0 393709.0 393741.0 50004.2 50198.2 50459.7 50498.2 50701.2 1133.8 1173.1 1177.7 1194.8 1196.5 26153.9 27425.0 27446.6 27741.9 27753.4 43076.1 43731.8 43754.1 43763.8 43921.1 337729.0 338145.0 338803.0 339560.0 341125.0 24866.0 25623.4 26039.3 26095.6 26218.6 38481.4 40783.0 41180.2 41745.0 41804.4 35570.3 35978.1 36373.8 36897.8 37057.0 35964.1 36038.3 36595.5 36875.8 37791.4 34275.1 34766.0 34929.0 35219.3 35630.8 31046.3 32733.0 33289.3 33295.7 33448.0 25149.7 25584.4 25693.9 25794.7 26069.9 22:36:16 INFO - PROCESS | 10574 | 22:36:16 INFO - PROCESS | 10574 | [#2] jquery.html Cycles:180 Average:25331.73 Median:23387.66 stddev:66589.40 (284.7%) stddev-sans-first:66749.78 22:36:16 INFO - PROCESS | 10574 | Values: 348.7 358.9 363.6 371.7 387.4 15695.5 16869.9 17539.0 17703.7 17724.2 14792.5 15070.8 15457.8 15536.7 15587.8 5003.5 5230.4 5238.3 5239.1 5240.7 3705.3 5091.1 5672.3 5939.7 5948.4 5979.5 5987.6 5993.6 5993.6 5999.0 5899.4 5899.6 5941.0 5945.6 5945.9 5020.8 5135.7 5138.2 5139.9 5263.7 20125.8 20546.6 20555.8 20683.8 21097.0 1966.1 1973.7 2112.9 2273.3 2496.4 13117.5 13387.3 13691.7 13709.5 14148.6 1721.8 1728.8 1746.3 1763.7 1767.9 68002.7 69161.0 69909.0 70124.0 70710.6 8516.8 8781.7 9002.3 9020.2 9337.0 11912.2 11914.8 11925.1 11955.9 11977.4 6815.4 6862.3 6930.9 7086.1 7101.2 6607.4 6676.1 6870.7 6886.1 6890.7 5527.6 5663.8 5697.2 5744.3 5972.2 1588.8 1589.2 1649.1 1654.8 1728.8 860.6 921.9 922.7 923.6 951.2 16672.2 16832.2 17126.6 17507.9 18040.6 814.8 869.8 879.3 890.9 922.6 9563.7 9648.1 9777.0 9921.3 10089.9 393925.0 400915.0 401982.0 405523.0 407234.0 86200.1 86289.1 86318.6 86995.0 87331.0 890.3 913.5 931.2 932.9 935.4 15133.4 15237.4 15633.5 15886.4 16045.4 38726.0 40065.8 40302.0 41087.8 41771.8 55784.4 57410.4 57602.1 58009.4 58242.0 7833.3 7958.4 8128.5 8189.2 8214.1 10186.9 11842.6 12169.1 12263.1 12672.0 10596.3 10602.5 10717.8 10781.2 10940.6 11001.6 11065.6 11091.9 11120.8 11221.0 10040.8 10714.9 10719.1 10852.2 11098.8 7534.0 7901.2 7909.8 7958.1 8048.2 9042.5 10089.2 10124.7 10297.0 10585.5 22:36:16 INFO - PROCESS | 10574 | 22:36:16 INFO - PROCESS | 10574 | [#3] mootools.html Cycles:180 Average:5060.82 Median:5259.17 stddev:2830.46 (53.8%) stddev-sans-first:2824.93 22:36:16 INFO - PROCESS | 10574 | Values: 1386.2 1424.7 1527.5 1691.0 1730.5 6429.3 7210.2 7426.5 7796.1 7814.6 7534.4 7791.6 7802.1 7809.8 7813.6 2141.0 2190.2 2190.7 2191.6 2191.7 2135.6 2154.3 2194.5 2203.9 2205.9 2166.1 2171.3 2173.6 2176.9 2176.9 2108.4 2116.3 2118.6 2119.9 2121.1 2071.2 2110.6 2116.3 2118.4 2118.7 7604.1 7682.4 7701.8 7706.7 7709.1 4341.1 4427.0 4459.0 4464.8 4494.9 2732.1 2792.9 2839.4 2854.2 2859.8 888.5 948.8 967.0 968.4 970.2 10153.2 10196.9 10209.0 10278.9 10279.8 3865.5 4008.9 4135.5 4143.1 4148.3 8791.1 8847.6 8875.8 8888.5 8889.0 4368.8 4405.9 4410.4 4432.8 4435.0 3256.7 3853.9 3935.1 3952.5 3971.4 3456.2 3555.3 3559.8 3612.0 3656.3 1165.8 1175.2 1192.7 1193.4 1194.9 819.7 825.7 839.5 853.1 857.5 5120.4 5191.4 5242.4 5293.2 5347.6 869.2 906.1 926.9 931.6 947.5 3526.6 3571.1 3571.7 3572.8 3602.5 9355.2 9521.3 9564.4 9623.4 9639.0 9597.1 9599.6 9600.8 9607.6 9621.9 7381.2 7386.2 7414.9 7464.0 7494.5 5077.9 5179.1 5203.9 5275.9 5437.4 8689.4 8757.0 8810.9 8851.5 8919.4 8727.2 9030.9 9138.6 9148.6 9152.6 5596.1 6375.7 6413.0 6569.3 6603.3 7217.6 7291.7 7471.5 7478.9 7501.8 6689.2 6854.0 6863.7 6876.4 7033.4 6638.0 6678.9 6686.4 6771.4 6873.3 6246.1 6258.9 6265.5 6287.2 6287.7 4404.2 4502.9 4520.7 4625.6 4644.0 4401.9 4459.1 4479.9 4495.6 4618.3 22:36:16 INFO - PROCESS | 10574 | 22:36:16 INFO - PROCESS | 10574 | [#4] prototype.html Cycles:180 Average:4374.76 Median:5069.38 stddev:1292.44 (25.5%) stddev-sans-first:1258.93 22:36:16 INFO - PROCESS | 10574 | Values: 276.1 283.6 284.2 291.0 292.8 5056.6 5112.0 5113.9 5119.8 5138.3 5002.1 5020.2 5020.3 5082.2 5102.2 3711.1 3787.1 3838.1 3888.0 3903.8 3870.3 3874.4 3874.8 3880.4 3887.5 3864.3 3872.5 3883.3 3885.1 3890.9 3802.3 3881.2 3896.2 3900.6 3909.6 3375.4 3376.7 3379.0 3389.3 3421.3 4846.2 4868.9 4904.5 4920.5 4926.9 4346.9 4446.8 4474.6 4485.6 4493.0 5251.3 5265.4 5274.9 5306.7 5317.9 3735.2 3742.8 3747.1 3747.6 3749.0 5391.5 5498.9 5531.3 5555.2 5559.4 3702.8 3770.8 3772.5 3805.0 3814.8 3865.8 3871.6 3872.4 3872.6 3874.7 4421.2 4432.8 4436.2 4443.3 4456.3 4997.4 5203.8 5232.8 5273.2 5303.9 1313.2 1332.7 1334.1 1336.3 1336.4 813.9 843.5 849.7 853.5 854.0 4356.0 4462.3 4620.5 4633.6 4641.3 5433.5 5453.0 5456.2 5478.5 5484.9 4612.6 4631.9 4633.4 4660.8 4672.8 2756.4 2861.0 2884.0 2909.6 2930.9 5082.9 5091.9 5120.2 5121.7 5152.1 5316.0 5576.9 5627.9 5633.4 5643.4 5131.5 5137.5 5138.0 5150.3 5174.2 5447.3 5457.8 5499.6 5501.8 5552.7 5190.5 5367.7 5376.3 5417.7 5419.9 5093.2 5094.6 5128.7 5167.1 5180.7 3829.2 3852.7 3858.1 3858.8 3858.9 5322.8 5452.9 5454.5 5473.0 5569.6 5258.7 5266.2 5314.0 5326.6 5331.6 5260.8 5275.2 5278.8 5321.3 5324.0 5022.6 5209.5 5218.3 5223.2 5237.9 5090.3 5168.1 5286.1 5332.3 5344.7 5207.9 5225.4 5228.8 5243.8 5246.0 22:36:16 INFO - PROCESS | 10574 | 22:36:16 INFO - PROCESS | 10574 | [#5] yui.html Cycles:180 Average:18089.41 Median:613.81 stddev:27022.68 (4402.5%) stddev-sans-first:27066.53 22:36:16 INFO - PROCESS | 10574 | Values: 589.7 646.2 649.4 659.7 663.2 12656.4 13391.9 13622.8 13638.4 14325.7 13579.6 13768.0 13795.1 13801.9 13829.7 633.3 757.7 777.8 780.9 781.7 718.1 742.3 748.5 751.5 751.6 810.1 812.5 813.6 814.1 815.4 805.6 807.5 812.5 812.8 813.6 588.2 592.9 593.0 594.1 594.3 12819.8 12821.4 12834.7 12850.5 12907.6 13187.7 13230.3 13850.0 13909.1 14166.9 10324.6 10362.3 10447.7 10549.2 10590.3 3277.1 3316.3 3323.6 3350.1 3372.3 64145.4 64927.0 65680.3 65904.0 66703.7 10231.7 10563.6 10626.3 10662.3 10794.0 20172.5 20186.6 20221.7 20227.0 20236.9 6624.4 6645.3 6734.4 6750.6 6764.0 3320.6 3409.6 3472.5 3563.8 3670.8 2787.7 2894.0 2895.9 2910.0 2910.4 474.8 485.2 493.4 498.8 499.3 481.9 492.7 494.6 506.2 520.8 6997.2 7101.1 7316.7 7401.2 7502.7 406.8 427.4 435.7 497.1 517.1 3435.3 3675.5 3846.5 3879.8 3946.2 94975.0 98108.5 98965.5 99427.5 102799.0 89897.6 90417.5 91325.0 92361.0 97927.5 81910.6 82696.0 83926.0 85184.0 85222.1 7344.4 7530.1 7662.3 7676.5 7770.6 32333.0 43634.8 43912.8 44089.0 45059.0 59303.0 64317.6 67013.7 67398.3 69540.3 9127.3 9168.0 9588.2 9660.4 9680.3 10805.2 10886.5 10987.9 11080.6 11392.3 9694.2 9768.0 9807.6 10334.5 10627.6 9608.6 9781.8 9829.6 9849.6 9961.3 9616.9 9849.0 9860.4 9943.3 10345.8 8485.4 8541.2 8551.2 8759.1 8839.1 8167.8 8707.6 8765.3 8805.4 8885.7 22:36:16 INFO - PROCESS | 10574 | -------- Summary: end -------- 22:36:16 INFO - PROCESS | 10574 | 22:36:16 INFO - TEST-INFO | 10574: exit 0 22:36:16 INFO - TEST-OK | dromaeo_css | took 1116386ms 22:36:16 INFO - TEST-START | kraken 22:36:16 INFO - operating with platform_type : linux_ 22:36:16 INFO - Initialising browser for kraken test... 22:36:16 INFO - TEST-INFO | started process 10820 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsWut8d/profile http://localhost:58328/getInfo.html) 22:36:21 INFO - PROCESS | 10820 | __metrics Screen width/height:1600/1200 22:36:21 INFO - PROCESS | 10820 | colorDepth:24 22:36:21 INFO - PROCESS | 10820 | Browser inner width/height: 1024/697 22:36:21 INFO - PROCESS | 10820 | __metrics 22:36:21 ERROR - PROCESS | 10820 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 22:36:22 INFO - TEST-INFO | 10820: exit 0 22:36:22 INFO - Browser initialized. 22:36:22 INFO - Running cycle 1/1 for kraken test... 22:36:22 INFO - TEST-INFO | started process 10937 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsWut8d/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:36:34 INFO - PROCESS | 10937 | RSS: Main: 165257216 22:36:34 INFO - PROCESS | 10937 | 22:36:37 INFO - PROCESS | 10937 | Cycle 1(1): loaded http://localhost:58328/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58328/tests/kraken/driver.html?testName=audio-beat-detection) 22:36:38 INFO - PROCESS | 10937 | RSS: Main: 169783296 22:36:38 INFO - PROCESS | 10937 | 22:36:41 INFO - PROCESS | 10937 | Cycle 1(1): loaded http://localhost:58328/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58328/tests/kraken/driver.html?testName=audio-dft) 22:36:41 INFO - PROCESS | 10937 | RSS: Main: 168701952 22:36:41 INFO - PROCESS | 10937 | 22:36:44 INFO - PROCESS | 10937 | Cycle 1(1): loaded http://localhost:58328/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58328/tests/kraken/driver.html?testName=audio-fft) 22:36:45 INFO - PROCESS | 10937 | RSS: Main: 165343232 22:36:45 INFO - PROCESS | 10937 | 22:36:47 INFO - PROCESS | 10937 | Cycle 1(1): loaded http://localhost:58328/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58328/tests/kraken/driver.html?testName=audio-oscillator) 22:36:48 INFO - PROCESS | 10937 | RSS: Main: 166031360 22:36:48 INFO - PROCESS | 10937 | 22:36:50 INFO - PROCESS | 10937 | Cycle 1(1): loaded http://localhost:58328/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58328/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:36:51 INFO - PROCESS | 10937 | RSS: Main: 166309888 22:36:51 INFO - PROCESS | 10937 | 22:36:54 INFO - PROCESS | 10937 | Cycle 1(1): loaded http://localhost:58328/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58328/tests/kraken/driver.html?testName=imaging-darkroom) 22:36:55 INFO - PROCESS | 10937 | RSS: Main: 166739968 22:36:55 INFO - PROCESS | 10937 | 22:36:58 INFO - PROCESS | 10937 | Cycle 1(1): loaded http://localhost:58328/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58328/tests/kraken/driver.html?testName=imaging-desaturate) 22:36:59 INFO - PROCESS | 10937 | RSS: Main: 163373056 22:36:59 INFO - PROCESS | 10937 | 22:37:02 INFO - PROCESS | 10937 | Cycle 1(1): loaded http://localhost:58328/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58328/tests/kraken/driver.html?testName=json-parse-financial) 22:37:02 INFO - PROCESS | 10937 | RSS: Main: 165453824 22:37:02 INFO - PROCESS | 10937 | 22:37:04 INFO - PROCESS | 10937 | Cycle 1(1): loaded http://localhost:58328/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58328/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:37:05 INFO - PROCESS | 10937 | RSS: Main: 165429248 22:37:05 INFO - PROCESS | 10937 | 22:37:07 INFO - PROCESS | 10937 | Cycle 1(1): loaded http://localhost:58328/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58328/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:37:07 INFO - PROCESS | 10937 | RSS: Main: 165998592 22:37:07 INFO - PROCESS | 10937 | 22:37:09 INFO - PROCESS | 10937 | Cycle 1(1): loaded http://localhost:58328/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58328/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:37:10 INFO - PROCESS | 10937 | RSS: Main: 166694912 22:37:10 INFO - PROCESS | 10937 | 22:37:13 INFO - PROCESS | 10937 | Cycle 1(1): loaded http://localhost:58328/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58328/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:37:14 INFO - PROCESS | 10937 | RSS: Main: 166936576 22:37:14 INFO - PROCESS | 10937 | 22:37:17 INFO - PROCESS | 10937 | Cycle 1(1): loaded http://localhost:58328/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58328/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:37:17 INFO - PROCESS | 10937 | RSS: Main: 167149568 22:37:17 INFO - PROCESS | 10937 | 22:37:19 INFO - PROCESS | 10937 | Cycle 1(1): loaded http://localhost:58328/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58328/tests/kraken/driver.html?testName=ai-astar) 22:37:19 INFO - PROCESS | 10937 | RSS: Main: 167862272 22:37:19 INFO - PROCESS | 10937 | 22:37:19 INFO - PROCESS | 10937 | __start_tp_report 22:37:19 INFO - PROCESS | 10937 | _x_x_mozilla_page_load 22:37:19 INFO - PROCESS | 10937 | _x_x_mozilla_page_load_details 22:37:19 INFO - PROCESS | 10937 | |i|pagename|runs| 22:37:19 INFO - PROCESS | 10937 | |0;ai-astar;105;115;109;113;114;115;116;115;116;115 22:37:19 INFO - PROCESS | 10937 | |1;audio-beat-detection;147;125;150;187;124;161;155;124;184;122 22:37:19 INFO - PROCESS | 10937 | |2;audio-dft;164;165;165;178;167;168;165;165;162;163 22:37:19 INFO - PROCESS | 10937 | |3;audio-fft;76;77;77;166;77;77;75;77;148;77 22:37:19 INFO - PROCESS | 10937 | |4;audio-oscillator;85;86;145;85;85;85;145;86;85;128 22:37:19 INFO - PROCESS | 10937 | |5;imaging-gaussian-blur;117;118;118;118;118;118;119;119;118;118 22:37:19 INFO - PROCESS | 10937 | |6;imaging-darkroom;148;148;148;148;147;148;148;148;147;147 22:37:19 INFO - PROCESS | 10937 | |7;imaging-desaturate;96;96;96;96;96;97;100;96;96;95 22:37:19 INFO - PROCESS | 10937 | |8;json-parse-financial;65;65;67;67;68;64;66;66;66;65 22:37:19 INFO - PROCESS | 10937 | |9;json-stringify-tinderbox;66;66;70;65;66;65;66;65;65;65 22:37:19 INFO - PROCESS | 10937 | |10;stanford-crypto-aes;81;85;80;85;81;80;78;80;89;80 22:37:19 INFO - PROCESS | 10937 | |11;stanford-crypto-ccm;142;147;140;141;142;146;149;142;144;147 22:37:19 INFO - PROCESS | 10937 | |12;stanford-crypto-pbkdf2;173;169;167;165;170;179;170;167;171;170 22:37:19 INFO - PROCESS | 10937 | |13;stanford-crypto-sha256-iterative;70;68;71;71;70;69;68;72;68;67 22:37:19 INFO - PROCESS | 10937 | __end_tp_report 22:37:19 INFO - PROCESS | 10937 | __start_cc_report 22:37:19 INFO - PROCESS | 10937 | _x_x_mozilla_cycle_collect,934 22:37:19 INFO - PROCESS | 10937 | __end_cc_report 22:37:19 INFO - PROCESS | 10937 | __startTimestamp1470634639795__endTimestamp 22:37:19 INFO - PROCESS | 10937 | 22:37:19 INFO - PROCESS | 10937 | ------- Summary: start ------- 22:37:19 INFO - PROCESS | 10937 | Number of tests: 14 22:37:19 INFO - PROCESS | 10937 | 22:37:19 INFO - PROCESS | 10937 | [#0] ai-astar Cycles:10 Average:113.30 Median:115.00 stddev:3.56 (3.1%) stddev-sans-first:2.17 22:37:19 INFO - PROCESS | 10937 | Values: 105.0 115.0 109.0 113.0 114.0 115.0 116.0 115.0 116.0 115.0 22:37:19 INFO - PROCESS | 10937 | 22:37:19 INFO - PROCESS | 10937 | [#1] audio-beat-detection Cycles:10 Average:147.90 Median:152.50 stddev:24.49 (16.1%) stddev-sans-first:25.97 22:37:19 INFO - PROCESS | 10937 | Values: 147.0 125.0 150.0 187.0 124.0 161.0 155.0 124.0 184.0 122.0 22:37:19 INFO - PROCESS | 10937 | 22:37:19 INFO - PROCESS | 10937 | [#2] audio-dft Cycles:10 Average:166.20 Median:165.00 stddev:4.49 (2.7%) stddev-sans-first:4.69 22:37:19 INFO - PROCESS | 10937 | Values: 164.0 165.0 165.0 178.0 167.0 168.0 165.0 165.0 162.0 163.0 22:37:19 INFO - PROCESS | 10937 | 22:37:19 INFO - PROCESS | 10937 | [#3] audio-fft Cycles:10 Average:92.70 Median:77.00 stddev:34.16 (44.4%) stddev-sans-first:35.69 22:37:19 INFO - PROCESS | 10937 | Values: 76.0 77.0 77.0 166.0 77.0 77.0 75.0 77.0 148.0 77.0 22:37:19 INFO - PROCESS | 10937 | 22:37:19 INFO - PROCESS | 10937 | [#4] audio-oscillator Cycles:10 Average:101.50 Median:85.00 stddev:26.52 (31.2%) stddev-sans-first:27.45 22:37:19 INFO - PROCESS | 10937 | Values: 85.0 86.0 145.0 85.0 85.0 85.0 145.0 86.0 85.0 128.0 22:37:19 INFO - PROCESS | 10937 | 22:37:19 INFO - PROCESS | 10937 | [#5] imaging-gaussian-blur Cycles:10 Average:118.10 Median:118.00 stddev:0.57 (0.5%) stddev-sans-first:0.44 22:37:19 INFO - PROCESS | 10937 | Values: 117.0 118.0 118.0 118.0 118.0 118.0 119.0 119.0 118.0 118.0 22:37:19 INFO - PROCESS | 10937 | 22:37:19 INFO - PROCESS | 10937 | [#6] imaging-darkroom Cycles:10 Average:147.70 Median:148.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 22:37:19 INFO - PROCESS | 10937 | Values: 148.0 148.0 148.0 148.0 147.0 148.0 148.0 148.0 147.0 147.0 22:37:19 INFO - PROCESS | 10937 | 22:37:19 INFO - PROCESS | 10937 | [#7] imaging-desaturate Cycles:10 Average:96.40 Median:96.00 stddev:1.35 (1.4%) stddev-sans-first:1.42 22:37:19 INFO - PROCESS | 10937 | Values: 96.0 96.0 96.0 96.0 96.0 97.0 100.0 96.0 96.0 95.0 22:37:19 INFO - PROCESS | 10937 | 22:37:19 INFO - PROCESS | 10937 | [#8] json-parse-financial Cycles:10 Average:65.90 Median:66.00 stddev:1.20 (1.8%) stddev-sans-first:1.22 22:37:19 INFO - PROCESS | 10937 | Values: 65.0 65.0 67.0 67.0 68.0 64.0 66.0 66.0 66.0 65.0 22:37:19 INFO - PROCESS | 10937 | 22:37:19 INFO - PROCESS | 10937 | [#9] json-stringify-tinderbox Cycles:10 Average:65.90 Median:66.00 stddev:1.52 (2.3%) stddev-sans-first:1.62 22:37:19 INFO - PROCESS | 10937 | Values: 66.0 66.0 70.0 65.0 66.0 65.0 66.0 65.0 65.0 65.0 22:37:19 INFO - PROCESS | 10937 | 22:37:19 INFO - PROCESS | 10937 | [#10] stanford-crypto-aes Cycles:10 Average:81.90 Median:81.00 stddev:3.35 (4.1%) stddev-sans-first:3.54 22:37:19 INFO - PROCESS | 10937 | Values: 81.0 85.0 80.0 85.0 81.0 80.0 78.0 80.0 89.0 80.0 22:37:19 INFO - PROCESS | 10937 | 22:37:19 INFO - PROCESS | 10937 | [#11] stanford-crypto-ccm Cycles:10 Average:144.00 Median:145.00 stddev:3.06 (2.1%) stddev-sans-first:3.15 22:37:19 INFO - PROCESS | 10937 | Values: 142.0 147.0 140.0 141.0 142.0 146.0 149.0 142.0 144.0 147.0 22:37:19 INFO - PROCESS | 10937 | 22:37:19 INFO - PROCESS | 10937 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.10 Median:170.00 stddev:3.87 (2.3%) stddev-sans-first:3.96 22:37:19 INFO - PROCESS | 10937 | Values: 173.0 169.0 167.0 165.0 170.0 179.0 170.0 167.0 171.0 170.0 22:37:19 INFO - PROCESS | 10937 | 22:37:19 INFO - PROCESS | 10937 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.40 Median:70.00 stddev:1.65 (2.4%) stddev-sans-first:1.73 22:37:19 INFO - PROCESS | 10937 | Values: 70.0 68.0 71.0 71.0 70.0 69.0 68.0 72.0 68.0 67.0 22:37:19 INFO - PROCESS | 10937 | -------- Summary: end -------- 22:37:19 INFO - PROCESS | 10937 | 22:37:20 INFO - TEST-INFO | 10937: exit 0 22:37:20 INFO - TEST-OK | kraken | took 64062ms 22:37:20 INFO - SUITE-END | took 1180s 22:37:21 INFO - Completed test suite (00:19:40) 22:37:21 INFO - javascript benchmark 22:37:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6365.761300811501, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2667.0665267156496, 2669.5728683410657, 2693.0574298995352, 2700.4869074875774, 2706.6616672915884, 4708.246680531116, 4776.0, 4806.255030470278, 4806.711597304165, 4836.250381190912, 4736.455307639622, 4754.144254034272, 4776.498467660897, 4790.736509491977, 4884.365032545764, 4337.93493097603, 4386.9561304387025, 4441.71128876622, 4583.266677331628, 4585.403897493321, 4464.241079016559, 4491.1691337102575, 4512.819487220508, 4527.524609915944, 4584.77076146193, 4274.187904298174, 4368.49762277339, 4416.624586910117, 4438.3564383164585, 4447.421835161441, 4343.500497442803, 4357.542458041891, 4400.7579583122915, 4423.51341352451, 4435.334699795024, 4375.223987576138, 4401.053773438694, 4402.669799765031, 4406.898275431142, 4457.6433885289425, 4783.593394561466, 4821.4696383397795, 4822.0, 4825.059113472874, 4877.975610121962, 5203.947960520384, 5211.1922651989, 5219.634625576211, 5223.425423203445, 5257.13257312543, 5058.064258112261, 5143.099957507421, 5189.714565698885, 5232.92150617741, 5246.658967167122, 4809.1583972804965, 4851.272309153655, 4866.416030076413, 4898.21628539432, 4909.509049095133, 5295.0, 5304.814331498379, 5340.06548853949, 5343.412224655285, 5377.354717433855, 4898.828541001048, 5026.597872170218, 5098.260752190911, 5110.310108135429, 5116.386033675908, 5147.202183661539, 5185.0, 5194.636375453758, 5238.214267859776, 5241.42344342122, 5117.078925793393, 5125.718085505258, 5133.589312854962, 5134.255532947702, 5176.611754118381, 4955.182394904872, 5036.420811606712, 5110.872228194251, 5114.590832733373, 5116.360454943132, 4316.633086187647, 4338.609525142752, 4341.15347507233, 4375.781210939504, 4380.145871555016, 3773.9998900291444, 3809.2381523694817, 3815.7138214634015, 3834.405667121601, 3844.519435070616, 4321.567843215653, 4471.530489298641, 4479.260921947907, 4500.077484115748, 4536.138133754642, 5182.766775495112, 5197.1684530475695, 5235.65968212065, 5292.603054770908, 5295.285136506599, 4500.8649740507835, 4501.707389019703, 4511.413516242933, 4512.300593407961, 4555.954440455553, 4502.572255635775, 4592.265237561974, 4676.579107880307, 4690.484046754854, 4725.362076119749, 4811.27830825379, 4845.8061677533915, 4846.636502262415, 4885.438174609965, 4896.2655601660035, 5173.715445650525, 5184.377874655065, 5191.636585439134, 5202.609804264771, 5237.397699264633, 4624.44506659203, 4655.3249778782565, 4780.426348838162, 4837.4920633332995, 4906.484819093944, 4920.065187614342, 4951.678140920829, 4953.2570114483115, 4956.157453232887, 5043.596512278936, 5100.821471248489, 5196.090684130338, 5196.220566914993, 5261.0, 5289.074411977966, 4998.87502812418, 5014.57376123019, 5020.263956143984, 5034.521720436553, 5069.594432445322, 4847.830325938717, 4926.8768280793265, 5019.548240658358, 5030.5221004006025, 5043.823466178666, 4865.781039853145, 4909.239067944474, 4946.8763280918265, 4947.431045429822, 4948.505149485023, 4977.676451030671, 5035.92446113316, 5040.193569028937, 5069.112905241642, 5128.435872054146, 4904.975475122745, 4940.431850337257, 4946.406431228275, 4955.108080545537, 4993.5755460784785], "value": 4732.75760945834, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [553.9806106786262, 556.6103727390824, 559.8432438917105, 569.8945695046416, 586.6392168816179, 33967.32065358691, 37885.05287367817, 37913.62086379135, 37918.62081379185, 37925.24149517008, 39012.0, 39489.40765888514, 39675.603243967555, 39710.60289397105, 39727.80136099315, 7539.208383119776, 7691.9230807691765, 7698.230176982313, 7698.692052317901, 7715.421343399239, 7633.0, 7686.385089192879, 7715.652795624211, 7740.0, 7745.767626971172, 7668.309852113309, 7688.461807673465, 7716.074071111474, 7716.151223365426, 7759.301662850342, 7677.155512893577, 7689.769306920802, 7720.7683769487, 7735.381169506426, 7744.922550774533, 7652.196519365442, 7718.575478348688, 7737.148913619498, 7742.419318551131, 7746.728864489773, 36585.63414365849, 36635.63364366349, 36655.450168247495, 36801.44797828035, 36925.63074369249, 2994.910152695401, 3172.682731726832, 3206.374756922401, 3428.2800611871535, 3789.8673546425744, 28002.859985699943, 28289.02965188646, 28760.280992975135, 28963.85518072417, 29654.258643533867, 3089.2585779413002, 3095.767817413703, 3097.04265121118, 3107.0074953684407, 3175.5871736674317, 257377.0, 258033.0, 258640.0, 259235.0, 259375.0, 31300.68699313023, 53466.0, 53698.46301536934, 53702.46297537053, 53731.0, 31805.52291715626, 33300.16749581231, 33318.50022249668, 33334.16664583356, 33342.16644583905, 12480.81278780819, 12543.56097536582, 12602.369881505889, 12604.81092783609, 12647.557335493213, 10257.794844103077, 10326.535305911102, 10343.37939723619, 10351.120154786777, 10351.948240258902, 7630.427717921067, 7732.729354472566, 7789.941297794732, 7851.939988101647, 7889.921100788919, 3052.0996306089755, 3067.2485241115623, 3111.2999575095423, 3122.469180239365, 3145.4809956357403, 820.9548474833941, 864.9308055355557, 872.9519876406731, 905.6060613633091, 926.2913870888775, 26767.464650707265, 27398.17805465839, 27892.02377916763, 28203.294917627223, 28319.57520637192, 982.0670363155032, 995.8406654935176, 1001.5593139018808, 1015.664830605913, 1039.6309310194922, 14709.852901471062, 14746.11523308605, 14833.629159271104, 14901.180435075958, 14936.477223297132, 389407.0, 390101.0, 393222.0, 393709.0, 393741.0, 50004.249936250984, 50198.24702629464, 50459.74770126126, 50498.24252636213, 50701.23948140781, 1133.7505748735266, 1173.0908545877014, 1177.6761390617648, 1194.8386967759416, 1196.4974710621386, 26153.869230653723, 27425.0, 27446.569178852642, 27741.861290693418, 27753.44493110167, 43076.13847722965, 43731.78134109309, 43754.12491750211, 43763.78118109389, 43921.121577568905, 337729.0, 338145.0, 338803.0, 339560.0, 341125.0, 24866.0, 25623.359416014748, 26039.349016274744, 26095.60856587115, 26218.60672089882, 38481.4227786589, 40783.0, 41180.1763964713, 41745.0, 41804.372934406616, 35570.288594228485, 35978.10054748652, 36373.818130909174, 36897.81551092335, 37057.0, 35964.084826886676, 36038.27923441569, 36595.451068233466, 36875.81562092173, 37791.433128503646, 34275.14312142217, 34766.0, 34929.0, 35219.295614088085, 35630.821845890605, 31046.3293086058, 32733.0, 33289.334213315116, 33295.66704332926, 33448.0, 25149.74850251547, 25584.360390990376, 25693.871530642227, 25794.742052579233, 26069.869650651624], "value": 16319.93564212823, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [348.71579662575, 358.9084783380238, 363.56553918067914, 371.6766413220499, 387.407266881671, 15695.52913412598, 16869.915650421746, 17539.03535305559, 17703.73444398335, 17724.20241089151, 14792.482263120794, 15070.849291507082, 15457.84542154581, 15536.689266214697, 15587.830912681538, 5003.524665156813, 5230.372355317368, 5238.26664267001, 5239.13554263546, 5240.68555886648, 3705.277470893177, 5091.134507133796, 5672.319321681383, 5939.703014849262, 5948.375420580842, 5979.46184843364, 5987.55093367997, 5993.610415323012, 5993.640381577097, 5999.0, 5899.439553242435, 5899.5870289079785, 5940.97029514854, 5945.613535120204, 5945.851353716149, 5020.849374518771, 5135.717535535544, 5138.177891537373, 5139.871503212412, 5263.736813159365, 20125.7924524529, 20546.589068218702, 20555.794442055536, 20683.793162068338, 21097.0, 1966.0759443061738, 1973.7434133562545, 2112.8837913914726, 2273.3407311879537, 2496.4133428644254, 13117.47530098795, 13387.330633468386, 13691.657708557266, 13709.45162193511, 14148.575542733735, 1721.8424608536752, 1728.8271172882737, 1746.3014794082342, 1763.700170970938, 1767.920443580029, 68002.65998670025, 69161.0, 69909.0, 70124.0, 70710.64644676744, 8516.80619767587, 8781.692640757543, 9002.279817614575, 9020.233280171127, 9336.95331523338, 11912.225705329125, 11914.761704765857, 11925.10561707858, 11955.880441195477, 11977.401129943468, 6815.420689241371, 6862.2976607789515, 6930.896036559456, 7086.078809754699, 7101.218865924744, 6607.405333520006, 6676.0987266718375, 6870.690818913161, 6886.070380498669, 6890.689918953659, 5527.640703354269, 5663.801766938137, 5697.202391665171, 5744.281964754406, 5972.193753843176, 1588.793456850625, 1589.2371661602494, 1649.1342045426247, 1654.8014238291482, 1728.8357606027407, 860.5912191709014, 921.9216366608779, 922.7324076018014, 923.5936188077225, 951.2390087929629, 16672.166391680366, 16832.158392080346, 17126.571835704206, 17507.91246043787, 18040.639187216184, 814.7515007922641, 869.7695110795644, 879.349281531662, 890.8619164029586, 922.5571725571763, 9563.713088607354, 9648.131668149901, 9777.0, 9921.305508614472, 10089.899101009043, 393925.0, 400915.0, 401982.0, 405523.0, 407234.0, 86200.13799862047, 86289.13710862811, 86318.56840715757, 86995.0, 87331.0, 890.3055616619048, 913.488446469979, 931.1573026411108, 932.883389576303, 935.3592788939599, 15133.394664213309, 15237.3905043797, 15633.452829150925, 15886.443974460839, 16045.358185672443, 38726.0, 40065.799671001456, 40302.0, 41087.794561027, 41771.7911410441, 55784.442155577926, 57410.42589574051, 57602.13596796135, 58009.4199058004, 58242.0, 7833.334166595903, 7958.363330933627, 8128.512289262663, 8189.181081891763, 8214.13751556078, 10186.949065254626, 11842.644720658394, 12169.148159629096, 12263.080268979684, 12672.0, 10596.258261921592, 10602.522886470282, 10717.839232411365, 10781.245312828027, 10940.617078402218, 11001.559937602406, 11065.557377704801, 11091.944540277247, 11120.833187502356, 11220.99011089006, 10040.849387259052, 10714.89285107139, 10719.088877445505, 10852.186086043735, 11098.833517497405, 7533.962330188533, 7901.249381308767, 7909.762707118795, 7958.0848202457455, 8048.154943730824, 9042.502662353634, 10089.192864570963, 10124.69625911224, 10296.9743274756, 10585.523651435858], "value": 8468.816220963534, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1386.1821525300074, 1424.6652036771357, 1527.4959263443066, 1690.9577260568492, 1730.498155534894, 6429.292777794451, 7210.206877243506, 7426.480146389755, 7796.103448103469, 7814.5701986390795, 7534.3972482201425, 7791.649375778089, 7802.063752349712, 7809.843803123934, 7813.570253636048, 2140.967885481723, 2190.233418303589, 2190.7042549255807, 2191.5726433345426, 2191.6822060801173, 2135.6476181430044, 2154.2675490333286, 2194.5062360968736, 2203.8787866667326, 2205.911763529465, 2166.1010680567547, 2171.3160354488286, 2173.5544213436206, 2176.880271585062, 2176.923807666732, 2108.399106254718, 2116.333354993172, 2118.5868755592664, 2119.9364019079453, 2121.0561300221407, 2071.2439959414855, 2110.567333696604, 2116.343933380657, 2118.406846083099, 2118.66101423773, 7604.0875094988405, 7682.385409167253, 7701.807454813675, 7706.653200605986, 7709.074911010659, 4341.066670665822, 4427.0, 4459.0, 4464.754438505881, 4494.865154045384, 2732.0847516082135, 2792.854929478904, 2839.375337425763, 2854.158023383107, 2859.79981401302, 888.5379602606673, 948.8386974214332, 966.9758256043585, 968.404431274768, 970.1995853420956, 10153.238507111997, 10196.89803101967, 10209.0, 10278.897211027943, 10279.79440411195, 3865.4974853268895, 4008.8596899108393, 4135.462389889355, 4143.109231515239, 4148.2947898857265, 8791.07693692166, 8847.557622118868, 8875.822483550422, 8888.466691998501, 8889.0, 4368.825246990084, 4405.889852753643, 4410.42664453619, 4432.822687092545, 4434.955650443519, 3256.7231785298513, 3853.9421908671393, 3935.0949281665376, 3952.486176796998, 3971.3645816669773, 3456.165943926007, 3555.253396786652, 3559.7864128152396, 3611.963880361163, 3656.2687462507074, 1165.8134698448207, 1175.2360965372404, 1192.7375977284983, 1193.4271549656214, 1194.9163558550817, 819.7376839411451, 825.6674893426095, 839.4574745908012, 853.0531110467376, 857.4512312120248, 5120.436751957282, 5191.39066889258, 5242.423333433319, 5293.206019097166, 5347.598930080182, 869.165601023025, 906.1120102299651, 926.9258459323238, 931.59475628102, 947.462932372985, 3526.6297038811067, 3571.08937221007, 3571.6785489305566, 3572.8392222350058, 3602.4776407420777, 9355.204807591432, 9521.333506654468, 9564.426134431957, 9623.374480658735, 9639.036096390304, 9597.088276613711, 9599.568019439143, 9600.75998100053, 9607.56765945534, 9621.855672164924, 7381.151167615685, 7386.187519372865, 7414.851702966019, 7464.0, 7494.5128566643, 5077.8730531737, 5179.093658609653, 5203.895922081461, 5275.920861187008, 5437.3747019091725, 8689.435186712843, 8756.956215218883, 8810.867836982323, 8851.513166775632, 8919.375643704878, 8727.170918762708, 9030.90969090327, 9138.63445462174, 9148.588313526041, 9152.633894644407, 5596.076647353141, 6375.74497020114, 6413.0, 6569.310222426577, 6603.273639899511, 7217.6391180441815, 7291.708331666674, 7471.514351567131, 7478.925210748041, 7501.774946751606, 6689.2307384651385, 6854.0404343390965, 6863.725450982104, 6876.415504682158, 7033.402160816388, 6637.966810165918, 6678.866422671616, 6686.398224159849, 6771.3905748482875, 6873.347032031949, 6246.094316324198, 6258.9374106260175, 6265.498760099273, 6287.2140982377205, 6287.71705273273, 4404.185225733249, 4502.932456013228, 4520.683552151318, 4625.629949603956, 4643.953560464487, 4401.911961760683, 4459.085887393141, 4479.865604031885, 4495.550444955609, 4618.30725391194], "value": 4093.3374647543455, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [276.1412008653089, 283.58879624544403, 284.2141478811088, 290.99418011639756, 292.7643247186016, 5056.5701915337195, 5112.0, 5113.948860511398, 5119.84966314148, 5138.332016837806, 5002.12462819007, 5020.246962955558, 5020.297158397827, 5082.186850103984, 5102.158143906251, 3711.109333759892, 3787.1289603391238, 3838.136419305662, 3888.045085734848, 3903.8048097595147, 3870.283997460465, 3874.3994680824517, 3874.845006199763, 3880.3985382265796, 3887.5334959804864, 3864.3237433449176, 3872.5159355080614, 3883.2815929053218, 3885.0675837798867, 3890.9221815563674, 3802.258559580883, 3881.2237552489614, 3896.162325100117, 3900.6294402031904, 3909.5894931032117, 3375.375555522236, 3376.7467439941856, 3378.9863041087574, 3389.3221355728706, 3421.26442814796, 4846.164993478819, 4868.92883565615, 4904.485029071931, 4920.532549407801, 4926.8768280793265, 4346.891327716832, 4446.822127114911, 4474.619657329131, 4485.573870482299, 4492.96661767792, 5251.264822924793, 5265.394479634814, 5274.92087618686, 5306.681599104066, 5317.893642127175, 3735.234276973214, 3742.791752865795, 3747.1194269346684, 3747.6252374762307, 3748.962510374916, 5391.460853914656, 5498.900219956025, 5531.3362396512675, 5555.16686489889, 5559.416261292547, 3702.8148592570265, 3770.849166033383, 3772.5472943246436, 3804.98335881983, 3814.8474061037805, 3865.8453661853773, 3871.5547712012917, 3872.3997780344093, 3872.6320999505, 3874.651281384689, 4421.204183247047, 4432.844850430284, 4436.179306828247, 4443.311286750494, 4456.286994080931, 4997.350344455271, 5203.7918483261, 5232.816851410183, 5273.182656688219, 5303.867403314948, 1313.1923866821835, 1332.733453309342, 1334.1128149780288, 1336.2717319061135, 1336.3986206207246, 813.8616435206029, 843.5191940593803, 849.6856163219525, 853.5177624642057, 853.9667002926404, 4356.0, 4462.263726485094, 4620.491745907947, 4633.606143477842, 4641.259527677121, 5433.483819037185, 5452.972735136299, 5456.208849716769, 5478.45215478457, 5484.862878427992, 4612.630989520831, 4631.907361852812, 4633.443986721615, 4660.764897302218, 4672.836450724276, 2756.3798145417522, 2860.971390286112, 2883.9711602883704, 2909.6072030276064, 2930.868110935013, 5082.898342033139, 5091.872703182376, 5120.206368012964, 5121.718305493159, 5152.149895267239, 5316.0, 5576.888462230732, 5627.859303517363, 5633.436656334416, 5643.351014633287, 5131.538161565477, 5137.51193636604, 5137.974310128426, 5150.270356710875, 5174.223866420067, 5447.291852059366, 5457.808976685797, 5499.615026948075, 5501.834944951658, 5552.69460179694, 5190.480951904779, 5367.651102678314, 5376.327959005124, 5417.729113544386, 5419.945800541944, 5093.2105523643895, 5094.617903657315, 5128.666636668605, 5167.095758242368, 5180.7409629517615, 3829.234153169433, 3852.6725228355904, 3858.131920317906, 3858.80705964695, 3858.9228215436096, 5322.760475778677, 5452.863678408072, 5454.536364408911, 5473.0, 5569.610127291051, 5258.713304184885, 5266.236395722675, 5313.973430132824, 5326.627136100436, 5331.600129990189, 5260.842174734764, 5275.204141804849, 5278.788848446019, 5321.2705870591435, 5323.973380133075, 5022.648414610942, 5209.453007434165, 5218.295530103387, 5223.164293712987, 5237.947620523746, 5090.287359769709, 5168.0697474453455, 5286.12778891494, 5332.280142180756, 5344.732763361739, 5207.901298727251, 5225.3990791057995, 5228.790848366023, 5243.790248390174, 5245.980297585381], "value": 3952.1159151671327, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [589.6888968442197, 646.1503123392738, 649.3701109923372, 659.6602749583963, 663.1577896071989, 12656.367181640915, 13391.866081339183, 13622.795658065124, 13638.38627261772, 14325.713485730279, 13579.592612221624, 13768.0, 13795.103318284304, 13801.861981380183, 13829.723405531884, 633.3255083336255, 757.7082823113113, 777.8094366880123, 780.9492382995115, 781.6560713286136, 718.0557566799641, 742.283696233135, 748.5059860492076, 751.5415596486166, 751.597895126105, 810.1291112054536, 812.5246730662569, 813.6460639621754, 814.1370147643487, 815.355868863597, 805.6495424490365, 807.4791759315239, 812.4962523235573, 812.7642983534768, 813.6379311206515, 588.2352941176496, 592.8517870532366, 592.9673867937262, 594.1058706646469, 594.2898236607256, 12819.807702884464, 12821.358932053454, 12834.679133021657, 12850.485980560767, 12907.612771616867, 13187.670308242275, 13230.27233502157, 13850.030497865153, 13909.095908765898, 14166.858331416657, 10324.638637647646, 10362.27464077515, 10447.68656940293, 10549.20880933933, 10590.25868189227, 3277.131560136566, 3316.2704205074847, 3323.5845519310087, 3350.1289664687356, 3372.291818718072, 64145.358546414405, 64927.0, 65680.3431965679, 65904.0, 66703.66648166777, 10231.693049208536, 10563.577456901792, 10626.309289896131, 10662.306950048222, 10794.0, 20172.495687607927, 20186.596268074558, 20221.696674549894, 20227.0, 20236.89881550583, 6624.436922861514, 6645.302243264484, 6734.427573656294, 6750.561213521106, 6764.0, 3320.634730179727, 3409.607895092096, 3472.4964880092243, 3563.803990780532, 3670.7797532148156, 2787.6515435570554, 2894.0015694585336, 2895.8841646333913, 2909.970900291012, 2910.4179164167253, 474.7673639916485, 485.1873112536487, 493.37341576198025, 498.78053656391074, 499.3209235439799, 481.91566475866586, 492.68221996811855, 494.5894907226993, 506.2431664661281, 520.8099043848968, 6997.230304666483, 7101.147862256562, 7316.670749816271, 7401.222871598512, 7502.6623801929045, 406.8230319810892, 427.4315160836081, 435.7320248047428, 497.1101727907078, 517.0976645753185, 3435.280258369786, 3675.5038069860225, 3846.538415390171, 3879.8448062077764, 3946.151577410813, 94975.0, 98108.50945745225, 98965.50517247367, 99427.50286248667, 102799.0, 89897.55051224702, 90417.54791226002, 91325.0, 92361.0, 97927.51036244773, 81910.59044704738, 82696.0, 83926.0, 85184.0, 85222.14777852266, 7344.375728062961, 7530.096388433423, 7662.272084151997, 7676.501027433199, 7770.611469426393, 32333.0, 43634.781826090664, 43912.780436097615, 44089.0, 45059.0, 59303.0, 64317.56824317531, 67013.66493167503, 67398.3260167392, 69540.30459695541, 9127.269818414643, 9167.954160229156, 9588.232941364813, 9660.37207581505, 9680.273979451711, 10805.18961077938, 10886.455677216265, 10987.945060274647, 11080.61217857371, 11392.25950313227, 9694.224462043161, 9767.951160244438, 9807.607695692092, 10334.483275836328, 10627.628033018807, 9608.567614457226, 9781.804363912539, 9829.606815727291, 9849.606015759577, 9961.252906031932, 9616.855747163658, 9849.01877090754, 9860.408375497493, 9943.25425593069, 10345.810231823436, 8485.448445851, 8541.188587084218, 8551.230389264996, 8759.12408759119, 8839.116088391109, 8167.83664326722, 8707.608157632794, 8765.34259930495, 8805.42764720291, 8885.733427997171], "value": 6287.7331540031155, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1581.0000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 115.0, 109.0, 113.0, 114.0, 115.0, 116.0, 115.0, 116.0, 115.0], "value": 113.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 125.0, 150.0, 187.0, 124.0, 161.0, 155.0, 124.0, 184.0, 122.0], "value": 147.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 165.0, 165.0, 178.0, 167.0, 168.0, 165.0, 165.0, 162.0, 163.0], "value": 166.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 77.0, 166.0, 77.0, 77.0, 75.0, 77.0, 148.0, 77.0], "value": 92.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 145.0, 85.0, 85.0, 85.0, 145.0, 86.0, 85.0, 128.0], "value": 101.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 118.0, 118.0, 118.0, 119.0, 119.0, 118.0, 118.0], "value": 118.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 148.0, 148.0, 147.0, 148.0, 148.0, 148.0, 147.0, 147.0], "value": 147.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 97.0, 100.0, 96.0, 96.0, 95.0], "value": 96.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 67.0, 67.0, 68.0, 64.0, 66.0, 66.0, 66.0, 65.0], "value": 65.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 70.0, 65.0, 66.0, 65.0, 66.0, 65.0, 65.0, 65.0], "value": 65.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 85.0, 80.0, 85.0, 81.0, 80.0, 78.0, 80.0, 89.0, 80.0], "value": 81.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 147.0, 140.0, 141.0, 142.0, 146.0, 149.0, 142.0, 144.0, 147.0], "value": 144.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 169.0, 167.0, 165.0, 170.0, 179.0, 170.0, 167.0, 171.0, 170.0], "value": 170.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 68.0, 71.0, 71.0, 70.0, 69.0, 68.0, 72.0, 68.0, 67.0], "value": 69.4, "unit": "score"}]}]} 22:37:21 INFO - Return code: 0 22:37:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:37:21 ERROR - # TBPL SUCCESS # 22:37:21 INFO - Running post-action listener: _resource_record_post_action 22:37:21 INFO - [mozharness: 2016-08-08 05:37:21.588095Z] Finished run-tests step (success) 22:37:21 INFO - Running post-run listener: _resource_record_post_run 22:37:21 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 8192; Write bytes: 535490560; Read time: 116; Write time: 587672 22:37:21 INFO - TinderboxPrint: CPU usage
13.3% 22:37:21 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 116 22:37:21 INFO - TinderboxPrint: I/O write bytes / time
535,490,560 / 587,672 22:37:21 INFO - TinderboxPrint: CPU idle
8,277.7 (86.7%) 22:37:21 INFO - TinderboxPrint: CPU user
1,218.3 (12.8%) 22:37:21 INFO - TinderboxPrint: Swap in / out
0 / 0 22:37:21 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 4096; Write bytes: 248766464; Read time: 96; Write time: 375396 22:37:21 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 0; Write bytes: 286724096; Read time: 0; Write time: 212276 22:37:22 INFO - Running post-run listener: _upload_blobber_files 22:37:22 INFO - Blob upload gear active. 22:37:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:37:22 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 22:37:22 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'] 22:37:22 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 22:37:22 INFO - (blobuploader) - INFO - Open directory for files ... 22:37:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 22:37:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:37:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:37:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 22:37:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:37:23 INFO - (blobuploader) - INFO - Done attempting. 22:37:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:37:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:37:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:37:28 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:37:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:37:28 INFO - (blobuploader) - INFO - Done attempting. 22:37:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 22:37:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:37:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:37:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 22:37:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:37:29 INFO - (blobuploader) - INFO - Done attempting. 22:37:29 INFO - (blobuploader) - INFO - Iteration through files over. 22:37:29 INFO - Return code: 0 22:37:29 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:37:29 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:37:29 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/722b2f742d7828ed042deee7bba97d53e2bffb9c4e1e5bb8410c79960ff105b4f2945a60184f854af13ce56a8b641142ce2a6ca199c1a1c17ef426a5d05fe50d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/e0616acb3f92594c85d4651b1b6bfec576519bc05c60aa22faabade89c2fa752743e1fc8a9fd23fbc86374ed46ddce442f348a86f5e3e9eb96be045cb8ba0462", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/1988f7f17c2e4c338799c0ae66d5ab397c6e4fb73c69d682478864c2a87d71945adbbe0b32f2981d20bf90a52682b3c041ad480657c638396d73a72a7fd2e82b"} 22:37:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:37:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:37:29 INFO - Contents: 22:37:29 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/722b2f742d7828ed042deee7bba97d53e2bffb9c4e1e5bb8410c79960ff105b4f2945a60184f854af13ce56a8b641142ce2a6ca199c1a1c17ef426a5d05fe50d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/e0616acb3f92594c85d4651b1b6bfec576519bc05c60aa22faabade89c2fa752743e1fc8a9fd23fbc86374ed46ddce442f348a86f5e3e9eb96be045cb8ba0462", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/1988f7f17c2e4c338799c0ae66d5ab397c6e4fb73c69d682478864c2a87d71945adbbe0b32f2981d20bf90a52682b3c041ad480657c638396d73a72a7fd2e82b"} 22:37:29 INFO - Running post-run listener: copy_logs_to_upload_dir 22:37:29 INFO - Copying logs to upload dir... 22:37:29 INFO - mkdir: /builds/slave/test/build/upload/logs 22:37:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.751290 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-08-07 22:37:29.662691) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-07 22:37:29.666583) ========= 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=db0483c52d987ecb441a263b000001ad-1470632956.631379-321176434 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/722b2f742d7828ed042deee7bba97d53e2bffb9c4e1e5bb8410c79960ff105b4f2945a60184f854af13ce56a8b641142ce2a6ca199c1a1c17ef426a5d05fe50d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/e0616acb3f92594c85d4651b1b6bfec576519bc05c60aa22faabade89c2fa752743e1fc8a9fd23fbc86374ed46ddce442f348a86f5e3e9eb96be045cb8ba0462", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/1988f7f17c2e4c338799c0ae66d5ab397c6e4fb73c69d682478864c2a87d71945adbbe0b32f2981d20bf90a52682b3c041ad480657c638396d73a72a7fd2e82b"} build_url:https://queue.taskcluster.net/v1/task/Rnk5KSAQT8u2mUUaU9BysA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011316 build_url: 'https://queue.taskcluster.net/v1/task/Rnk5KSAQT8u2mUUaU9BysA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/722b2f742d7828ed042deee7bba97d53e2bffb9c4e1e5bb8410c79960ff105b4f2945a60184f854af13ce56a8b641142ce2a6ca199c1a1c17ef426a5d05fe50d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/e0616acb3f92594c85d4651b1b6bfec576519bc05c60aa22faabade89c2fa752743e1fc8a9fd23fbc86374ed46ddce442f348a86f5e3e9eb96be045cb8ba0462", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/1988f7f17c2e4c338799c0ae66d5ab397c6e4fb73c69d682478864c2a87d71945adbbe0b32f2981d20bf90a52682b3c041ad480657c638396d73a72a7fd2e82b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-07 22:37:29.691919) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 22:37:29.692254) ========= 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=db0483c52d987ecb441a263b000001ad-1470632956.631379-321176434 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004542 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 22:37:29.774171) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-07 22:37:29.774487) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-07 22:37:29.774782) ========= ========= Total master_lag: 0.17 =========