builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-014 starttime: 1472058615.7 results: success (0) buildid: 20160824091826 builduid: 3d5081f34d564847bdabb73ac1c01358 revision: ff3d89bec675e5a8ceec87b60b9d121f7daa15fb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-24 10:10:15.704158) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-24 10:10:15.704615) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-24 10:10:15.704893) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-24 10:10:15.721961) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 10:10:15.722398) ========= 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=31acecf42b6a79ec49471d4a000001bb-1472058614.577174-1433154885 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-24 10:10:15-- 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% 104M=0s 2016-08-24 10:10:15 (104 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.108623 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 10:10:15.844889) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 10:10:15.848285) ========= 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=31acecf42b6a79ec49471d4a000001bb-1472058614.577174-1433154885 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017975 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 10:10:15.898891) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 10:10:15.902287) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev ff3d89bec675e5a8ceec87b60b9d121f7daa15fb --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 ff3d89bec675e5a8ceec87b60b9d121f7daa15fb --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=31acecf42b6a79ec49471d4a000001bb-1472058614.577174-1433154885 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-24 10:10:16,000 truncating revision to first 12 chars 2016-08-24 10:10:16,000 Setting DEBUG logging. 2016-08-24 10:10:16,000 attempt 1/10 2016-08-24 10:10:16,000 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/ff3d89bec675?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-24 10:10:16,304 unpacking tar archive at: autoland-ff3d89bec675/testing/mozharness/ program finished with exit code 0 elapsedTime=0.602520 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 10:10:16.544641) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-24 10:10:16.544938) ========= script_repo_revision: ff3d89bec675e5a8ceec87b60b9d121f7daa15fb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-24 10:10:16.545378) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-24 10:10:16.545649) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-24 10:10:16.557422) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-08-24 10:10:16.557755) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=31acecf42b6a79ec49471d4a000001bb-1472058614.577174-1433154885 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:10:16 INFO - MultiFileLogger online at 20160824 10:10:16 in /builds/slave/test 10:10:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 10:10:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:10:16 INFO - {'append_to_log': False, 10:10:16 INFO - 'base_work_dir': '/builds/slave/test', 10:10:16 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 10:10:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:10:16 INFO - 'branch': 'Autoland-Non-PGO', 10:10:16 INFO - 'buildbot_json_path': 'buildprops.json', 10:10:16 INFO - 'config_files': ('talos/linux_config.py',), 10:10:16 INFO - 'default_actions': ('clobber', 10:10:16 INFO - 'read-buildbot-config', 10:10:16 INFO - 'download-and-extract', 10:10:16 INFO - 'populate-webroot', 10:10:16 INFO - 'create-virtualenv', 10:10:16 INFO - 'install', 10:10:16 INFO - 'run-tests'), 10:10:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:10:16 INFO - 'download_minidump_stackwalk': True, 10:10:16 INFO - 'download_symbols': 'ondemand', 10:10:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:10:16 INFO - 'tooltool.py': '/tools/tooltool.py', 10:10:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:10:16 INFO - '/tools/misc-python/virtualenv.py')}, 10:10:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:10:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:10:16 INFO - 'installer_path': 'installer.exe', 10:10:16 INFO - 'log_level': 'info', 10:10:16 INFO - 'log_name': 'talos', 10:10:16 INFO - 'log_to_console': True, 10:10:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:10:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:10:16 INFO - 'opt_config_files': (), 10:10:16 INFO - 'pip_index': False, 10:10:16 INFO - 'sps_profile': False, 10:10:16 INFO - 'sps_profile_interval': 0, 10:10:16 INFO - 'suite': 'dromaeojs', 10:10:16 INFO - 'system_bits': '32', 10:10:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:10:16 INFO - 'title': 'talos-linux64-ix-014', 10:10:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:10:16 INFO - 'use_talos_json': True, 10:10:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:10:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:10:16 INFO - 'work_dir': 'build'} 10:10:16 INFO - [mozharness: 2016-08-24 17:10:16.750678Z] Running clobber step. 10:10:16 INFO - Running pre-action listener: _resource_record_pre_action 10:10:16 INFO - Running main action method: clobber 10:10:16 INFO - rmtree: /builds/slave/test/build 10:10:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:10:17 INFO - Running post-action listener: _resource_record_post_action 10:10:17 INFO - [mozharness: 2016-08-24 17:10:17.212361Z] Finished clobber step (success) 10:10:17 INFO - [mozharness: 2016-08-24 17:10:17.212463Z] Running read-buildbot-config step. 10:10:17 INFO - Running pre-action listener: _resource_record_pre_action 10:10:17 INFO - Running main action method: read_buildbot_config 10:10:17 INFO - Using buildbot properties: 10:10:17 INFO - { 10:10:17 INFO - "project": "", 10:10:17 INFO - "product": "firefox", 10:10:17 INFO - "script_repo_revision": "production", 10:10:17 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 10:10:17 INFO - "repository": "", 10:10:17 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 10:10:17 INFO - "buildid": "20160824091826", 10:10:17 INFO - "pgo_build": "False", 10:10:17 INFO - "basedir": "/builds/slave/test", 10:10:17 INFO - "buildnumber": 312, 10:10:17 INFO - "slavename": "talos-linux64-ix-014", 10:10:17 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 10:10:17 INFO - "platform": "ubuntu64_hw", 10:10:17 INFO - "scheduler": "tests-autoland-linux64-talos", 10:10:17 INFO - "branch": "autoland", 10:10:17 INFO - "repo_path": "integration/autoland", 10:10:17 INFO - "revision": "ff3d89bec675e5a8ceec87b60b9d121f7daa15fb", 10:10:17 INFO - "stage_platform": "linux64", 10:10:17 INFO - "builduid": "3d5081f34d564847bdabb73ac1c01358", 10:10:17 INFO - "slavebuilddir": "test" 10:10:17 INFO - } 10:10:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/GMjyknKaSEuZeRN8SHkKyg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 10:10:17 INFO - Running post-action listener: _resource_record_post_action 10:10:17 INFO - [mozharness: 2016-08-24 17:10:17.214893Z] Finished read-buildbot-config step (success) 10:10:17 INFO - [mozharness: 2016-08-24 17:10:17.214982Z] Running download-and-extract step. 10:10:17 INFO - Running pre-action listener: _resource_record_pre_action 10:10:17 INFO - Running main action method: download_and_extract 10:10:17 INFO - mkdir: /builds/slave/test/build/tests 10:10:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:10:17 INFO - trying https://queue.taskcluster.net/v1/task/GMjyknKaSEuZeRN8SHkKyg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 10:10:17 INFO - Downloading https://queue.taskcluster.net/v1/task/GMjyknKaSEuZeRN8SHkKyg/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 10:10:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GMjyknKaSEuZeRN8SHkKyg/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 10:10:17 INFO - Downloaded 1361 bytes. 10:10:17 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 10:10:17 INFO - Using the following test package requirements: 10:10:17 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 10:10:17 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:10:17 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:10:17 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:10:17 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:10:17 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:10:17 INFO - u'jsshell-linux-x86_64.zip'], 10:10:17 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:10:17 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:10:17 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 10:10:17 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:10:17 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:10:17 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:10:17 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:10:17 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:10:17 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:10:17 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:10:17 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:10:17 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:10:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:10:17 INFO - trying https://queue.taskcluster.net/v1/task/GMjyknKaSEuZeRN8SHkKyg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 10:10:17 INFO - Downloading https://queue.taskcluster.net/v1/task/GMjyknKaSEuZeRN8SHkKyg/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 10:10:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GMjyknKaSEuZeRN8SHkKyg/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 10:10:18 INFO - Downloaded 20324257 bytes. 10:10:18 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 10:10:22 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 10:10:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:10:22 INFO - trying https://queue.taskcluster.net/v1/task/GMjyknKaSEuZeRN8SHkKyg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 10:10:22 INFO - Downloading https://queue.taskcluster.net/v1/task/GMjyknKaSEuZeRN8SHkKyg/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 10:10:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GMjyknKaSEuZeRN8SHkKyg/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 10:10:23 INFO - Downloaded 20324257 bytes. 10:10:23 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 10:10:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:10:28 INFO - trying https://queue.taskcluster.net/v1/task/GMjyknKaSEuZeRN8SHkKyg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 10:10:28 INFO - Downloading https://queue.taskcluster.net/v1/task/GMjyknKaSEuZeRN8SHkKyg/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 10:10:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GMjyknKaSEuZeRN8SHkKyg/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 10:10:29 INFO - Downloaded 14413981 bytes. 10:10:29 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 10:10:29 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')]} 10:10:29 INFO - trying https://queue.taskcluster.net/v1/task/GMjyknKaSEuZeRN8SHkKyg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 10:10:29 INFO - Downloading https://queue.taskcluster.net/v1/task/GMjyknKaSEuZeRN8SHkKyg/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 10:10:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GMjyknKaSEuZeRN8SHkKyg/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 10:10:30 INFO - Downloaded 55752178 bytes. 10:10:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GMjyknKaSEuZeRN8SHkKyg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 10:10:30 INFO - mkdir: /builds/slave/test/properties 10:10:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:10:30 INFO - Writing to file /builds/slave/test/properties/build_url 10:10:30 INFO - Contents: 10:10:30 INFO - build_url:https://queue.taskcluster.net/v1/task/GMjyknKaSEuZeRN8SHkKyg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 10:10:31 INFO - Running post-action listener: _resource_record_post_action 10:10:31 INFO - Running post-action listener: set_extra_try_arguments 10:10:31 INFO - [mozharness: 2016-08-24 17:10:31.108038Z] Finished download-and-extract step (success) 10:10:31 INFO - [mozharness: 2016-08-24 17:10:31.108335Z] Running populate-webroot step. 10:10:31 INFO - Running pre-action listener: _resource_record_pre_action 10:10:31 INFO - Running main action method: populate_webroot 10:10:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:10:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:10:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:10:31 INFO - '--tppagecycles', 10:10:31 INFO - '7'], 10:10:31 INFO - 'tests': ['tsvgm']}}, 10:10:31 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:10:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:10:31 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:10:31 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:10:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:10:31 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:10:31 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:10:31 INFO - 'talos_options': ['--disable-e10s'], 10:10:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:10:31 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:10:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:10:31 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:10:31 INFO - 'talos_options': ['--disable-e10s'], 10:10:31 INFO - 'tests': ['damp', 'tps']}, 10:10:31 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:10:31 INFO - 'tests': ['damp', 'tps']}, 10:10:31 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:10:31 INFO - 'tests': ['dromaeo_dom']}, 10:10:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:10:31 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:10:31 INFO - 'tests': ['basic_compositor_video']}, 10:10:31 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:10:31 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:10:31 INFO - 'tests': ['a11yr', 10:10:31 INFO - 'ts_paint', 10:10:31 INFO - 'tpaint', 10:10:31 INFO - 'sessionrestore', 10:10:31 INFO - 'sessionrestore_no_auto_restore', 10:10:31 INFO - 'tabpaint']}, 10:10:31 INFO - 'other-e10s': {'tests': ['a11yr', 10:10:31 INFO - 'ts_paint', 10:10:31 INFO - 'tpaint', 10:10:31 INFO - 'sessionrestore', 10:10:31 INFO - 'sessionrestore_no_auto_restore', 10:10:31 INFO - 'tabpaint']}, 10:10:31 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:10:31 INFO - 'ts_paint', 10:10:31 INFO - 'tpaint', 10:10:31 INFO - 'sessionrestore', 10:10:31 INFO - 'sessionrestore_no_auto_restore', 10:10:31 INFO - 'tabpaint']}, 10:10:31 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:10:31 INFO - 'ts_paint', 10:10:31 INFO - 'tpaint', 10:10:31 INFO - 'sessionrestore', 10:10:31 INFO - 'sessionrestore_no_auto_restore', 10:10:31 INFO - 'tabpaint']}, 10:10:31 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:10:31 INFO - 'tests': ['a11yr', 10:10:31 INFO - 'ts_paint', 10:10:31 INFO - 'tpaint', 10:10:31 INFO - 'sessionrestore', 10:10:31 INFO - 'sessionrestore_no_auto_restore', 10:10:31 INFO - 'tabpaint']}, 10:10:31 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:10:31 INFO - 'tests': ['a11yr', 10:10:31 INFO - 'ts_paint', 10:10:31 INFO - 'tpaint', 10:10:31 INFO - 'sessionrestore', 10:10:31 INFO - 'sessionrestore_no_auto_restore', 10:10:31 INFO - 'tabpaint']}, 10:10:31 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:10:31 INFO - 'tests': ['tsvgx', 10:10:31 INFO - 'tsvgr_opacity', 10:10:31 INFO - 'tart', 10:10:31 INFO - 'tscrollx', 10:10:31 INFO - 'cart']}, 10:10:31 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:10:31 INFO - 'tsvgr_opacity', 10:10:31 INFO - 'tart', 10:10:31 INFO - 'tscrollx', 10:10:31 INFO - 'cart']}, 10:10:31 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:10:31 INFO - 'talos_options': ['--disable-e10s'], 10:10:31 INFO - 'tests': ['tp5o']}, 10:10:31 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:10:31 INFO - 'tests': ['tp5o']}, 10:10:31 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:10:31 INFO - 'talos_options': ['--disable-e10s', 10:10:31 INFO - '--xperf_path', 10:10:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:10:31 INFO - 'tests': ['tp5n']}, 10:10:31 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:10:31 INFO - 'talos_options': ['--xperf_path', 10:10:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:10:31 INFO - 'tests': ['tp5n']}}, 10:10:31 INFO - 'talos.zip': {'path': '', 10:10:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:10:31 INFO - Running post-action listener: _resource_record_post_action 10:10:31 INFO - [mozharness: 2016-08-24 17:10:31.125133Z] Finished populate-webroot step (success) 10:10:31 INFO - [mozharness: 2016-08-24 17:10:31.125225Z] Running create-virtualenv step. 10:10:31 INFO - Running pre-action listener: _resource_record_pre_action 10:10:31 INFO - Running main action method: create_virtualenv 10:10:31 INFO - Creating virtualenv /builds/slave/test/build/venv 10:10:31 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 10:10:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:10:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:10:31 INFO - Using real prefix '/usr' 10:10:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:10:31 INFO - Installing distribute.............................................................................................................................................................................................done. 10:10:33 INFO - Installing pip.................done. 10:10:33 INFO - Return code: 0 10:10:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:10:33 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')]} 10:10:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:10:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:33 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')]} 10:10:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:10:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:33 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 0x7fb1242f8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x118d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x125c230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1256090>, '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 0x12599b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1259e40>, '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': '31acecf42b6a79ec49471d4a000001bb-1472058614.577174-1433154885', '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 10:10:33 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 10:10:33 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 10:10:33 INFO - Using env: {'DISPLAY': ':0', 10:10:33 INFO - 'HOME': '/home/cltbld', 10:10:33 INFO - 'LANG': 'en_US.UTF-8', 10:10:33 INFO - 'LANGUAGE': 'en_US:en', 10:10:33 INFO - 'LOGNAME': 'cltbld', 10:10:33 INFO - 'MAIL': '/var/mail/cltbld', 10:10:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:10:33 INFO - 'MOZ_NO_REMOTE': '1', 10:10:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:10:33 INFO - 'NO_EM_RESTART': '1', 10:10:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:10:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:10:33 INFO - 'PWD': '/builds/slave/test', 10:10:33 INFO - 'SHELL': '/bin/bash', 10:10:33 INFO - 'SHLVL': '1', 10:10:33 INFO - 'TERM': 'linux', 10:10:33 INFO - 'TMOUT': '86400', 10:10:33 INFO - 'USER': 'cltbld', 10:10:33 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1472058614.577174-1433154885', 10:10:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:10:33 INFO - '_': '/tools/buildbot/bin/python'} 10:10:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:10:33 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 10:10:33 INFO - Cleaning up... 10:10:33 INFO - Return code: 0 10:10:33 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:10:33 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')]} 10:10:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:10:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:33 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')]} 10:10:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:10:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:33 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 0x7fb1242f8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x118d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x125c230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1256090>, '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 0x12599b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1259e40>, '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': '31acecf42b6a79ec49471d4a000001bb-1472058614.577174-1433154885', '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 10:10:33 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 10:10:33 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 10:10:33 INFO - Using env: {'DISPLAY': ':0', 10:10:33 INFO - 'HOME': '/home/cltbld', 10:10:33 INFO - 'LANG': 'en_US.UTF-8', 10:10:33 INFO - 'LANGUAGE': 'en_US:en', 10:10:33 INFO - 'LOGNAME': 'cltbld', 10:10:33 INFO - 'MAIL': '/var/mail/cltbld', 10:10:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:10:33 INFO - 'MOZ_NO_REMOTE': '1', 10:10:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:10:33 INFO - 'NO_EM_RESTART': '1', 10:10:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:10:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:10:33 INFO - 'PWD': '/builds/slave/test', 10:10:33 INFO - 'SHELL': '/bin/bash', 10:10:33 INFO - 'SHLVL': '1', 10:10:33 INFO - 'TERM': 'linux', 10:10:33 INFO - 'TMOUT': '86400', 10:10:33 INFO - 'USER': 'cltbld', 10:10:33 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1472058614.577174-1433154885', 10:10:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:10:33 INFO - '_': '/tools/buildbot/bin/python'} 10:10:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:10:34 INFO - Downloading/unpacking psutil>=3.1.1 10:10:34 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 10:10:34 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 10:10:34 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 10:10:34 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 10:10:34 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 10:10:34 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 10:10:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:10:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:10:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:10:36 INFO - Installing collected packages: psutil 10:10:36 INFO - Running setup.py install for psutil 10:10:36 INFO - building 'psutil._psutil_linux' extension 10:10:36 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 10:10:36 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 10:10:36 INFO - building 'psutil._psutil_posix' extension 10:10:36 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 10:10:36 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 10:10:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:10:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:10:36 INFO - Successfully installed psutil 10:10:36 INFO - Cleaning up... 10:10:36 INFO - Return code: 0 10:10:36 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:10:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:10:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:10:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:10:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:10:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:36 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 0x7fb1242f8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x118d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x125c230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1256090>, '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 0x12599b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1259e40>, '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': '31acecf42b6a79ec49471d4a000001bb-1472058614.577174-1433154885', '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 10:10:36 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 10:10:36 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 10:10:36 INFO - Using env: {'DISPLAY': ':0', 10:10:36 INFO - 'HOME': '/home/cltbld', 10:10:36 INFO - 'LANG': 'en_US.UTF-8', 10:10:36 INFO - 'LANGUAGE': 'en_US:en', 10:10:36 INFO - 'LOGNAME': 'cltbld', 10:10:36 INFO - 'MAIL': '/var/mail/cltbld', 10:10:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:10:36 INFO - 'MOZ_NO_REMOTE': '1', 10:10:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:10:36 INFO - 'NO_EM_RESTART': '1', 10:10:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:10:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:10:36 INFO - 'PWD': '/builds/slave/test', 10:10:36 INFO - 'SHELL': '/bin/bash', 10:10:36 INFO - 'SHLVL': '1', 10:10:36 INFO - 'TERM': 'linux', 10:10:36 INFO - 'TMOUT': '86400', 10:10:36 INFO - 'USER': 'cltbld', 10:10:36 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1472058614.577174-1433154885', 10:10:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:10:36 INFO - '_': '/tools/buildbot/bin/python'} 10:10:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:10:36 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:10:36 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 10:10:36 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 10:10:36 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 10:10:36 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 10:10:36 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 10:10:36 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 10:10:38 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:10:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:10:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:10:38 INFO - Installing collected packages: mozsystemmonitor 10:10:38 INFO - Running setup.py install for mozsystemmonitor 10:10:38 INFO - Successfully installed mozsystemmonitor 10:10:38 INFO - Cleaning up... 10:10:38 INFO - Return code: 0 10:10:38 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:10:38 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')]} 10:10:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:10:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:38 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')]} 10:10:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:10:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:38 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 0x7fb1242f8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x118d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x125c230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1256090>, '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 0x12599b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1259e40>, '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': '31acecf42b6a79ec49471d4a000001bb-1472058614.577174-1433154885', '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 10:10:38 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 10:10:38 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 10:10:38 INFO - Using env: {'DISPLAY': ':0', 10:10:38 INFO - 'HOME': '/home/cltbld', 10:10:38 INFO - 'LANG': 'en_US.UTF-8', 10:10:38 INFO - 'LANGUAGE': 'en_US:en', 10:10:38 INFO - 'LOGNAME': 'cltbld', 10:10:38 INFO - 'MAIL': '/var/mail/cltbld', 10:10:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:10:38 INFO - 'MOZ_NO_REMOTE': '1', 10:10:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:10:38 INFO - 'NO_EM_RESTART': '1', 10:10:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:10:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:10:38 INFO - 'PWD': '/builds/slave/test', 10:10:38 INFO - 'SHELL': '/bin/bash', 10:10:38 INFO - 'SHLVL': '1', 10:10:38 INFO - 'TERM': 'linux', 10:10:38 INFO - 'TMOUT': '86400', 10:10:38 INFO - 'USER': 'cltbld', 10:10:38 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1472058614.577174-1433154885', 10:10:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:10:38 INFO - '_': '/tools/buildbot/bin/python'} 10:10:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:10:39 INFO - Downloading/unpacking jsonschema==2.5.1 10:10:39 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 10:10:39 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 10:10:39 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 10:10:39 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 10:10:39 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 10:10:39 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 10:10:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:10:41 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:10:41 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 10:10:41 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 10:10:41 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 10:10:41 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 10:10:41 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 10:10:41 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 10:10:41 INFO - Downloading functools32-3.2.3-2.tar.gz 10:10:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:10:41 INFO - warning: no files found matching '*.txt' 10:10:41 INFO - no previously-included directories found matching 'build' 10:10:41 INFO - no previously-included directories found matching 'dist' 10:10:41 INFO - no previously-included directories found matching '.git*' 10:10:41 INFO - Installing collected packages: jsonschema, functools32 10:10:41 INFO - Running setup.py install for functools32 10:10:41 INFO - warning: no files found matching '*.txt' 10:10:41 INFO - no previously-included directories found matching 'build' 10:10:41 INFO - no previously-included directories found matching 'dist' 10:10:41 INFO - no previously-included directories found matching '.git*' 10:10:41 INFO - Successfully installed jsonschema functools32 10:10:41 INFO - Cleaning up... 10:10:41 INFO - Return code: 0 10:10:41 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:10:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:10:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:10:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:10:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:10:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:41 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 0x7fb1242f8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x118d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x125c230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1256090>, '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 0x12599b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1259e40>, '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': '31acecf42b6a79ec49471d4a000001bb-1472058614.577174-1433154885', '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 10:10:41 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 10:10:41 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 10:10:41 INFO - Using env: {'DISPLAY': ':0', 10:10:41 INFO - 'HOME': '/home/cltbld', 10:10:41 INFO - 'LANG': 'en_US.UTF-8', 10:10:41 INFO - 'LANGUAGE': 'en_US:en', 10:10:41 INFO - 'LOGNAME': 'cltbld', 10:10:41 INFO - 'MAIL': '/var/mail/cltbld', 10:10:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:10:41 INFO - 'MOZ_NO_REMOTE': '1', 10:10:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:10:41 INFO - 'NO_EM_RESTART': '1', 10:10:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:10:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:10:41 INFO - 'PWD': '/builds/slave/test', 10:10:41 INFO - 'SHELL': '/bin/bash', 10:10:41 INFO - 'SHLVL': '1', 10:10:41 INFO - 'TERM': 'linux', 10:10:41 INFO - 'TMOUT': '86400', 10:10:41 INFO - 'USER': 'cltbld', 10:10:41 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1472058614.577174-1433154885', 10:10:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:10:41 INFO - '_': '/tools/buildbot/bin/python'} 10:10:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:10:41 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:10:41 INFO - Cleaning up... 10:10:41 INFO - Return code: 0 10:10:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:10:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:10:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:10:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:10:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:10:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:41 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 0x7fb1242f8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x118d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x125c230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1256090>, '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 0x12599b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1259e40>, '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': '31acecf42b6a79ec49471d4a000001bb-1472058614.577174-1433154885', '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 10:10:41 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 10:10:41 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 10:10:41 INFO - Using env: {'DISPLAY': ':0', 10:10:41 INFO - 'HOME': '/home/cltbld', 10:10:41 INFO - 'LANG': 'en_US.UTF-8', 10:10:41 INFO - 'LANGUAGE': 'en_US:en', 10:10:41 INFO - 'LOGNAME': 'cltbld', 10:10:41 INFO - 'MAIL': '/var/mail/cltbld', 10:10:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:10:41 INFO - 'MOZ_NO_REMOTE': '1', 10:10:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:10:41 INFO - 'NO_EM_RESTART': '1', 10:10:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:10:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:10:41 INFO - 'PWD': '/builds/slave/test', 10:10:41 INFO - 'SHELL': '/bin/bash', 10:10:41 INFO - 'SHLVL': '1', 10:10:41 INFO - 'TERM': 'linux', 10:10:41 INFO - 'TMOUT': '86400', 10:10:41 INFO - 'USER': 'cltbld', 10:10:41 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1472058614.577174-1433154885', 10:10:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:10:41 INFO - '_': '/tools/buildbot/bin/python'} 10:10:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:10:41 INFO - Downloading/unpacking blobuploader==1.2.4 10:10:41 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 10:10:41 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 10:10:41 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 10:10:41 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 10:10:41 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 10:10:41 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 10:10:43 INFO - Downloading blobuploader-1.2.4.tar.gz 10:10:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:10:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:10:43 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 10:10:43 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 10:10:43 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 10:10:43 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 10:10:43 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 10:10:43 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 10:10:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:10:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:10:44 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 10:10:44 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 10:10:44 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 10:10:44 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 10:10:44 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 10:10:44 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 10:10:44 INFO - Downloading docopt-0.6.1.tar.gz 10:10:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:10:44 INFO - Installing collected packages: blobuploader, requests, docopt 10:10:44 INFO - Running setup.py install for blobuploader 10:10:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:10:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:10:44 INFO - Running setup.py install for requests 10:10:45 INFO - Running setup.py install for docopt 10:10:45 INFO - Successfully installed blobuploader requests docopt 10:10:45 INFO - Cleaning up... 10:10:45 INFO - Return code: 0 10:10:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:10:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:10:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:10:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:10:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:10:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:45 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 0x7fb1242f8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x118d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x125c230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1256090>, '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 0x12599b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1259e40>, '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': '31acecf42b6a79ec49471d4a000001bb-1472058614.577174-1433154885', '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 10:10:45 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 10:10:45 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 10:10:45 INFO - Using env: {'DISPLAY': ':0', 10:10:45 INFO - 'HOME': '/home/cltbld', 10:10:45 INFO - 'LANG': 'en_US.UTF-8', 10:10:45 INFO - 'LANGUAGE': 'en_US:en', 10:10:45 INFO - 'LOGNAME': 'cltbld', 10:10:45 INFO - 'MAIL': '/var/mail/cltbld', 10:10:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:10:45 INFO - 'MOZ_NO_REMOTE': '1', 10:10:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:10:45 INFO - 'NO_EM_RESTART': '1', 10:10:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:10:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:10:45 INFO - 'PWD': '/builds/slave/test', 10:10:45 INFO - 'SHELL': '/bin/bash', 10:10:45 INFO - 'SHLVL': '1', 10:10:45 INFO - 'TERM': 'linux', 10:10:45 INFO - 'TMOUT': '86400', 10:10:45 INFO - 'USER': 'cltbld', 10:10:45 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1472058614.577174-1433154885', 10:10:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:10:45 INFO - '_': '/tools/buildbot/bin/python'} 10:10:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:10:45 INFO - Running setup.py (path:/tmp/pip-zhqvLF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:10:45 INFO - Running setup.py (path:/tmp/pip-02APxX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:10:45 INFO - Running setup.py (path:/tmp/pip-5az7tg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:10:45 INFO - Running setup.py (path:/tmp/pip-dLKK0k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:10:45 INFO - Running setup.py (path:/tmp/pip-x6Z19v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:10:45 INFO - Running setup.py (path:/tmp/pip-AFdbqL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:10:45 INFO - Running setup.py (path:/tmp/pip-VUwh7P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:10:45 INFO - Running setup.py (path:/tmp/pip-7n3Bkc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:10:46 INFO - Running setup.py (path:/tmp/pip-QJ5Ida-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:10:46 INFO - Running setup.py (path:/tmp/pip-j40mh6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:10:46 INFO - Running setup.py (path:/tmp/pip-_FhKGI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:10:46 INFO - Running setup.py (path:/tmp/pip-SW1hjD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:10:46 INFO - Running setup.py (path:/tmp/pip-5cy9FQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:10:46 INFO - Running setup.py (path:/tmp/pip-H087BS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:10:46 INFO - Running setup.py (path:/tmp/pip-Lj4Zht-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:10:46 INFO - Running setup.py (path:/tmp/pip-pFc8in-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:10:46 INFO - Running setup.py (path:/tmp/pip-TByn5_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:10:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:10:46 INFO - Running setup.py install for manifestparser 10:10:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:10:46 INFO - Running setup.py install for mozcrash 10:10:46 INFO - Running setup.py install for mozdebug 10:10:46 INFO - Running setup.py install for mozdevice 10:10:47 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:10:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:10:47 INFO - Running setup.py install for mozfile 10:10:47 INFO - Running setup.py install for mozhttpd 10:10:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:10:47 INFO - Running setup.py install for mozinfo 10:10:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:10:47 INFO - Running setup.py install for mozInstall 10:10:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:10:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:10:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:10:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:10:47 INFO - Running setup.py install for mozleak 10:10:47 INFO - Running setup.py install for mozlog 10:10:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:10:47 INFO - Running setup.py install for moznetwork 10:10:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:10:47 INFO - Running setup.py install for mozprocess 10:10:47 INFO - Running setup.py install for mozprofile 10:10:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:10:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:10:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:10:47 INFO - Running setup.py install for mozrunner 10:10:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:10:48 INFO - Running setup.py install for mozscreenshot 10:10:48 INFO - Running setup.py install for moztest 10:10:48 INFO - Running setup.py install for mozversion 10:10:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:10:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:10:48 INFO - Cleaning up... 10:10:48 INFO - Return code: 0 10:10:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:10:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:10:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:10:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:10:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:10:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:48 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 0x7fb1242f8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x118d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x125c230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1256090>, '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 0x12599b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1259e40>, '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': '31acecf42b6a79ec49471d4a000001bb-1472058614.577174-1433154885', '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 10:10:48 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 10:10:48 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 10:10:48 INFO - Using env: {'DISPLAY': ':0', 10:10:48 INFO - 'HOME': '/home/cltbld', 10:10:48 INFO - 'LANG': 'en_US.UTF-8', 10:10:48 INFO - 'LANGUAGE': 'en_US:en', 10:10:48 INFO - 'LOGNAME': 'cltbld', 10:10:48 INFO - 'MAIL': '/var/mail/cltbld', 10:10:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:10:48 INFO - 'MOZ_NO_REMOTE': '1', 10:10:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:10:48 INFO - 'NO_EM_RESTART': '1', 10:10:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:10:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:10:48 INFO - 'PWD': '/builds/slave/test', 10:10:48 INFO - 'SHELL': '/bin/bash', 10:10:48 INFO - 'SHLVL': '1', 10:10:48 INFO - 'TERM': 'linux', 10:10:48 INFO - 'TMOUT': '86400', 10:10:48 INFO - 'USER': 'cltbld', 10:10:48 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1472058614.577174-1433154885', 10:10:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:10:48 INFO - '_': '/tools/buildbot/bin/python'} 10:10:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:10:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:10:48 INFO - Running setup.py (path:/tmp/pip-Wol8Y2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:10:48 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)) 10:10:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:10:48 INFO - Running setup.py (path:/tmp/pip-msLHlO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:10:48 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)) 10:10:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:10:48 INFO - Running setup.py (path:/tmp/pip-H0XqMX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:10:48 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)) 10:10:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:10:48 INFO - Running setup.py (path:/tmp/pip-zpvtjh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:10:48 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)) 10:10:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:10:48 INFO - Running setup.py (path:/tmp/pip-ysn_fO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:10:49 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)) 10:10:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:10:49 INFO - Running setup.py (path:/tmp/pip-WcZtfx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:10:49 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)) 10:10:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:10:49 INFO - Running setup.py (path:/tmp/pip-JOdLyC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:10:49 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)) 10:10:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:10:49 INFO - Running setup.py (path:/tmp/pip-WyGyhM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:10:49 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)) 10:10:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:10:49 INFO - Running setup.py (path:/tmp/pip-Pqblg4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:10:49 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)) 10:10:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:10:49 INFO - Running setup.py (path:/tmp/pip-FcmaZ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:10:49 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)) 10:10:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:10:49 INFO - Running setup.py (path:/tmp/pip-5hrIUb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:10:49 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)) 10:10:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:10:49 INFO - Running setup.py (path:/tmp/pip-7xdCmP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:10:49 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)) 10:10:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:10:49 INFO - Running setup.py (path:/tmp/pip-1w_0Pa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:10:49 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)) 10:10:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:10:49 INFO - Running setup.py (path:/tmp/pip-s1pex7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:10:49 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)) 10:10:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:10:49 INFO - Running setup.py (path:/tmp/pip-xwTM8n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:10:49 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)) 10:10:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:10:49 INFO - Running setup.py (path:/tmp/pip-bh85tp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:10:49 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)) 10:10:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:10:49 INFO - Running setup.py (path:/tmp/pip-XQBcE1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:10:49 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)) 10:10:49 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)) 10:10:49 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)) 10:10:49 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)) 10:10:49 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)) 10:10:49 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)) 10:10:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:10:49 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 10:10:49 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 10:10:49 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 10:10:49 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 10:10:49 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 10:10:49 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 10:10:51 INFO - Downloading blessings-1.6.tar.gz 10:10:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:10:51 INFO - Installing collected packages: blessings 10:10:51 INFO - Running setup.py install for blessings 10:10:51 INFO - Successfully installed blessings 10:10:51 INFO - Cleaning up... 10:10:52 INFO - Return code: 0 10:10:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:10:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:10:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:10:52 INFO - Reading from file tmpfile_stdout 10:10:52 INFO - Current package versions: 10:10:52 INFO - argparse == 1.2.1 10:10:52 INFO - blessings == 1.6 10:10:52 INFO - blobuploader == 1.2.4 10:10:52 INFO - docopt == 0.6.1 10:10:52 INFO - functools32 == 3.2.3-2 10:10:52 INFO - jsonschema == 2.5.1 10:10:52 INFO - manifestparser == 1.1 10:10:52 INFO - mozInstall == 1.12 10:10:52 INFO - mozcrash == 0.17 10:10:52 INFO - mozdebug == 0.1 10:10:52 INFO - mozdevice == 0.48 10:10:52 INFO - mozfile == 1.2 10:10:52 INFO - mozhttpd == 0.7 10:10:52 INFO - mozinfo == 0.9 10:10:52 INFO - mozleak == 0.1 10:10:52 INFO - mozlog == 3.3 10:10:52 INFO - moznetwork == 0.27 10:10:52 INFO - mozprocess == 0.23 10:10:52 INFO - mozprofile == 0.28 10:10:52 INFO - mozrunner == 6.12 10:10:52 INFO - mozscreenshot == 0.1 10:10:52 INFO - mozsystemmonitor == 0.3 10:10:52 INFO - moztest == 0.7 10:10:52 INFO - mozversion == 1.4 10:10:52 INFO - psutil == 3.1.1 10:10:52 INFO - requests == 1.2.3 10:10:52 INFO - wsgiref == 0.1.2 10:10:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:10: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')]} 10:10:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:10:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10: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')]} 10:10:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:10:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:52 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 0x7fb1242f8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x118d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x125c230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1256090>, '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 0x12599b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1259e40>, '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': '31acecf42b6a79ec49471d4a000001bb-1472058614.577174-1433154885', '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 10:10:52 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 10:10:52 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 10:10:52 INFO - Using env: {'DISPLAY': ':0', 10:10:52 INFO - 'HOME': '/home/cltbld', 10:10:52 INFO - 'LANG': 'en_US.UTF-8', 10:10:52 INFO - 'LANGUAGE': 'en_US:en', 10:10:52 INFO - 'LOGNAME': 'cltbld', 10:10:52 INFO - 'MAIL': '/var/mail/cltbld', 10:10:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:10:52 INFO - 'MOZ_NO_REMOTE': '1', 10:10:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:10:52 INFO - 'NO_EM_RESTART': '1', 10:10:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:10:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:10:52 INFO - 'PWD': '/builds/slave/test', 10:10:52 INFO - 'SHELL': '/bin/bash', 10:10:52 INFO - 'SHLVL': '1', 10:10:52 INFO - 'TERM': 'linux', 10:10:52 INFO - 'TMOUT': '86400', 10:10:52 INFO - 'USER': 'cltbld', 10:10:52 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1472058614.577174-1433154885', 10:10:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:10:52 INFO - '_': '/tools/buildbot/bin/python'} 10:10:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:10:52 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)) 10:10:52 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)) 10:10:52 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)) 10:10:52 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)) 10:10:52 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)) 10:10:52 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)) 10:10:52 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)) 10:10:52 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)) 10:10:52 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)) 10:10:52 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)) 10:10:52 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)) 10:10:52 INFO - Cleaning up... 10:10:52 INFO - Return code: 0 10:10:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:10: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')]} 10:10:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:10:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10: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')]} 10:10:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:10:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb1242f8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x118d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x125c230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1256090>, '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 0x12599b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1259e40>, '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': '31acecf42b6a79ec49471d4a000001bb-1472058614.577174-1433154885', '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 10:10:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:10:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:10:52 INFO - Using env: {'DISPLAY': ':0', 10:10:52 INFO - 'HOME': '/home/cltbld', 10:10:52 INFO - 'LANG': 'en_US.UTF-8', 10:10:52 INFO - 'LANGUAGE': 'en_US:en', 10:10:52 INFO - 'LOGNAME': 'cltbld', 10:10:52 INFO - 'MAIL': '/var/mail/cltbld', 10:10:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:10:52 INFO - 'MOZ_NO_REMOTE': '1', 10:10:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:10:52 INFO - 'NO_EM_RESTART': '1', 10:10:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:10:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:10:52 INFO - 'PWD': '/builds/slave/test', 10:10:52 INFO - 'SHELL': '/bin/bash', 10:10:52 INFO - 'SHLVL': '1', 10:10:52 INFO - 'TERM': 'linux', 10:10:52 INFO - 'TMOUT': '86400', 10:10:52 INFO - 'USER': 'cltbld', 10:10:52 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1472058614.577174-1433154885', 10:10:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:10:52 INFO - '_': '/tools/buildbot/bin/python'} 10:10:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:10:52 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:10:52 INFO - Cleaning up... 10:10:52 INFO - Return code: 0 10:10:52 INFO - Running post-action listener: _resource_record_post_action 10:10:52 INFO - Running post-action listener: _start_resource_monitoring 10:10:52 INFO - Starting resource monitoring. 10:10:52 INFO - [mozharness: 2016-08-24 17:10:52.694546Z] Finished create-virtualenv step (success) 10:10:52 INFO - [mozharness: 2016-08-24 17:10:52.695043Z] Running install step. 10:10:52 INFO - Running pre-action listener: _resource_record_pre_action 10:10:52 INFO - Running main action method: install 10:10:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:10:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:10:52 INFO - Reading from file tmpfile_stdout 10:10:52 INFO - Detecting whether we're running mozinstall >=1.0... 10:10:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:10:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:10:52 INFO - Reading from file tmpfile_stdout 10:10:52 INFO - Output received: 10:10:52 INFO - Usage: mozinstall [options] installer 10:10:52 INFO - Options: 10:10:52 INFO - -h, --help show this help message and exit 10:10:52 INFO - -d DEST, --destination=DEST 10:10:52 INFO - Directory to install application into. [default: 10:10:52 INFO - "/builds/slave/test"] 10:10:52 INFO - --app=APP Application being installed. [default: firefox] 10:10:52 INFO - mkdir: /builds/slave/test/build/application 10:10:52 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'] 10:10:52 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 10:11:09 INFO - Reading from file tmpfile_stdout 10:11:09 INFO - Output received: 10:11:09 INFO - /builds/slave/test/build/application/firefox/firefox 10:11:09 INFO - Running post-action listener: _resource_record_post_action 10:11:09 INFO - [mozharness: 2016-08-24 17:11:09.050069Z] Finished install step (success) 10:11:09 INFO - [mozharness: 2016-08-24 17:11:09.050315Z] Running run-tests step. 10:11:09 INFO - Running pre-action listener: _resource_record_pre_action 10:11:09 INFO - Running main action method: run_tests 10:11:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:11:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:11:09 INFO - Python 2.7.3 10:11:09 INFO - Return code: 0 10:11:09 INFO - grabbing minidump binary from tooltool 10:11: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')]} 10:11:09 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 0x1256090>, '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 0x12599b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1259e40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:11:09 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 10:11:09 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 10:11:09 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 10:11:09 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:11:09 INFO - Return code: 0 10:11:09 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:11:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:11:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:11:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:11:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:11:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GMjyknKaSEuZeRN8SHkKyg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 10:11:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GMjyknKaSEuZeRN8SHkKyg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-014 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 10:11:09 INFO - Using env: {'DISPLAY': ':0', 10:11:09 INFO - 'HOME': '/home/cltbld', 10:11:09 INFO - 'LANG': 'en_US.UTF-8', 10:11:09 INFO - 'LANGUAGE': 'en_US:en', 10:11:09 INFO - 'LOGNAME': 'cltbld', 10:11:09 INFO - 'MAIL': '/var/mail/cltbld', 10:11:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:11:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:11:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:11:09 INFO - 'MOZ_NO_REMOTE': '1', 10:11:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:11:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:11:09 INFO - 'NO_EM_RESTART': '1', 10:11:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:11:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:11:09 INFO - 'PWD': '/builds/slave/test', 10:11:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:11:09 INFO - 'SHELL': '/bin/bash', 10:11:09 INFO - 'SHLVL': '1', 10:11:09 INFO - 'TERM': 'linux', 10:11:09 INFO - 'TMOUT': '86400', 10:11:09 INFO - 'USER': 'cltbld', 10:11:09 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1472058614.577174-1433154885', 10:11:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:11:09 INFO - '_': '/tools/buildbot/bin/python'} 10:11:09 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GMjyknKaSEuZeRN8SHkKyg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 10:11:09 INFO - mozversion application_buildid: 20160824091826 10:11:09 INFO - mozversion application_changeset: ff3d89bec675e5a8ceec87b60b9d121f7daa15fb 10:11:09 INFO - mozversion application_display_name: Nightly 10:11:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:11:09 INFO - mozversion application_name: Firefox 10:11:09 INFO - mozversion application_remotingname: firefox 10:11:09 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 10:11:09 INFO - mozversion application_vendor: Mozilla 10:11:09 INFO - mozversion application_version: 51.0a1 10:11:09 INFO - mozversion platform_buildid: 20160824091826 10:11:09 INFO - mozversion platform_changeset: ff3d89bec675e5a8ceec87b60b9d121f7daa15fb 10:11:09 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 10:11:09 INFO - mozversion platform_version: 51.0a1 10:11:09 INFO - using testdate: 1472058669 10:11:09 INFO - actual date: 1472058669 10:11:09 INFO - starting webserver on 'localhost:60707' 10:11:09 INFO - SUITE-START | Running 2 tests 10:11:09 INFO - TEST-START | dromaeo_css 10:11:09 INFO - operating with platform_type : linux_ 10:11:09 INFO - Initialising browser for dromaeo_css test... 10:11:09 INFO - TEST-INFO | started process 11596 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0LPVjz/profile http://localhost:60707/getInfo.html) 10:11:13 INFO - PROCESS | 11596 | __metrics Screen width/height:1600/1200 10:11:13 INFO - PROCESS | 11596 | colorDepth:24 10:11:13 INFO - PROCESS | 11596 | Browser inner width/height: 1024/697 10:11:13 INFO - PROCESS | 11596 | __metrics 10:11:14 INFO - PROCESS | 11596 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:11:14 INFO - PROCESS | 11596 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:11:14 INFO - PROCESS | 11596 | console.error: PushService: 10:11:14 INFO - PROCESS | 11596 | stateChangeProcessEnqueue: Error transitioning state 10:11:14 INFO - PROCESS | 11596 | UnknownError 10:11:15 INFO - TEST-INFO | 11596: exit 0 10:11:15 INFO - Browser initialized. 10:11:15 INFO - Running cycle 1/1 for dromaeo_css test... 10:11:15 INFO - TEST-INFO | started process 11676 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0LPVjz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:11:27 INFO - PROCESS | 11676 | RSS: Main: 181813248 10:11:27 INFO - PROCESS | 11676 | 10:12:19 INFO - PROCESS | 11676 | 1472058739545 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] 10:14:31 INFO - PROCESS | 11676 | Cycle 1(1): loaded http://localhost:60707/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60707/tests/dromaeo/cssquery-ext.html) 10:14:32 INFO - PROCESS | 11676 | RSS: Main: 265084928 10:14:32 INFO - PROCESS | 11676 | 10:17:35 INFO - PROCESS | 11676 | Cycle 1(1): loaded http://localhost:60707/tests/dromaeo/cssquery-ext.html (next: http://localhost:60707/tests/dromaeo/cssquery-jquery.html) 10:17:36 INFO - PROCESS | 11676 | RSS: Main: 272351232 10:17:36 INFO - PROCESS | 11676 | 10:20:38 INFO - PROCESS | 11676 | Cycle 1(1): loaded http://localhost:60707/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60707/tests/dromaeo/cssquery-mootools.html) 10:20:38 INFO - PROCESS | 11676 | RSS: Main: 253976576 10:20:38 INFO - PROCESS | 11676 | 10:23:41 INFO - PROCESS | 11676 | Cycle 1(1): loaded http://localhost:60707/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60707/tests/dromaeo/cssquery-prototype.html) 10:23:41 INFO - PROCESS | 11676 | RSS: Main: 225955840 10:23:41 INFO - PROCESS | 11676 | 10:26:44 INFO - PROCESS | 11676 | Cycle 1(1): loaded http://localhost:60707/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60707/tests/dromaeo/cssquery-yui.html) 10:26:45 INFO - PROCESS | 11676 | RSS: Main: 218898432 10:26:45 INFO - PROCESS | 11676 | 10:29:48 INFO - PROCESS | 11676 | Cycle 1(1): loaded http://localhost:60707/tests/dromaeo/cssquery-yui.html (next: http://localhost:60707/tests/dromaeo/cssquery-dojo.html) 10:29:48 INFO - PROCESS | 11676 | RSS: Main: 286068736 10:29:48 INFO - PROCESS | 11676 | 10:29:48 INFO - PROCESS | 11676 | __start_tp_report 10:29:48 INFO - PROCESS | 11676 | _x_x_mozilla_page_load 10:29:48 INFO - PROCESS | 11676 | _x_x_mozilla_page_load_details 10:29:48 INFO - PROCESS | 11676 | |i|pagename|runs| 10:29:48 INFO - PROCESS | 11676 | |0;dojo.html;2581.0205732094605;2592.2482480080776;2598.519273934321;2632.512985097757;2654.3629528913057;4535.319702044695;4586.266197408415;4594.081183763253;4653.162430762462;4703.435587729473;4665.9066818663605;4679.461861885884;4729.030548737509;4734.502877197896;4740.288956656504;4243.957560424387;4274.187904298174;4321.2653848845775;4387.056782791699;4445.288753799393;4339.739615623057;4384.846530371437;4399.274119770234;4418.3593378960195;4425.645948324142;4185.832566697329;4242.3212286034395;4245.3844192591905;4275.893102672458;4300;4269.658427325807;4287.978560107211;4358.455193100863;4374.759388233646;4426.756528390937;4232.830686772525;4243.787810609488;4250.107477429743;4302.5052119006405;4347;4651.813927442899;4708;4708.411448568929;4711.222648263032;4763.618910487153;4856.68431551948;4951.480094590052;4983.377077865267;5004.249362595603;5023.397192336906;5029.346184995927;5041.294218809369;5053.242013697938;5053.722045287508;5057.897914078599;4671.85984420468;4706.552877476634;4706.905861882811;4727.976360118178;4766.904661906742;4921.729304888266;5059.696418214845;5125.769340379692;5134.768935397916;5204.141316682781;4910.779014944336;4938.037082768898;4938.530839570235;4940.530649588283;5001.049800537886;5016.297718319438;5018.548330650259;5026.396832380138;5027.597792176617;5030.798768049311;4758.976205119022;4833.975830120827;4839.95160048395;4900.901981960341;4971.825986090469;4901.901961960741;4908.607311415079;4916.508349165055;4916.557509824133;4957.405111386584;4203.432536607519;4203.600657937553;4208.726432781859;4221.176870510221;4265;3651.3062518121474;3654.744167908221;3656.6160553142067;3681.9079523012138;3724.385476396364;4201.096764195712;4206.41110244566;4244.278472659594;4244.787760611957;4252.829886804555;4909.239067944474;4951.72765497901;4954.256861470808;4959.2809042688605;4980.078685443204;4154.210699966997;4194.49666040071;4229.746215227096;4230.344296634026;4272.7222730523035;4460.799264033127;4480.238359478896;4535.682502224879;4537.705049171794;4540.8637740867825;4687.578117969331;4694.084653492673;4694.906101878011;4695.716945996208;4759.476457589732;4889.559939605452;4916.729579873141;4957.256411538298;4966.701997880139;5025.522575355335;4663.673542851968;4689.695169813951;4764.452088009784;4765.904681906273;4787.784549695202;4948.257761335828;4953.380827396575;4956.975215123901;4976.601871850316;5044.041632090038;5022.547970682656;5036.84889453317;5036.874078148076;5036.974815125901;5105.055564720538;4766.952330476651;4776.546228108324;4811.254255590389;4829.13075646387;4903.313536104877;4816.181249187576;4818.132736107535;4828.179209534458;4833.734144621939;4881.9511804881495;4745.857624271277;4752;4757.976210118927;4768.332433459388;4820.4456487504385;4769.73766442849;4889.095517329305;4902.2156454967035;4936.777844996912;5021.874453138701;4830.903381932412;4855.393075865517;4859.611231101574;4860;4915.164422048332 10:29:48 INFO - PROCESS | 11676 | |1;ext.html;555.097965805566;567.9521283232434;577.0882006429841;589.5813972079823;590.18554394935;26825.4634907302;29152;29232;29324.413511729752;29354.559681604766;30532.389352213;38957.610423895756;40132.59867401325;40310;43830.780846095804;7672.961635191817;7769.456138070337;7789.4157938154585;7795.883061754078;7812.570308633023;7723.61381930904;7801.921980780205;7815.491993020435;7821.335186509154;7827.530348179127;7531.209223031585;7709.537427754324;7714.6914123435;7869.645865936047;10106.747331316703;10070.647527336545;10149.086582207638;10152.949235253776;10155.644552440703;10168.135708464752;9907.157891579225;9976.850347244725;9982.25133115012;10000.449975251358;10002.399856008662;37014.629853701386;37783.81108094442;37791.43312850309;37825.810870945745;37845.62154378476;2741.163944996775;2862.9856850715614;2932.135020169055;2940.882364705409;2943.6173297471405;27641.308967275778;27819.86090069557;27830.860845695843;27839.582406263922;28299.292517687223;3059.5869557609662;3077.538369244609;3108.5492603572357;3118.469860123784;3124.656287808339;241542;241959;242261;242653;243257;50932.49067509278;51256.77378071983;51300;51303;51402;31892.84053579717;32785.67214327874;32962;34959.825200873835;35012;12268.32524211177;12572.4342404592;12573.497060117494;12585.748285034248;12599.559015434415;9976.900230997597;10069.949650251701;10077.244206684529;10103.7474063149;10197.235207359477;16958.576035598962;17099.829001710073;17182.828171718375;17255.74116388255;17291.567710807078;5451.918221226685;6764.4926630502905;6811.693473793691;6956.930430695729;7046.260142684944;844.1010324005038;860.1484530315068;866.9046404895456;877.2455688108222;983.5180761426849;26342.341441464116;27766;28334.433311333658;28642.427151456854;28691.139265822057;953.1707414549386;964.1274646444979;1009.8333774927202;1027.3219675014454;1035.297872552637;13842.446302148002;14837.255107805091;14977.850221497863;15245.847541524443;15302.540923772305;352412;354415;354811;355136;357432;47835.28247076297;48020.03959920782;48611.51388486141;48668.513314866395;48713.756431218324;1083.5774048121239;1109.5062697099875;1125.471028616549;1127.7462570921641;1154.8671902731126;24896;28374.432511349245;29265.41469170647;29582.852085739432;29690.70309296966;41775.37336940009;42559.5744042568;42562.36156457718;42599.7870010648;42677.35983960305;334505;338475;339753;339789;340325;37725.245495090494;37948.24103517969;38996;40218.59781402149;40389.39415908705;40285.798571006955;40449.595504044584;40668.79665601653;41698.58301416947;41799.164016720104;35151.82424087863;35352.64647353494;35464.46803298004;35622.64377356193;35799.46300805438;34913.47629785606;35058.474122888685;35452.82273588719;35683.643163568035;35690;34378.82810585931;34756.47865282073;35083.29833403369;35245.64754352424;35572.64427355797;28912.710872891843;31036.68963310338;31122.066338009896;31158.68841311558;31281.369353516584;24051;24652.630210547213;24723.25830225096;24817.25548233556;25045.74954250507 10:29:48 INFO - PROCESS | 11676 | |2;jquery.html;345.57666858098816;365.40256680327656;366.82759103221485;374.3561074951083;388.50077650219475;12723.1729937554;16055.518334449956;16118.83881161188;17121;17227.91386043068;16092.517224483285;16318.102504362256;16779.916100419512;16959.32162713493;16973.660526789456;4884.242942343943;4901.019796040806;5037.823676171335;5062.240663900426;5069.797208111671;3723.515942927416;4964.652474326798;5043.445221025684;5100.056489549426;5655.688937108457;5927.792527261547;6030.8793824123495;6040;6043.909341359883;6047.606905551125;5811.1283307504;5898.852528686774;5909.37951515089;5922.4077592240865;6037.064255040454;5196.636235463519;5207.6354655174155;5212.244224587452;5213.661112027706;5239.371275446971;19944.800551994438;20884.582308353747;21059.894700526398;21111.47221319464;21317.253896113718;1865.8320751132462;1887;1943.37811900192;2186.387811412807;2268.739095004079;13092.607221783363;13216.207027578375;13351.666208344772;13467.461301547926;13957.58127256184;1764.0209683625583;1764.3383731100837;1767.3460819496868;1785.5536115971008;1822.8997405142711;42637;48803.096228274444;60839.39160608382;66079;71489.2851071493;9623.951880240555;9747.756306092404;9906.801863962824;10023.649172278936;10083.621986634413;13521.86478135206;13621.795673064911;13625.523106691218;13625.659358516117;13632.93183534076;6932.757353492603;7109.751158709524;7142.535735177197;7242.565446073147;7374.852502949911;6635.8009259722285;6759.932400675931;6839.487038472134;6852.177738671391;6908.585484870924;6078;6152.292486364126;6171.475424588871;6192.721327540272;6297.118403423525;1749.2390809997692;1763.3387479695114;1812.8277813607685;1814.5372929903053;1823.8632102592358;381.3517021064202;382.5027464296459;402.72815849301605;658.2791842931982;886.2688282167238;10563.47182640865;10600.151987840954;10827.404492752818;10853.837192442119;11190.32858028521;396.4251834839494;400.71549200067693;415.0226217258373;415.71731222768807;435.6188335206694;5419.620626556103;5720.313562372458;5750.1949727038245;5949.702514874239;5955.851103722355;404900;405403;407420;421468;422319;78629.60685196538;79052;79700.20299797044;80634.59682701548;81760.18239817525;428.1971303805365;438.8222769778245;439.5231174176055;439.6988063176734;440.74436826641113;8531.8720219198;10061.647842325483;10207.285490015925;10352.637657681946;10479.580816767244;38766;39002.414963775;39041;39234.803825980685;39987;48534.514654853;48823.267650984555;49060.75469622629;49495.25757113718;49881.75059124681;6761.763338283136;7054.118235220598;7146.749863754743;7558.206388329147;7927.920720792718;10980.670579882617;11917.82123268169;12295.69260768488;12444.626661200178;12520.937395312965;9831.606735730491;9904.801903962025;9966.202703783825;10558.31370960885;10964;5976.850578735566;10811.6215932442;10854.945725271324;10946.507407166855;10998.175136864607;10131.898681013095;10459.581616735246;10658.89341106579;10665.306755060896;11263.155263355446;7063.434925205868;7125.786226413215;7237.565746055254;7340.045794046953;7533.472656913963;10030.849537257092;10108.342957707726;10186.439745813756;10390.168786496912;10783.622573210214 10:29:48 INFO - PROCESS | 11676 | |3;mootools.html;1256.956006539771;1288.433089440646;1300.1678925487686;1544.2973447081579;1556.8053993250837;6726.394624483795;6986.091808064944;7319.9268007319915;7862.646180921858;7883.408744344169;7295.379892709113;7581.658825352859;7585.7344992925255;7766.61166941652;7771.68913243471;2160.503084290614;2189.7481789594162;2194.9122035118576;2195;2197.088208393515;1852.4627857921187;2064.205280966831;2107.546877421354;2133.807957283844;2156.5363446858923;2165.0149182122177;2183.170395249811;2187.278198194592;2190.167736260219;2190.58378908007;2134.9679754803615;2148.871067735933;2175.19517778423;2175.2495389090736;2175.380016695234;2121.3847984084596;2123.458518077896;2124.8193903518218;2128.17001369466;2158.946026349338;7915.327197188246;7972.441929064909;7975.322097621709;7976.122626511079;7982.401319901031;4403.493598236179;4481.08137831747;4532.229520981441;4536.500984891659;4540.387047748544;2756.3935934094466;2842.04791394883;2883.639545056868;2891.3928075104254;2894.3777087925987;872.8865247517846;888.338188049907;902.0483390023522;928.4058202750246;931.0642803982023;10443.895561044368;10454.738631534197;10463.162946964301;10466.319689220176;10475.214358923111;3830.367989281737;3981;4036.091879327128;4099.159672267178;4109.56849530795;8980.820383592292;8981.775455613662;8990.056044115405;8994.05562415937;9005.14451127142;4593.609543188866;4594.517575654575;4594.816207351669;4595.425571803525;4596.517365676623;4144.088300573869;4183.100633363842;4191.706580539394;4192.329227323614;4192.329227323614;3545.308664810389;3561.3411518869093;3566.607673156003;3580.606133325332;3596.7841929484316;1037.678319720889;1119.5557730527692;1121.814900541418;1144.3305666185208;1177.2936238256978;738.8042168825266;756.9243075692386;800.8918795962587;806.6047636658112;826.09955148888;4987.900241995212;5026.572741317029;5062.620303477254;5080.49195080489;5280.947190528045;836.8912041434696;853.1298075962608;871.7994861181963;895.4761464543316;917.2707697380465;3311.1887587541205;3377.1725927147513;3457.4640930655787;3486.0239133042787;3540.256546125291;8630.136986301319;9232.353735238603;9284.071592840663;9288.674896378594;9295.070492950787;9216.354855160209;9223.985361610217;9231.861522077174;9234.076592340713;9239.676611318571;6605.174353205849;6895;7169.139703235541;7169.820754481076;7173.89239161413;5096.413912400121;5123.948760512347;5149.897002059863;5312;5391.649542779707;8768.517731524573;8809.295256379603;8813.338999575186;8826.338024648048;8903.777405564913;8717.433366831136;8748.300135989233;8883.33374996865;8906.688265910921;9013.819723605622;6312.242530896322;6561.1470508833545;6675.833104172434;6702.798916032527;6704.83237919056;7636.236376362319;7690.9230907692445;7691.57696326685;7694.615269236628;7700.537967721954;6549.31232220629;6796.320367963164;6838.213605435439;6845.349691779273;7072.08062951813;6460.8707825842275;6669.666516674244;6716.529842911144;6770.593764373956;6932.826679333057;6145.201123853871;6232.8130156095385;6239.844003899939;6248.312685604489;6262.15460912771;4577.382053422745;4654.976725116353;4711.552402521755;4722.693024953367;4755.144074066563;4540.524329592829;4546.863594092182;4601.608863246528;4688.367070445446;4746.169420351355 10:29:48 INFO - PROCESS | 11676 | |4;prototype.html;293.5523326926438;299.25784055542255;304.25154120862675;306.5126448946175;309.9504079347305;4564.612007979317;4683.672142949987;4712.340272361872;4751.3348131261655;4752.168370535155;4465.17394282058;4613.039458230255;4632.3283123947;4633.49031606523;4671.602913752336;3718.9070273243115;3723.888283351504;3731.794751288678;3740.775553466794;3759.360908645523;3547.8935631931085;3605.4591811228265;3739.383001804699;3751.9062023449496;3775.924481510368;3691.667749902508;3704.073981504624;3704.6848368829083;3713.294474049922;3724.906877328075;3707.536557930259;3710.9052829415386;3717.7955212463303;3721.8697345593046;3755.1363186466992;3316.535685004101;3317.651646577123;3326.6839650233187;3332.7500437467043;3337.8998630041137;4490.281554951225;4556.835503136017;4588.954110458886;4617.769111544443;4622.6070783983405;4237.576242375769;4238.7880605969885;4245.172191422674;4248.256555102845;4254.255505286563;4893.510648935114;4901.142300097505;4910.986495536813;4936.136176169156;4937.185364414867;3483.7387195960405;3606.9098272543133;3638.108663377463;3644.125409901631;3652.8493524539685;5100.234964755279;5102.438731739506;5105.208692652608;5112.437631860493;5114.923276150824;3687.9262414751556;3693.9630603693618;3710.9072273192846;3729.6083911188935;3734;3770.8680196193;3783.4135708965155;3787.6401741834484;3799.848006079781;3802.1065049713297;4006.959930400659;4162.604552567501;4166.66666666666;4203.243416185116;4250.4899412070135;4889.877753056202;4890.388701412324;4891.850415152508;4894.2169252920075;4909.828156014522;1204.8253003314471;1243.359669770069;1243.5212443209248;1260.3194275091532;1266.2276011632896;857.562643052048;858.8668756342777;877.9604917778715;882.250087425683;883.2757139145967;4288.078063216361;4292.356146577976;4295.548967358445;4296.140771845581;4306.41863348444;4965.32968049316;4980.232017633761;4987.608426270099;5019.47295533971;5049.899002020013;4297.957020429818;4310.4611923509565;4311.245532031882;4322.502912165141;4341.45731783527;2353.8352315338107;2572.2797616667362;2668.6389941130165;2686.395560998799;2699.1767510908967;4775.6657034007985;4788.209945359046;4792.808287668524;4818.903621927542;4837.661363704507;5191.454897235812;5196.376434827769;5229;5244.763985620656;5248.6588371755715;4630.259158534618;4823.252395878644;4830.178869592108;4843.660943733905;4856.660033797671;5093.108705976513;5095.643304968617;5098.566621837037;5109.233614957638;5127.743612819419;5014.373203349582;5046.6719663221775;5055.191169412877;5055.6713813602;5066.164082926276;4609.815607375667;4817.975910120427;4877.317175595348;4890.486498917562;4898.510148985073;3655;3678.834452449593;3688.502052223023;3697.2975134724315;3707.1473561081643;4968.552830245295;5185.7407129644125;5196.32447781786;5204.34945631796;5208.557272631717;4780.354652122058;4937.654364194472;4941.65408421407;4944.898418172191;4972.254161875748;4895.227153525284;4925.950740492549;4932.82735104284;4944.75276236194;4982.950170498249;4611.3544103824825;4865.537773911473;4873.1471992400475;4878.609711223165;4920.827771027997;4934.18585933317;4954.628402869727;4979.850604481871;4985.252212168204;4988.80044798204;4871.147549178809;4882.584980276574;4920.138975679313;4958.181899986462;4961.330220420197 10:29:48 INFO - PROCESS | 11676 | |5;yui.html;575.7466714645556;618.1099217127339;649.1528555235421;665.7303791964255;682.2461180395662;12590.622281331563;13293.401796919137;13579.388927498261;13592.3203839808;14336.283185840719;12900.290484023375;12946.546870859522;12991.870081299185;12996.93501532491;13024.348782560857;745.5452174173749;764.8890910817928;770.0912922751152;770.2720928722359;770.4953255617579;608.0878681977034;723.724984505887;760.6196901549225;762.230147550972;768.7002069193019;796.8087658961837;797.8204903896606;798.3892322373389;799.0411506192563;799.4803377804416;791.2720297326473;792.8572856885759;793.1949071692237;793.4326956226325;793.4525177627419;471.2436539354321;555.7221389305347;577.8844231153744;578.3984655957798;581.1399129288676;12857.485700571966;12906.870931290754;12967.935160324138;13034.348282585928;13182.934085329607;12425.254484730945;13123.803142952864;13362.933185334012;13574.45702171912;13686.863131368658;11747.118966077578;11895.345755983417;12002;12256;12417;4096.221717873625;4129.256733787917;4146.688998325138;4303.677224208165;4303.924018995252;65345.673271633335;66625.33374666239;66701.66649166771;66831;67792;9726.221902247804;9912.454814985102;9945;9957.103860652576;10054.145397641136;18330;18340.908295458703;18369.908150459163;18391.356302529348;18413.447596572125;6728.6635668216395;6737.52837301394;6798.827376478801;6820.795376138723;6938.722451102;3672.6510981456718;3708.332500149999;3710.981445092811;3712.9071773205887;3762.492063571383;2873.9712602873706;2971.5097008993275;2971.985140074329;2975.2413134650524;2976.122043997026;488.64573184440997;488.872893047803;492.1363007921147;495.2942057567951;537.3551737914519;471.4319245309394;494.9059678661115;521.3092652235803;554.354177383352;557.7378632042934;7680.270374314431;8087.1912808719835;8265.256126948603;8281.792955176168;8301.211384918422;489.4591476418506;494.6240856948745;525.2488940814671;537.4517991648497;607.7903123422412;3517.542719446507;3778.3576791945434;3861.362875125629;3894.3963685628773;4003.2193722223888;105617;108120;109882;110420.44789776;113904;88752;91385.54307228421;92848.53575732079;93959;94000.52999734957;77517.22482775213;78672;78871;79095;79602.43776841191;7125.3524993135525;7400.740974065882;7682.116556596063;7685.077790665156;7691.500052496794;47202;47881;48066.16370842966;48455.75772121117;48704.51295487142;54287.45712542824;68403.3159668397;69479;69665.65167174132;72873.27126728665;9323.72028839136;9810.558524866256;9944.254180936603;10101.44442055694;10161.441120738134;9480.194183494481;9820.518810483696;10301;11593.24643898144;12679.746405072032;11131.833022504507;11239;11255.943720281673;11449.713757155805;11602;9926.354786938826;10110.19118470506;10870.728231794268;10999.065079468015;11011.28426652265;10535.683929482127;10635.89364106349;10861.891381086089;11287.774244515227;11426.143039272254;9274.95362523183;9895.158911492605;10235.846462302923;10381.532831022772;10751.892481075089;9359.719208423758;9465.384749991228;9585.616575337188;9647.761908800283;9925.900740992498 10:29:48 INFO - PROCESS | 11676 | __end_tp_report 10:29:48 INFO - PROCESS | 11676 | __start_cc_report 10:29:48 INFO - PROCESS | 11676 | _x_x_mozilla_cycle_collect,1072 10:29:48 INFO - PROCESS | 11676 | __end_cc_report 10:29:48 INFO - PROCESS | 11676 | __startTimestamp1472059788803__endTimestamp 10:29:48 INFO - PROCESS | 11676 | 10:29:48 INFO - PROCESS | 11676 | ------- Summary: start ------- 10:29:48 INFO - PROCESS | 11676 | Number of tests: 6 10:29:48 INFO - PROCESS | 11676 | 10:29:48 INFO - PROCESS | 11676 | [#0] dojo.html Cycles:165 Average:4612.61 Median:4758.98 stddev:484.58 (10.2%) stddev-sans-first:459.11 10:29:48 INFO - PROCESS | 11676 | Values: 2581.0 2592.2 2598.5 2632.5 2654.4 4535.3 4586.3 4594.1 4653.2 4703.4 4665.9 4679.5 4729.0 4734.5 4740.3 4244.0 4274.2 4321.3 4387.1 4445.3 4339.7 4384.8 4399.3 4418.4 4425.6 4185.8 4242.3 4245.4 4275.9 4300.0 4269.7 4288.0 4358.5 4374.8 4426.8 4232.8 4243.8 4250.1 4302.5 4347.0 4651.8 4708.0 4708.4 4711.2 4763.6 4856.7 4951.5 4983.4 5004.2 5023.4 5029.3 5041.3 5053.2 5053.7 5057.9 4671.9 4706.6 4706.9 4728.0 4766.9 4921.7 5059.7 5125.8 5134.8 5204.1 4910.8 4938.0 4938.5 4940.5 5001.0 5016.3 5018.5 5026.4 5027.6 5030.8 4759.0 4834.0 4840.0 4900.9 4971.8 4901.9 4908.6 4916.5 4916.6 4957.4 4203.4 4203.6 4208.7 4221.2 4265.0 3651.3 3654.7 3656.6 3681.9 3724.4 4201.1 4206.4 4244.3 4244.8 4252.8 4909.2 4951.7 4954.3 4959.3 4980.1 4154.2 4194.5 4229.7 4230.3 4272.7 4460.8 4480.2 4535.7 4537.7 4540.9 4687.6 4694.1 4694.9 4695.7 4759.5 4889.6 4916.7 4957.3 4966.7 5025.5 4663.7 4689.7 4764.5 4765.9 4787.8 4948.3 4953.4 4957.0 4976.6 5044.0 5022.5 5036.8 5036.9 5037.0 5105.1 4767.0 4776.5 4811.3 4829.1 4903.3 4816.2 4818.1 4828.2 4833.7 4882.0 4745.9 4752.0 4758.0 4768.3 4820.4 4769.7 4889.1 4902.2 4936.8 5021.9 4830.9 4855.4 4859.6 4860.0 4915.2 10:29:48 INFO - PROCESS | 11676 | 10:29:48 INFO - PROCESS | 11676 | [#1] ext.html Cycles:180 Average:46016.01 Median:34834.98 stddev:83028.54 (238.3%) stddev-sans-first:83191.30 10:29:48 INFO - PROCESS | 11676 | Values: 555.1 568.0 577.1 589.6 590.2 26825.5 29152.0 29232.0 29324.4 29354.6 30532.4 38957.6 40132.6 40310.0 43830.8 7673.0 7769.5 7789.4 7795.9 7812.6 7723.6 7801.9 7815.5 7821.3 7827.5 7531.2 7709.5 7714.7 7869.6 10106.7 10070.6 10149.1 10152.9 10155.6 10168.1 9907.2 9976.9 9982.3 10000.4 10002.4 37014.6 37783.8 37791.4 37825.8 37845.6 2741.2 2863.0 2932.1 2940.9 2943.6 27641.3 27819.9 27830.9 27839.6 28299.3 3059.6 3077.5 3108.5 3118.5 3124.7 241542.0 241959.0 242261.0 242653.0 243257.0 50932.5 51256.8 51300.0 51303.0 51402.0 31892.8 32785.7 32962.0 34959.8 35012.0 12268.3 12572.4 12573.5 12585.7 12599.6 9976.9 10069.9 10077.2 10103.7 10197.2 16958.6 17099.8 17182.8 17255.7 17291.6 5451.9 6764.5 6811.7 6956.9 7046.3 844.1 860.1 866.9 877.2 983.5 26342.3 27766.0 28334.4 28642.4 28691.1 953.2 964.1 1009.8 1027.3 1035.3 13842.4 14837.3 14977.9 15245.8 15302.5 352412.0 354415.0 354811.0 355136.0 357432.0 47835.3 48020.0 48611.5 48668.5 48713.8 1083.6 1109.5 1125.5 1127.7 1154.9 24896.0 28374.4 29265.4 29582.9 29690.7 41775.4 42559.6 42562.4 42599.8 42677.4 334505.0 338475.0 339753.0 339789.0 340325.0 37725.2 37948.2 38996.0 40218.6 40389.4 40285.8 40449.6 40668.8 41698.6 41799.2 35151.8 35352.6 35464.5 35622.6 35799.5 34913.5 35058.5 35452.8 35683.6 35690.0 34378.8 34756.5 35083.3 35245.6 35572.6 28912.7 31036.7 31122.1 31158.7 31281.4 24051.0 24652.6 24723.3 24817.3 25045.7 10:29:48 INFO - PROCESS | 11676 | 10:29:48 INFO - PROCESS | 11676 | [#2] jquery.html Cycles:180 Average:24376.14 Median:203917.51 stddev:67917.64 (33.3%) stddev-sans-first:68084.20 10:29:48 INFO - PROCESS | 11676 | Values: 345.6 365.4 366.8 374.4 388.5 12723.2 16055.5 16118.8 17121.0 17227.9 16092.5 16318.1 16779.9 16959.3 16973.7 4884.2 4901.0 5037.8 5062.2 5069.8 3723.5 4964.7 5043.4 5100.1 5655.7 5927.8 6030.9 6040.0 6043.9 6047.6 5811.1 5898.9 5909.4 5922.4 6037.1 5196.6 5207.6 5212.2 5213.7 5239.4 19944.8 20884.6 21059.9 21111.5 21317.3 1865.8 1887.0 1943.4 2186.4 2268.7 13092.6 13216.2 13351.7 13467.5 13957.6 1764.0 1764.3 1767.3 1785.6 1822.9 42637.0 48803.1 60839.4 66079.0 71489.3 9624.0 9747.8 9906.8 10023.6 10083.6 13521.9 13621.8 13625.5 13625.7 13632.9 6932.8 7109.8 7142.5 7242.6 7374.9 6635.8 6759.9 6839.5 6852.2 6908.6 6078.0 6152.3 6171.5 6192.7 6297.1 1749.2 1763.3 1812.8 1814.5 1823.9 381.4 382.5 402.7 658.3 886.3 10563.5 10600.2 10827.4 10853.8 11190.3 396.4 400.7 415.0 415.7 435.6 5419.6 5720.3 5750.2 5949.7 5955.9 404900.0 405403.0 407420.0 421468.0 422319.0 78629.6 79052.0 79700.2 80634.6 81760.2 428.2 438.8 439.5 439.7 440.7 8531.9 10061.6 10207.3 10352.6 10479.6 38766.0 39002.4 39041.0 39234.8 39987.0 48534.5 48823.3 49060.8 49495.3 49881.8 6761.8 7054.1 7146.7 7558.2 7927.9 10980.7 11917.8 12295.7 12444.6 12520.9 9831.6 9904.8 9966.2 10558.3 10964.0 5976.9 10811.6 10854.9 10946.5 10998.2 10131.9 10459.6 10658.9 10665.3 11263.2 7063.4 7125.8 7237.6 7340.0 7533.5 10030.8 10108.3 10186.4 10390.2 10783.6 10:29:48 INFO - PROCESS | 11676 | 10:29:48 INFO - PROCESS | 11676 | [#3] mootools.html Cycles:180 Average:5055.96 Median:5136.92 stddev:2822.29 (54.9%) stddev-sans-first:2815.77 10:29:48 INFO - PROCESS | 11676 | Values: 1257.0 1288.4 1300.2 1544.3 1556.8 6726.4 6986.1 7319.9 7862.6 7883.4 7295.4 7581.7 7585.7 7766.6 7771.7 2160.5 2189.7 2194.9 2195.0 2197.1 1852.5 2064.2 2107.5 2133.8 2156.5 2165.0 2183.2 2187.3 2190.2 2190.6 2135.0 2148.9 2175.2 2175.2 2175.4 2121.4 2123.5 2124.8 2128.2 2158.9 7915.3 7972.4 7975.3 7976.1 7982.4 4403.5 4481.1 4532.2 4536.5 4540.4 2756.4 2842.0 2883.6 2891.4 2894.4 872.9 888.3 902.0 928.4 931.1 10443.9 10454.7 10463.2 10466.3 10475.2 3830.4 3981.0 4036.1 4099.2 4109.6 8980.8 8981.8 8990.1 8994.1 9005.1 4593.6 4594.5 4594.8 4595.4 4596.5 4144.1 4183.1 4191.7 4192.3 4192.3 3545.3 3561.3 3566.6 3580.6 3596.8 1037.7 1119.6 1121.8 1144.3 1177.3 738.8 756.9 800.9 806.6 826.1 4987.9 5026.6 5062.6 5080.5 5280.9 836.9 853.1 871.8 895.5 917.3 3311.2 3377.2 3457.5 3486.0 3540.3 8630.1 9232.4 9284.1 9288.7 9295.1 9216.4 9224.0 9231.9 9234.1 9239.7 6605.2 6895.0 7169.1 7169.8 7173.9 5096.4 5123.9 5149.9 5312.0 5391.6 8768.5 8809.3 8813.3 8826.3 8903.8 8717.4 8748.3 8883.3 8906.7 9013.8 6312.2 6561.1 6675.8 6702.8 6704.8 7636.2 7690.9 7691.6 7694.6 7700.5 6549.3 6796.3 6838.2 6845.3 7072.1 6460.9 6669.7 6716.5 6770.6 6932.8 6145.2 6232.8 6239.8 6248.3 6262.2 4577.4 4655.0 4711.6 4722.7 4755.1 4540.5 4546.9 4601.6 4688.4 4746.2 10:29:48 INFO - PROCESS | 11676 | 10:29:48 INFO - PROCESS | 11676 | [#4] prototype.html Cycles:180 Average:4119.45 Median:4631.29 stddev:1186.14 (25.6%) stddev-sans-first:1154.18 10:29:48 INFO - PROCESS | 11676 | Values: 293.6 299.3 304.3 306.5 310.0 4564.6 4683.7 4712.3 4751.3 4752.2 4465.2 4613.0 4632.3 4633.5 4671.6 3718.9 3723.9 3731.8 3740.8 3759.4 3547.9 3605.5 3739.4 3751.9 3775.9 3691.7 3704.1 3704.7 3713.3 3724.9 3707.5 3710.9 3717.8 3721.9 3755.1 3316.5 3317.7 3326.7 3332.8 3337.9 4490.3 4556.8 4589.0 4617.8 4622.6 4237.6 4238.8 4245.2 4248.3 4254.3 4893.5 4901.1 4911.0 4936.1 4937.2 3483.7 3606.9 3638.1 3644.1 3652.8 5100.2 5102.4 5105.2 5112.4 5114.9 3687.9 3694.0 3710.9 3729.6 3734.0 3770.9 3783.4 3787.6 3799.8 3802.1 4007.0 4162.6 4166.7 4203.2 4250.5 4889.9 4890.4 4891.9 4894.2 4909.8 1204.8 1243.4 1243.5 1260.3 1266.2 857.6 858.9 878.0 882.3 883.3 4288.1 4292.4 4295.5 4296.1 4306.4 4965.3 4980.2 4987.6 5019.5 5049.9 4298.0 4310.5 4311.2 4322.5 4341.5 2353.8 2572.3 2668.6 2686.4 2699.2 4775.7 4788.2 4792.8 4818.9 4837.7 5191.5 5196.4 5229.0 5244.8 5248.7 4630.3 4823.3 4830.2 4843.7 4856.7 5093.1 5095.6 5098.6 5109.2 5127.7 5014.4 5046.7 5055.2 5055.7 5066.2 4609.8 4818.0 4877.3 4890.5 4898.5 3655.0 3678.8 3688.5 3697.3 3707.1 4968.6 5185.7 5196.3 5204.3 5208.6 4780.4 4937.7 4941.7 4944.9 4972.3 4895.2 4926.0 4932.8 4944.8 4983.0 4611.4 4865.5 4873.1 4878.6 4920.8 4934.2 4954.6 4979.9 4985.3 4988.8 4871.1 4882.6 4920.1 4958.2 4961.3 10:29:48 INFO - PROCESS | 11676 | 10:29:48 INFO - PROCESS | 11676 | [#5] yui.html Cycles:180 Average:18649.36 Median:495.10 stddev:27842.67 (5623.6%) stddev-sans-first:27887.71 10:29:48 INFO - PROCESS | 11676 | Values: 575.7 618.1 649.2 665.7 682.2 12590.6 13293.4 13579.4 13592.3 14336.3 12900.3 12946.5 12991.9 12996.9 13024.3 745.5 764.9 770.1 770.3 770.5 608.1 723.7 760.6 762.2 768.7 796.8 797.8 798.4 799.0 799.5 791.3 792.9 793.2 793.4 793.5 471.2 555.7 577.9 578.4 581.1 12857.5 12906.9 12967.9 13034.3 13182.9 12425.3 13123.8 13362.9 13574.5 13686.9 11747.1 11895.3 12002.0 12256.0 12417.0 4096.2 4129.3 4146.7 4303.7 4303.9 65345.7 66625.3 66701.7 66831.0 67792.0 9726.2 9912.5 9945.0 9957.1 10054.1 18330.0 18340.9 18369.9 18391.4 18413.4 6728.7 6737.5 6798.8 6820.8 6938.7 3672.7 3708.3 3711.0 3712.9 3762.5 2874.0 2971.5 2972.0 2975.2 2976.1 488.6 488.9 492.1 495.3 537.4 471.4 494.9 521.3 554.4 557.7 7680.3 8087.2 8265.3 8281.8 8301.2 489.5 494.6 525.2 537.5 607.8 3517.5 3778.4 3861.4 3894.4 4003.2 105617.0 108120.0 109882.0 110420.4 113904.0 88752.0 91385.5 92848.5 93959.0 94000.5 77517.2 78672.0 78871.0 79095.0 79602.4 7125.4 7400.7 7682.1 7685.1 7691.5 47202.0 47881.0 48066.2 48455.8 48704.5 54287.5 68403.3 69479.0 69665.7 72873.3 9323.7 9810.6 9944.3 10101.4 10161.4 9480.2 9820.5 10301.0 11593.2 12679.7 11131.8 11239.0 11255.9 11449.7 11602.0 9926.4 10110.2 10870.7 10999.1 11011.3 10535.7 10635.9 10861.9 11287.8 11426.1 9275.0 9895.2 10235.8 10381.5 10751.9 9359.7 9465.4 9585.6 9647.8 9925.9 10:29:48 INFO - PROCESS | 11676 | -------- Summary: end -------- 10:29:48 INFO - PROCESS | 11676 | 10:29:49 INFO - TEST-INFO | 11676: exit 0 10:29:49 INFO - TEST-OK | dromaeo_css | took 1120422ms 10:29:49 INFO - TEST-START | kraken 10:29:49 INFO - operating with platform_type : linux_ 10:29:49 INFO - Initialising browser for kraken test... 10:29:49 INFO - TEST-INFO | started process 11979 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNjHq4r/profile http://localhost:60707/getInfo.html) 10:29:54 INFO - PROCESS | 11979 | __metrics Screen width/height:1600/1200 10:29:54 INFO - PROCESS | 11979 | colorDepth:24 10:29:54 INFO - PROCESS | 11979 | Browser inner width/height: 1024/697 10:29:54 INFO - PROCESS | 11979 | __metrics 10:29:54 INFO - PROCESS | 11979 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:29:54 INFO - PROCESS | 11979 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:29:55 INFO - TEST-INFO | 11979: exit 0 10:29:55 INFO - Browser initialized. 10:29:55 INFO - Running cycle 1/1 for kraken test... 10:29:55 INFO - TEST-INFO | started process 12060 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNjHq4r/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:30:08 INFO - PROCESS | 12060 | RSS: Main: 181972992 10:30:08 INFO - PROCESS | 12060 | 10:30:10 INFO - PROCESS | 12060 | Cycle 1(1): loaded http://localhost:60707/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60707/tests/kraken/driver.html?testName=audio-beat-detection) 10:30:11 INFO - PROCESS | 12060 | RSS: Main: 243695616 10:30:11 INFO - PROCESS | 12060 | 10:30:14 INFO - PROCESS | 12060 | Cycle 1(1): loaded http://localhost:60707/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60707/tests/kraken/driver.html?testName=audio-dft) 10:30:15 INFO - PROCESS | 12060 | RSS: Main: 225447936 10:30:15 INFO - PROCESS | 12060 | 10:30:18 INFO - PROCESS | 12060 | Cycle 1(1): loaded http://localhost:60707/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60707/tests/kraken/driver.html?testName=audio-fft) 10:30:19 INFO - PROCESS | 12060 | RSS: Main: 303345664 10:30:19 INFO - PROCESS | 12060 | 10:30:21 INFO - PROCESS | 12060 | Cycle 1(1): loaded http://localhost:60707/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60707/tests/kraken/driver.html?testName=audio-oscillator) 10:30:21 INFO - PROCESS | 12060 | RSS: Main: 213553152 10:30:21 INFO - PROCESS | 12060 | 10:30:24 INFO - PROCESS | 12060 | Cycle 1(1): loaded http://localhost:60707/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60707/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:30:24 INFO - PROCESS | 12060 | RSS: Main: 214556672 10:30:24 INFO - PROCESS | 12060 | 10:30:27 INFO - PROCESS | 12060 | Cycle 1(1): loaded http://localhost:60707/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60707/tests/kraken/driver.html?testName=imaging-darkroom) 10:30:28 INFO - PROCESS | 12060 | RSS: Main: 253308928 10:30:28 INFO - PROCESS | 12060 | 10:30:31 INFO - PROCESS | 12060 | Cycle 1(1): loaded http://localhost:60707/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60707/tests/kraken/driver.html?testName=imaging-desaturate) 10:30:32 INFO - PROCESS | 12060 | RSS: Main: 247447552 10:30:32 INFO - PROCESS | 12060 | 10:30:35 INFO - PROCESS | 12060 | Cycle 1(1): loaded http://localhost:60707/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60707/tests/kraken/driver.html?testName=json-parse-financial) 10:30:36 INFO - PROCESS | 12060 | RSS: Main: 250511360 10:30:36 INFO - PROCESS | 12060 | 10:30:37 INFO - PROCESS | 12060 | Cycle 1(1): loaded http://localhost:60707/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60707/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:30:38 INFO - PROCESS | 12060 | RSS: Main: 214622208 10:30:38 INFO - PROCESS | 12060 | 10:30:40 INFO - PROCESS | 12060 | Cycle 1(1): loaded http://localhost:60707/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60707/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:30:41 INFO - PROCESS | 12060 | RSS: Main: 222801920 10:30:41 INFO - PROCESS | 12060 | 10:30:43 INFO - PROCESS | 12060 | Cycle 1(1): loaded http://localhost:60707/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60707/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:30:43 INFO - PROCESS | 12060 | RSS: Main: 223154176 10:30:43 INFO - PROCESS | 12060 | 10:30:46 INFO - PROCESS | 12060 | Cycle 1(1): loaded http://localhost:60707/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60707/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:30:47 INFO - PROCESS | 12060 | RSS: Main: 218746880 10:30:47 INFO - PROCESS | 12060 | 10:30:50 INFO - PROCESS | 12060 | Cycle 1(1): loaded http://localhost:60707/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60707/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:30:50 INFO - PROCESS | 12060 | RSS: Main: 220995584 10:30:50 INFO - PROCESS | 12060 | 10:30:52 INFO - PROCESS | 12060 | Cycle 1(1): loaded http://localhost:60707/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60707/tests/kraken/driver.html?testName=ai-astar) 10:30:52 INFO - PROCESS | 12060 | RSS: Main: 272105472 10:30:52 INFO - PROCESS | 12060 | 10:30:52 INFO - PROCESS | 12060 | __start_tp_report 10:30:52 INFO - PROCESS | 12060 | _x_x_mozilla_page_load 10:30:52 INFO - PROCESS | 12060 | _x_x_mozilla_page_load_details 10:30:52 INFO - PROCESS | 12060 | |i|pagename|runs| 10:30:52 INFO - PROCESS | 12060 | |0;ai-astar;113;114;128;114;114;116;114;113;113;114 10:30:52 INFO - PROCESS | 12060 | |1;audio-beat-detection;154;122;153;178;124;152;146;126;198;126 10:30:52 INFO - PROCESS | 12060 | |2;audio-dft;161;160;160;161;160;162;165;162;161;161 10:30:52 INFO - PROCESS | 12060 | |3;audio-fft;75;75;76;181;78;76;76;75;168;76 10:30:52 INFO - PROCESS | 12060 | |4;audio-oscillator;88;86;147;86;87;87;150;86;87;152 10:30:52 INFO - PROCESS | 12060 | |5;imaging-gaussian-blur;117;117;117;117;116;117;117;117;117;118 10:30:52 INFO - PROCESS | 12060 | |6;imaging-darkroom;149;148;147;147;148;148;147;147;147;148 10:30:52 INFO - PROCESS | 12060 | |7;imaging-desaturate;95;95;95;94;95;95;95;95;95;94 10:30:52 INFO - PROCESS | 12060 | |8;json-parse-financial;65;66;66;66;68;66;65;66;65;67 10:30:52 INFO - PROCESS | 12060 | |9;json-stringify-tinderbox;65;65;65;65;66;65;65;65;65;65 10:30:52 INFO - PROCESS | 12060 | |10;stanford-crypto-aes;83;82;95;89;93;83;86;82;93;85 10:30:52 INFO - PROCESS | 12060 | |11;stanford-crypto-ccm;143;141;130;132;131;134;139;132;148;132 10:30:52 INFO - PROCESS | 12060 | |12;stanford-crypto-pbkdf2;173;172;172;171;171;176;174;176;173;172 10:30:52 INFO - PROCESS | 12060 | |13;stanford-crypto-sha256-iterative;74;70;70;69;69;70;68;67;67;67 10:30:52 INFO - PROCESS | 12060 | __end_tp_report 10:30:52 INFO - PROCESS | 12060 | __start_cc_report 10:30:52 INFO - PROCESS | 12060 | _x_x_mozilla_cycle_collect,2020 10:30:52 INFO - PROCESS | 12060 | __end_cc_report 10:30:52 INFO - PROCESS | 12060 | __startTimestamp1472059852911__endTimestamp 10:30:52 INFO - PROCESS | 12060 | 10:30:52 INFO - PROCESS | 12060 | ------- Summary: start ------- 10:30:52 INFO - PROCESS | 12060 | Number of tests: 14 10:30:52 INFO - PROCESS | 12060 | 10:30:52 INFO - PROCESS | 12060 | [#0] ai-astar Cycles:10 Average:115.30 Median:114.00 stddev:4.55 (4.0%) stddev-sans-first:4.75 10:30:52 INFO - PROCESS | 12060 | Values: 113.0 114.0 128.0 114.0 114.0 116.0 114.0 113.0 113.0 114.0 10:30:52 INFO - PROCESS | 12060 | 10:30:52 INFO - PROCESS | 12060 | [#1] audio-beat-detection Cycles:10 Average:147.90 Median:152.50 stddev:25.17 (16.5%) stddev-sans-first:26.60 10:30:52 INFO - PROCESS | 12060 | Values: 154.0 122.0 153.0 178.0 124.0 152.0 146.0 126.0 198.0 126.0 10:30:52 INFO - PROCESS | 12060 | 10:30:52 INFO - PROCESS | 12060 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.00 stddev:1.49 (0.9%) stddev-sans-first:1.58 10:30:52 INFO - PROCESS | 12060 | Values: 161.0 160.0 160.0 161.0 160.0 162.0 165.0 162.0 161.0 161.0 10:30:52 INFO - PROCESS | 12060 | 10:30:52 INFO - PROCESS | 12060 | [#3] audio-fft Cycles:10 Average:95.60 Median:76.00 stddev:41.71 (54.9%) stddev-sans-first:43.56 10:30:52 INFO - PROCESS | 12060 | Values: 75.0 75.0 76.0 181.0 78.0 76.0 76.0 75.0 168.0 76.0 10:30:52 INFO - PROCESS | 12060 | 10:30:52 INFO - PROCESS | 12060 | [#4] audio-oscillator Cycles:10 Average:105.60 Median:86.50 stddev:30.44 (35.2%) stddev-sans-first:31.61 10:30:52 INFO - PROCESS | 12060 | Values: 88.0 86.0 147.0 86.0 87.0 87.0 150.0 86.0 87.0 152.0 10:30:52 INFO - PROCESS | 12060 | 10:30:52 INFO - PROCESS | 12060 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 10:30:52 INFO - PROCESS | 12060 | Values: 117.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 118.0 10:30:52 INFO - PROCESS | 12060 | 10:30:52 INFO - PROCESS | 12060 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:148.00 stddev:0.70 (0.5%) stddev-sans-first:0.53 10:30:52 INFO - PROCESS | 12060 | Values: 149.0 148.0 147.0 147.0 148.0 148.0 147.0 147.0 147.0 148.0 10:30:52 INFO - PROCESS | 12060 | 10:30:52 INFO - PROCESS | 12060 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 10:30:52 INFO - PROCESS | 12060 | Values: 95.0 95.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 94.0 10:30:52 INFO - PROCESS | 12060 | 10:30:52 INFO - PROCESS | 12060 | [#8] json-parse-financial Cycles:10 Average:66.00 Median:66.00 stddev:0.94 (1.4%) stddev-sans-first:0.93 10:30:52 INFO - PROCESS | 12060 | Values: 65.0 66.0 66.0 66.0 68.0 66.0 65.0 66.0 65.0 67.0 10:30:52 INFO - PROCESS | 12060 | 10:30:52 INFO - PROCESS | 12060 | [#9] json-stringify-tinderbox Cycles:10 Average:65.10 Median:65.00 stddev:0.32 (0.5%) stddev-sans-first:0.33 10:30:52 INFO - PROCESS | 12060 | Values: 65.0 65.0 65.0 65.0 66.0 65.0 65.0 65.0 65.0 65.0 10:30:52 INFO - PROCESS | 12060 | 10:30:52 INFO - PROCESS | 12060 | [#10] stanford-crypto-aes Cycles:10 Average:87.10 Median:87.50 stddev:5.02 (5.7%) stddev-sans-first:5.10 10:30:52 INFO - PROCESS | 12060 | Values: 83.0 82.0 95.0 89.0 93.0 83.0 86.0 82.0 93.0 85.0 10:30:52 INFO - PROCESS | 12060 | 10:30:52 INFO - PROCESS | 12060 | [#11] stanford-crypto-ccm Cycles:10 Average:136.20 Median:136.50 stddev:6.14 (4.5%) stddev-sans-first:6.00 10:30:52 INFO - PROCESS | 12060 | Values: 143.0 141.0 130.0 132.0 131.0 134.0 139.0 132.0 148.0 132.0 10:30:52 INFO - PROCESS | 12060 | 10:30:52 INFO - PROCESS | 12060 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.00 Median:173.00 stddev:1.83 (1.1%) stddev-sans-first:1.94 10:30:52 INFO - PROCESS | 12060 | Values: 173.0 172.0 172.0 171.0 171.0 176.0 174.0 176.0 173.0 172.0 10:30:52 INFO - PROCESS | 12060 | 10:30:52 INFO - PROCESS | 12060 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.10 Median:69.50 stddev:2.13 (3.1%) stddev-sans-first:1.33 10:30:52 INFO - PROCESS | 12060 | Values: 74.0 70.0 70.0 69.0 69.0 70.0 68.0 67.0 67.0 67.0 10:30:52 INFO - PROCESS | 12060 | -------- Summary: end -------- 10:30:52 INFO - PROCESS | 12060 | 10:30:54 INFO - TEST-INFO | 12060: exit 0 10:30:54 INFO - TEST-OK | kraken | took 64449ms 10:30:54 INFO - SUITE-END | took 1184s 10:30:54 INFO - Completed test suite (00:19:45) 10:30:54 INFO - javascript benchmark 10:30:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2581.0205732094605, 2592.2482480080776, 2598.519273934321, 2632.512985097757, 2654.3629528913057, 4535.319702044695, 4586.266197408415, 4594.081183763253, 4653.162430762462, 4703.435587729473, 4665.9066818663605, 4679.461861885884, 4729.030548737509, 4734.502877197896, 4740.288956656504, 4243.957560424387, 4274.187904298174, 4321.2653848845775, 4387.056782791699, 4445.288753799393, 4339.739615623057, 4384.846530371437, 4399.274119770234, 4418.3593378960195, 4425.645948324142, 4185.832566697329, 4242.3212286034395, 4245.3844192591905, 4275.893102672458, 4300.0, 4269.658427325807, 4287.978560107211, 4358.455193100863, 4374.759388233646, 4426.756528390937, 4232.830686772525, 4243.787810609488, 4250.107477429743, 4302.5052119006405, 4347.0, 4651.813927442899, 4708.0, 4708.411448568929, 4711.222648263032, 4763.618910487153, 4856.68431551948, 4951.480094590052, 4983.377077865267, 5004.249362595603, 5023.397192336906, 5029.346184995927, 5041.294218809369, 5053.242013697938, 5053.722045287508, 5057.897914078599, 4671.85984420468, 4706.552877476634, 4706.905861882811, 4727.976360118178, 4766.904661906742, 4921.729304888266, 5059.696418214845, 5125.769340379692, 5134.768935397916, 5204.141316682781, 4910.779014944336, 4938.037082768898, 4938.530839570235, 4940.530649588283, 5001.049800537886, 5016.297718319438, 5018.548330650259, 5026.396832380138, 5027.597792176617, 5030.798768049311, 4758.976205119022, 4833.975830120827, 4839.95160048395, 4900.901981960341, 4971.825986090469, 4901.901961960741, 4908.607311415079, 4916.508349165055, 4916.557509824133, 4957.405111386584, 4203.432536607519, 4203.600657937553, 4208.726432781859, 4221.176870510221, 4265.0, 3651.3062518121474, 3654.744167908221, 3656.6160553142067, 3681.9079523012138, 3724.385476396364, 4201.096764195712, 4206.41110244566, 4244.278472659594, 4244.787760611957, 4252.829886804555, 4909.239067944474, 4951.72765497901, 4954.256861470808, 4959.2809042688605, 4980.078685443204, 4154.210699966997, 4194.49666040071, 4229.746215227096, 4230.344296634026, 4272.7222730523035, 4460.799264033127, 4480.238359478896, 4535.682502224879, 4537.705049171794, 4540.8637740867825, 4687.578117969331, 4694.084653492673, 4694.906101878011, 4695.716945996208, 4759.476457589732, 4889.559939605452, 4916.729579873141, 4957.256411538298, 4966.701997880139, 5025.522575355335, 4663.673542851968, 4689.695169813951, 4764.452088009784, 4765.904681906273, 4787.784549695202, 4948.257761335828, 4953.380827396575, 4956.975215123901, 4976.601871850316, 5044.041632090038, 5022.547970682656, 5036.84889453317, 5036.874078148076, 5036.974815125901, 5105.055564720538, 4766.952330476651, 4776.546228108324, 4811.254255590389, 4829.13075646387, 4903.313536104877, 4816.181249187576, 4818.132736107535, 4828.179209534458, 4833.734144621939, 4881.9511804881495, 4745.857624271277, 4752.0, 4757.976210118927, 4768.332433459388, 4820.4456487504385, 4769.73766442849, 4889.095517329305, 4902.2156454967035, 4936.777844996912, 5021.874453138701, 4830.903381932412, 4855.393075865517, 4859.611231101574, 4860.0, 4915.164422048332], "value": 4581.587338298223, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [555.097965805566, 567.9521283232434, 577.0882006429841, 589.5813972079823, 590.18554394935, 26825.4634907302, 29152.0, 29232.0, 29324.413511729752, 29354.559681604766, 30532.389352213, 38957.610423895756, 40132.59867401325, 40310.0, 43830.780846095804, 7672.961635191817, 7769.456138070337, 7789.4157938154585, 7795.883061754078, 7812.570308633023, 7723.61381930904, 7801.921980780205, 7815.491993020435, 7821.335186509154, 7827.530348179127, 7531.209223031585, 7709.537427754324, 7714.6914123435, 7869.645865936047, 10106.747331316703, 10070.647527336545, 10149.086582207638, 10152.949235253776, 10155.644552440703, 10168.135708464752, 9907.157891579225, 9976.850347244725, 9982.25133115012, 10000.449975251358, 10002.399856008662, 37014.629853701386, 37783.81108094442, 37791.43312850309, 37825.810870945745, 37845.62154378476, 2741.163944996775, 2862.9856850715614, 2932.135020169055, 2940.882364705409, 2943.6173297471405, 27641.308967275778, 27819.86090069557, 27830.860845695843, 27839.582406263922, 28299.292517687223, 3059.5869557609662, 3077.538369244609, 3108.5492603572357, 3118.469860123784, 3124.656287808339, 241542.0, 241959.0, 242261.0, 242653.0, 243257.0, 50932.49067509278, 51256.77378071983, 51300.0, 51303.0, 51402.0, 31892.84053579717, 32785.67214327874, 32962.0, 34959.825200873835, 35012.0, 12268.32524211177, 12572.4342404592, 12573.497060117494, 12585.748285034248, 12599.559015434415, 9976.900230997597, 10069.949650251701, 10077.244206684529, 10103.7474063149, 10197.235207359477, 16958.576035598962, 17099.829001710073, 17182.828171718375, 17255.74116388255, 17291.567710807078, 5451.918221226685, 6764.4926630502905, 6811.693473793691, 6956.930430695729, 7046.260142684944, 844.1010324005038, 860.1484530315068, 866.9046404895456, 877.2455688108222, 983.5180761426849, 26342.341441464116, 27766.0, 28334.433311333658, 28642.427151456854, 28691.139265822057, 953.1707414549386, 964.1274646444979, 1009.8333774927202, 1027.3219675014454, 1035.297872552637, 13842.446302148002, 14837.255107805091, 14977.850221497863, 15245.847541524443, 15302.540923772305, 352412.0, 354415.0, 354811.0, 355136.0, 357432.0, 47835.28247076297, 48020.03959920782, 48611.51388486141, 48668.513314866395, 48713.756431218324, 1083.5774048121239, 1109.5062697099875, 1125.471028616549, 1127.7462570921641, 1154.8671902731126, 24896.0, 28374.432511349245, 29265.41469170647, 29582.852085739432, 29690.70309296966, 41775.37336940009, 42559.5744042568, 42562.36156457718, 42599.7870010648, 42677.35983960305, 334505.0, 338475.0, 339753.0, 339789.0, 340325.0, 37725.245495090494, 37948.24103517969, 38996.0, 40218.59781402149, 40389.39415908705, 40285.798571006955, 40449.595504044584, 40668.79665601653, 41698.58301416947, 41799.164016720104, 35151.82424087863, 35352.64647353494, 35464.46803298004, 35622.64377356193, 35799.46300805438, 34913.47629785606, 35058.474122888685, 35452.82273588719, 35683.643163568035, 35690.0, 34378.82810585931, 34756.47865282073, 35083.29833403369, 35245.64754352424, 35572.64427355797, 28912.710872891843, 31036.68963310338, 31122.066338009896, 31158.68841311558, 31281.369353516584, 24051.0, 24652.630210547213, 24723.25830225096, 24817.25548233556, 25045.74954250507], "value": 17159.456107169186, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [345.57666858098816, 365.40256680327656, 366.82759103221485, 374.3561074951083, 388.50077650219475, 12723.1729937554, 16055.518334449956, 16118.83881161188, 17121.0, 17227.91386043068, 16092.517224483285, 16318.102504362256, 16779.916100419512, 16959.32162713493, 16973.660526789456, 4884.242942343943, 4901.019796040806, 5037.823676171335, 5062.240663900426, 5069.797208111671, 3723.515942927416, 4964.652474326798, 5043.445221025684, 5100.056489549426, 5655.688937108457, 5927.792527261547, 6030.8793824123495, 6040.0, 6043.909341359883, 6047.606905551125, 5811.1283307504, 5898.852528686774, 5909.37951515089, 5922.4077592240865, 6037.064255040454, 5196.636235463519, 5207.6354655174155, 5212.244224587452, 5213.661112027706, 5239.371275446971, 19944.800551994438, 20884.582308353747, 21059.894700526398, 21111.47221319464, 21317.253896113718, 1865.8320751132462, 1887.0, 1943.37811900192, 2186.387811412807, 2268.739095004079, 13092.607221783363, 13216.207027578375, 13351.666208344772, 13467.461301547926, 13957.58127256184, 1764.0209683625583, 1764.3383731100837, 1767.3460819496868, 1785.5536115971008, 1822.8997405142711, 42637.0, 48803.096228274444, 60839.39160608382, 66079.0, 71489.2851071493, 9623.951880240555, 9747.756306092404, 9906.801863962824, 10023.649172278936, 10083.621986634413, 13521.86478135206, 13621.795673064911, 13625.523106691218, 13625.659358516117, 13632.93183534076, 6932.757353492603, 7109.751158709524, 7142.535735177197, 7242.565446073147, 7374.852502949911, 6635.8009259722285, 6759.932400675931, 6839.487038472134, 6852.177738671391, 6908.585484870924, 6078.0, 6152.292486364126, 6171.475424588871, 6192.721327540272, 6297.118403423525, 1749.2390809997692, 1763.3387479695114, 1812.8277813607685, 1814.5372929903053, 1823.8632102592358, 381.3517021064202, 382.5027464296459, 402.72815849301605, 658.2791842931982, 886.2688282167238, 10563.47182640865, 10600.151987840954, 10827.404492752818, 10853.837192442119, 11190.32858028521, 396.4251834839494, 400.71549200067693, 415.0226217258373, 415.71731222768807, 435.6188335206694, 5419.620626556103, 5720.313562372458, 5750.1949727038245, 5949.702514874239, 5955.851103722355, 404900.0, 405403.0, 407420.0, 421468.0, 422319.0, 78629.60685196538, 79052.0, 79700.20299797044, 80634.59682701548, 81760.18239817525, 428.1971303805365, 438.8222769778245, 439.5231174176055, 439.6988063176734, 440.74436826641113, 8531.8720219198, 10061.647842325483, 10207.285490015925, 10352.637657681946, 10479.580816767244, 38766.0, 39002.414963775, 39041.0, 39234.803825980685, 39987.0, 48534.514654853, 48823.267650984555, 49060.75469622629, 49495.25757113718, 49881.75059124681, 6761.763338283136, 7054.118235220598, 7146.749863754743, 7558.206388329147, 7927.920720792718, 10980.670579882617, 11917.82123268169, 12295.69260768488, 12444.626661200178, 12520.937395312965, 9831.606735730491, 9904.801903962025, 9966.202703783825, 10558.31370960885, 10964.0, 5976.850578735566, 10811.6215932442, 10854.945725271324, 10946.507407166855, 10998.175136864607, 10131.898681013095, 10459.581616735246, 10658.89341106579, 10665.306755060896, 11263.155263355446, 7063.434925205868, 7125.786226413215, 7237.565746055254, 7340.045794046953, 7533.472656913963, 10030.849537257092, 10108.342957707726, 10186.439745813756, 10390.168786496912, 10783.622573210214], "value": 7600.9169883558525, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1256.956006539771, 1288.433089440646, 1300.1678925487686, 1544.2973447081579, 1556.8053993250837, 6726.394624483795, 6986.091808064944, 7319.9268007319915, 7862.646180921858, 7883.408744344169, 7295.379892709113, 7581.658825352859, 7585.7344992925255, 7766.61166941652, 7771.68913243471, 2160.503084290614, 2189.7481789594162, 2194.9122035118576, 2195.0, 2197.088208393515, 1852.4627857921187, 2064.205280966831, 2107.546877421354, 2133.807957283844, 2156.5363446858923, 2165.0149182122177, 2183.170395249811, 2187.278198194592, 2190.167736260219, 2190.58378908007, 2134.9679754803615, 2148.871067735933, 2175.19517778423, 2175.2495389090736, 2175.380016695234, 2121.3847984084596, 2123.458518077896, 2124.8193903518218, 2128.17001369466, 2158.946026349338, 7915.327197188246, 7972.441929064909, 7975.322097621709, 7976.122626511079, 7982.401319901031, 4403.493598236179, 4481.08137831747, 4532.229520981441, 4536.500984891659, 4540.387047748544, 2756.3935934094466, 2842.04791394883, 2883.639545056868, 2891.3928075104254, 2894.3777087925987, 872.8865247517846, 888.338188049907, 902.0483390023522, 928.4058202750246, 931.0642803982023, 10443.895561044368, 10454.738631534197, 10463.162946964301, 10466.319689220176, 10475.214358923111, 3830.367989281737, 3981.0, 4036.091879327128, 4099.159672267178, 4109.56849530795, 8980.820383592292, 8981.775455613662, 8990.056044115405, 8994.05562415937, 9005.14451127142, 4593.609543188866, 4594.517575654575, 4594.816207351669, 4595.425571803525, 4596.517365676623, 4144.088300573869, 4183.100633363842, 4191.706580539394, 4192.329227323614, 4192.329227323614, 3545.308664810389, 3561.3411518869093, 3566.607673156003, 3580.606133325332, 3596.7841929484316, 1037.678319720889, 1119.5557730527692, 1121.814900541418, 1144.3305666185208, 1177.2936238256978, 738.8042168825266, 756.9243075692386, 800.8918795962587, 806.6047636658112, 826.09955148888, 4987.900241995212, 5026.572741317029, 5062.620303477254, 5080.49195080489, 5280.947190528045, 836.8912041434696, 853.1298075962608, 871.7994861181963, 895.4761464543316, 917.2707697380465, 3311.1887587541205, 3377.1725927147513, 3457.4640930655787, 3486.0239133042787, 3540.256546125291, 8630.136986301319, 9232.353735238603, 9284.071592840663, 9288.674896378594, 9295.070492950787, 9216.354855160209, 9223.985361610217, 9231.861522077174, 9234.076592340713, 9239.676611318571, 6605.174353205849, 6895.0, 7169.139703235541, 7169.820754481076, 7173.89239161413, 5096.413912400121, 5123.948760512347, 5149.897002059863, 5312.0, 5391.649542779707, 8768.517731524573, 8809.295256379603, 8813.338999575186, 8826.338024648048, 8903.777405564913, 8717.433366831136, 8748.300135989233, 8883.33374996865, 8906.688265910921, 9013.819723605622, 6312.242530896322, 6561.1470508833545, 6675.833104172434, 6702.798916032527, 6704.83237919056, 7636.236376362319, 7690.9230907692445, 7691.57696326685, 7694.615269236628, 7700.537967721954, 6549.31232220629, 6796.320367963164, 6838.213605435439, 6845.349691779273, 7072.08062951813, 6460.8707825842275, 6669.666516674244, 6716.529842911144, 6770.593764373956, 6932.826679333057, 6145.201123853871, 6232.8130156095385, 6239.844003899939, 6248.312685604489, 6262.15460912771, 4577.382053422745, 4654.976725116353, 4711.552402521755, 4722.693024953367, 4755.144074066563, 4540.524329592829, 4546.863594092182, 4601.608863246528, 4688.367070445446, 4746.169420351355], "value": 4066.817125116678, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [293.5523326926438, 299.25784055542255, 304.25154120862675, 306.5126448946175, 309.9504079347305, 4564.612007979317, 4683.672142949987, 4712.340272361872, 4751.3348131261655, 4752.168370535155, 4465.17394282058, 4613.039458230255, 4632.3283123947, 4633.49031606523, 4671.602913752336, 3718.9070273243115, 3723.888283351504, 3731.794751288678, 3740.775553466794, 3759.360908645523, 3547.8935631931085, 3605.4591811228265, 3739.383001804699, 3751.9062023449496, 3775.924481510368, 3691.667749902508, 3704.073981504624, 3704.6848368829083, 3713.294474049922, 3724.906877328075, 3707.536557930259, 3710.9052829415386, 3717.7955212463303, 3721.8697345593046, 3755.1363186466992, 3316.535685004101, 3317.651646577123, 3326.6839650233187, 3332.7500437467043, 3337.8998630041137, 4490.281554951225, 4556.835503136017, 4588.954110458886, 4617.769111544443, 4622.6070783983405, 4237.576242375769, 4238.7880605969885, 4245.172191422674, 4248.256555102845, 4254.255505286563, 4893.510648935114, 4901.142300097505, 4910.986495536813, 4936.136176169156, 4937.185364414867, 3483.7387195960405, 3606.9098272543133, 3638.108663377463, 3644.125409901631, 3652.8493524539685, 5100.234964755279, 5102.438731739506, 5105.208692652608, 5112.437631860493, 5114.923276150824, 3687.9262414751556, 3693.9630603693618, 3710.9072273192846, 3729.6083911188935, 3734.0, 3770.8680196193, 3783.4135708965155, 3787.6401741834484, 3799.848006079781, 3802.1065049713297, 4006.959930400659, 4162.604552567501, 4166.66666666666, 4203.243416185116, 4250.4899412070135, 4889.877753056202, 4890.388701412324, 4891.850415152508, 4894.2169252920075, 4909.828156014522, 1204.8253003314471, 1243.359669770069, 1243.5212443209248, 1260.3194275091532, 1266.2276011632896, 857.562643052048, 858.8668756342777, 877.9604917778715, 882.250087425683, 883.2757139145967, 4288.078063216361, 4292.356146577976, 4295.548967358445, 4296.140771845581, 4306.41863348444, 4965.32968049316, 4980.232017633761, 4987.608426270099, 5019.47295533971, 5049.899002020013, 4297.957020429818, 4310.4611923509565, 4311.245532031882, 4322.502912165141, 4341.45731783527, 2353.8352315338107, 2572.2797616667362, 2668.6389941130165, 2686.395560998799, 2699.1767510908967, 4775.6657034007985, 4788.209945359046, 4792.808287668524, 4818.903621927542, 4837.661363704507, 5191.454897235812, 5196.376434827769, 5229.0, 5244.763985620656, 5248.6588371755715, 4630.259158534618, 4823.252395878644, 4830.178869592108, 4843.660943733905, 4856.660033797671, 5093.108705976513, 5095.643304968617, 5098.566621837037, 5109.233614957638, 5127.743612819419, 5014.373203349582, 5046.6719663221775, 5055.191169412877, 5055.6713813602, 5066.164082926276, 4609.815607375667, 4817.975910120427, 4877.317175595348, 4890.486498917562, 4898.510148985073, 3655.0, 3678.834452449593, 3688.502052223023, 3697.2975134724315, 3707.1473561081643, 4968.552830245295, 5185.7407129644125, 5196.32447781786, 5204.34945631796, 5208.557272631717, 4780.354652122058, 4937.654364194472, 4941.65408421407, 4944.898418172191, 4972.254161875748, 4895.227153525284, 4925.950740492549, 4932.82735104284, 4944.75276236194, 4982.950170498249, 4611.3544103824825, 4865.537773911473, 4873.1471992400475, 4878.609711223165, 4920.827771027997, 4934.18585933317, 4954.628402869727, 4979.850604481871, 4985.252212168204, 4988.80044798204, 4871.147549178809, 4882.584980276574, 4920.138975679313, 4958.181899986462, 4961.330220420197], "value": 3745.324646972593, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [575.7466714645556, 618.1099217127339, 649.1528555235421, 665.7303791964255, 682.2461180395662, 12590.622281331563, 13293.401796919137, 13579.388927498261, 13592.3203839808, 14336.283185840719, 12900.290484023375, 12946.546870859522, 12991.870081299185, 12996.93501532491, 13024.348782560857, 745.5452174173749, 764.8890910817928, 770.0912922751152, 770.2720928722359, 770.4953255617579, 608.0878681977034, 723.724984505887, 760.6196901549225, 762.230147550972, 768.7002069193019, 796.8087658961837, 797.8204903896606, 798.3892322373389, 799.0411506192563, 799.4803377804416, 791.2720297326473, 792.8572856885759, 793.1949071692237, 793.4326956226325, 793.4525177627419, 471.2436539354321, 555.7221389305347, 577.8844231153744, 578.3984655957798, 581.1399129288676, 12857.485700571966, 12906.870931290754, 12967.935160324138, 13034.348282585928, 13182.934085329607, 12425.254484730945, 13123.803142952864, 13362.933185334012, 13574.45702171912, 13686.863131368658, 11747.118966077578, 11895.345755983417, 12002.0, 12256.0, 12417.0, 4096.221717873625, 4129.256733787917, 4146.688998325138, 4303.677224208165, 4303.924018995252, 65345.673271633335, 66625.33374666239, 66701.66649166771, 66831.0, 67792.0, 9726.221902247804, 9912.454814985102, 9945.0, 9957.103860652576, 10054.145397641136, 18330.0, 18340.908295458703, 18369.908150459163, 18391.356302529348, 18413.447596572125, 6728.6635668216395, 6737.52837301394, 6798.827376478801, 6820.795376138723, 6938.722451102, 3672.6510981456718, 3708.332500149999, 3710.981445092811, 3712.9071773205887, 3762.492063571383, 2873.9712602873706, 2971.5097008993275, 2971.985140074329, 2975.2413134650524, 2976.122043997026, 488.64573184440997, 488.872893047803, 492.1363007921147, 495.2942057567951, 537.3551737914519, 471.4319245309394, 494.9059678661115, 521.3092652235803, 554.354177383352, 557.7378632042934, 7680.270374314431, 8087.1912808719835, 8265.256126948603, 8281.792955176168, 8301.211384918422, 489.4591476418506, 494.6240856948745, 525.2488940814671, 537.4517991648497, 607.7903123422412, 3517.542719446507, 3778.3576791945434, 3861.362875125629, 3894.3963685628773, 4003.2193722223888, 105617.0, 108120.0, 109882.0, 110420.44789776, 113904.0, 88752.0, 91385.54307228421, 92848.53575732079, 93959.0, 94000.52999734957, 77517.22482775213, 78672.0, 78871.0, 79095.0, 79602.43776841191, 7125.3524993135525, 7400.740974065882, 7682.116556596063, 7685.077790665156, 7691.500052496794, 47202.0, 47881.0, 48066.16370842966, 48455.75772121117, 48704.51295487142, 54287.45712542824, 68403.3159668397, 69479.0, 69665.65167174132, 72873.27126728665, 9323.72028839136, 9810.558524866256, 9944.254180936603, 10101.44442055694, 10161.441120738134, 9480.194183494481, 9820.518810483696, 10301.0, 11593.24643898144, 12679.746405072032, 11131.833022504507, 11239.0, 11255.943720281673, 11449.713757155805, 11602.0, 9926.354786938826, 10110.19118470506, 10870.728231794268, 10999.065079468015, 11011.28426652265, 10535.683929482127, 10635.89364106349, 10861.891381086089, 11287.774244515227, 11426.143039272254, 9274.95362523183, 9895.158911492605, 10235.846462302923, 10381.532831022772, 10751.892481075089, 9359.719208423758, 9465.384749991228, 9585.616575337188, 9647.761908800283, 9925.900740992498], "value": 6508.087537911248, "unit": "score"}], "name": "dromaeo_css", "value": 6243.652468675519, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 128.0, 114.0, 114.0, 116.0, 114.0, 113.0, 113.0, 114.0], "value": 115.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 122.0, 153.0, 178.0, 124.0, 152.0, 146.0, 126.0, 198.0, 126.0], "value": 147.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 160.0, 161.0, 160.0, 162.0, 165.0, 162.0, 161.0, 161.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 181.0, 78.0, 76.0, 76.0, 75.0, 168.0, 76.0], "value": 95.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 147.0, 86.0, 87.0, 87.0, 150.0, 86.0, 87.0, 152.0], "value": 105.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 118.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 147.0, 147.0, 148.0, 148.0, 147.0, 147.0, 147.0, 148.0], "value": 147.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 66.0, 66.0, 68.0, 66.0, 65.0, 66.0, 65.0, 67.0], "value": 66.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 65.0, 66.0, 65.0, 65.0, 65.0, 65.0, 65.0], "value": 65.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 95.0, 89.0, 93.0, 83.0, 86.0, 82.0, 93.0, 85.0], "value": 87.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 141.0, 130.0, 132.0, 131.0, 134.0, 139.0, 132.0, 148.0, 132.0], "value": 136.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 172.0, 172.0, 171.0, 171.0, 176.0, 174.0, 176.0, 173.0, 172.0], "value": 173.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 70.0, 70.0, 69.0, 69.0, 70.0, 68.0, 67.0, 67.0, 67.0], "value": 69.1, "unit": "score"}], "name": "kraken", "value": 1581.5999999999997, "alertThreshold": 2.0}]} 10:30:54 INFO - Return code: 0 10:30:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:30:54 INFO - # TBPL SUCCESS # 10:30:54 INFO - Running post-action listener: _resource_record_post_action 10:30:54 INFO - [mozharness: 2016-08-24 17:30:54.695463Z] Finished run-tests step (success) 10:30:54 INFO - Running post-run listener: _resource_record_post_run 10:30:54 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 114688; Write bytes: 410017792; Read time: 68; Write time: 293432 10:30:54 INFO - TinderboxPrint: CPU usage
13.0% 10:30:54 INFO - TinderboxPrint: I/O read bytes / time
114,688 / 68 10:30:54 INFO - TinderboxPrint: I/O write bytes / time
410,017,792 / 293,432 10:30:54 INFO - TinderboxPrint: CPU idle
8,336.3 (87.0%) 10:30:54 INFO - TinderboxPrint: CPU user
1,198.8 (12.5%) 10:30:54 INFO - TinderboxPrint: Swap in / out
0 / 0 10:30:54 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 118104064; Read time: 0; Write time: 101112 10:30:54 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 110592; Write bytes: 291913728; Read time: 60; Write time: 192320 10:30:55 INFO - Running post-run listener: _upload_blobber_files 10:30:55 INFO - Blob upload gear active. 10:30:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:30:55 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 10:30:55 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'] 10:30:55 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 10:30:55 INFO - (blobuploader) - INFO - Open directory for files ... 10:30:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:30:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:30:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:30:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:30:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:30:56 INFO - (blobuploader) - INFO - Done attempting. 10:30:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:30:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:30:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:31:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:31:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:31:00 INFO - (blobuploader) - INFO - Done attempting. 10:31:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:31:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:31:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:31:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:31:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:31:00 INFO - (blobuploader) - INFO - Done attempting. 10:31:00 INFO - (blobuploader) - INFO - Iteration through files over. 10:31:00 INFO - Return code: 0 10:31:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:31:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:31:00 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/3822b2f56275db4c7461f4c73e18ef3d17569b9b6718f1bc16360970fcdda515d82222ca65f5e384195a42411040e8d349fe1f31f59d9cf49742099a4265bf55", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/8c323c1289736a6727520dd3333fffadb2f3a32e5a088a7db08a9b5bcda3bc2fc525e8983a3092042bd1e075468324300d1601c824a0728087b3106f05787263", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/e99ec1c5e6fba81d971e42e1b3d881513b259cad415d5693421b70e7fee25455c9b6a70516fb4b6189e65601fb83cc5fe55a813b36f867b8ab5ec5de3849e326"} 10:31:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:31:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:31:00 INFO - Contents: 10:31:00 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/3822b2f56275db4c7461f4c73e18ef3d17569b9b6718f1bc16360970fcdda515d82222ca65f5e384195a42411040e8d349fe1f31f59d9cf49742099a4265bf55", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/8c323c1289736a6727520dd3333fffadb2f3a32e5a088a7db08a9b5bcda3bc2fc525e8983a3092042bd1e075468324300d1601c824a0728087b3106f05787263", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/e99ec1c5e6fba81d971e42e1b3d881513b259cad415d5693421b70e7fee25455c9b6a70516fb4b6189e65601fb83cc5fe55a813b36f867b8ab5ec5de3849e326"} 10:31:00 INFO - Running post-run listener: copy_logs_to_upload_dir 10:31:00 INFO - Copying logs to upload dir... 10:31:00 INFO - mkdir: /builds/slave/test/build/upload/logs 10:31:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.318188 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-08-24 10:31:00.891806) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-24 10:31:00.895283) ========= 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=31acecf42b6a79ec49471d4a000001bb-1472058614.577174-1433154885 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/3822b2f56275db4c7461f4c73e18ef3d17569b9b6718f1bc16360970fcdda515d82222ca65f5e384195a42411040e8d349fe1f31f59d9cf49742099a4265bf55", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/8c323c1289736a6727520dd3333fffadb2f3a32e5a088a7db08a9b5bcda3bc2fc525e8983a3092042bd1e075468324300d1601c824a0728087b3106f05787263", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/e99ec1c5e6fba81d971e42e1b3d881513b259cad415d5693421b70e7fee25455c9b6a70516fb4b6189e65601fb83cc5fe55a813b36f867b8ab5ec5de3849e326"} build_url:https://queue.taskcluster.net/v1/task/GMjyknKaSEuZeRN8SHkKyg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011193 build_url: 'https://queue.taskcluster.net/v1/task/GMjyknKaSEuZeRN8SHkKyg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/3822b2f56275db4c7461f4c73e18ef3d17569b9b6718f1bc16360970fcdda515d82222ca65f5e384195a42411040e8d349fe1f31f59d9cf49742099a4265bf55", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/8c323c1289736a6727520dd3333fffadb2f3a32e5a088a7db08a9b5bcda3bc2fc525e8983a3092042bd1e075468324300d1601c824a0728087b3106f05787263", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/e99ec1c5e6fba81d971e42e1b3d881513b259cad415d5693421b70e7fee25455c9b6a70516fb4b6189e65601fb83cc5fe55a813b36f867b8ab5ec5de3849e326"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-24 10:31:00.920478) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 10:31:00.920822) ========= 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=31acecf42b6a79ec49471d4a000001bb-1472058614.577174-1433154885 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004419 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 10:31:01.002972) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-24 10:31:01.003306) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-24 10:31:01.003581) ========= ========= Total master_lag: 0.19 =========