builder: autoland_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-069 starttime: 1472066244.41 results: success (0) buildid: 20160824091826 builduid: 3d5081f34d564847bdabb73ac1c01358 revision: ff3d89bec675e5a8ceec87b60b9d121f7daa15fb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-24 12:17:24.405905) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-24 12:17:24.406646) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-24 12:17:24.406949) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-24 12:17:24.422269) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 12:17:24.422616) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1472061355.267774-331982381 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-24 12:17:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 114M=0s 2016-08-24 12:17:25 (114 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.136926 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 12:17:24.573655) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 12:17:24.574005) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1472061355.267774-331982381 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016558 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 12:17:24.624127) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 12:17:24.624559) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1472061355.267774-331982381 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-24 12:17:25,492 truncating revision to first 12 chars 2016-08-24 12:17:25,492 Setting DEBUG logging. 2016-08-24 12:17:25,493 attempt 1/10 2016-08-24 12:17:25,493 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 12:17:25,764 unpacking tar archive at: autoland-ff3d89bec675/testing/mozharness/ program finished with exit code 0 elapsedTime=0.638856 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 12:17:25.277507) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-24 12:17:25.277851) ========= script_repo_revision: ff3d89bec675e5a8ceec87b60b9d121f7daa15fb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-24 12:17:25.278343) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-24 12:17:25.278664) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-24 12:17:25.287947) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-08-24 12:17:25.288311) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=05b19d94dfa9f3ce7b6e62cc000001f7-1472061355.267774-331982381 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:17:26 INFO - MultiFileLogger online at 20160824 12:17:26 in /builds/slave/test 12:17:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 12:17:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:17:26 INFO - {'append_to_log': False, 12:17:26 INFO - 'base_work_dir': '/builds/slave/test', 12:17:26 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 12:17:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:17:26 INFO - 'branch': 'Autoland-Non-PGO', 12:17:26 INFO - 'buildbot_json_path': 'buildprops.json', 12:17:26 INFO - 'config_files': ('talos/linux_config.py',), 12:17:26 INFO - 'default_actions': ('clobber', 12:17:26 INFO - 'read-buildbot-config', 12:17:26 INFO - 'download-and-extract', 12:17:26 INFO - 'populate-webroot', 12:17:26 INFO - 'create-virtualenv', 12:17:26 INFO - 'install', 12:17:26 INFO - 'run-tests'), 12:17:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:17:26 INFO - 'download_minidump_stackwalk': True, 12:17:26 INFO - 'download_symbols': 'ondemand', 12:17:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:17:26 INFO - 'tooltool.py': '/tools/tooltool.py', 12:17:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:17:26 INFO - '/tools/misc-python/virtualenv.py')}, 12:17:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:17:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:17:26 INFO - 'installer_path': 'installer.exe', 12:17:26 INFO - 'log_level': 'info', 12:17:26 INFO - 'log_name': 'talos', 12:17:26 INFO - 'log_to_console': True, 12:17:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:17:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:17:26 INFO - 'opt_config_files': (), 12:17:26 INFO - 'pip_index': False, 12:17:26 INFO - 'sps_profile': False, 12:17:26 INFO - 'sps_profile_interval': 0, 12:17:26 INFO - 'suite': 'dromaeojs-e10s', 12:17:26 INFO - 'system_bits': '32', 12:17:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:17:26 INFO - 'title': 'talos-linux64-ix-069', 12:17:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:17:26 INFO - 'use_talos_json': True, 12:17:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:17:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:17:26 INFO - 'work_dir': 'build'} 12:17:26 INFO - [mozharness: 2016-08-24 19:17:26.252391Z] Running clobber step. 12:17:26 INFO - Running pre-action listener: _resource_record_pre_action 12:17:26 INFO - Running main action method: clobber 12:17:26 INFO - rmtree: /builds/slave/test/build 12:17:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:17:26 INFO - Running post-action listener: _resource_record_post_action 12:17:26 INFO - [mozharness: 2016-08-24 19:17:26.256099Z] Finished clobber step (success) 12:17:26 INFO - [mozharness: 2016-08-24 19:17:26.256195Z] Running read-buildbot-config step. 12:17:26 INFO - Running pre-action listener: _resource_record_pre_action 12:17:26 INFO - Running main action method: read_buildbot_config 12:17:26 INFO - Using buildbot properties: 12:17:26 INFO - { 12:17:26 INFO - "project": "", 12:17:26 INFO - "product": "firefox", 12:17:26 INFO - "script_repo_revision": "production", 12:17:26 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs-e10s", 12:17:26 INFO - "repository": "", 12:17:26 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs-e10s", 12:17:26 INFO - "buildid": "20160824091826", 12:17:26 INFO - "pgo_build": "False", 12:17:26 INFO - "basedir": "/builds/slave/test", 12:17:26 INFO - "buildnumber": 341, 12:17:26 INFO - "slavename": "talos-linux64-ix-069", 12:17:26 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 12:17:26 INFO - "platform": "ubuntu64_hw", 12:17:26 INFO - "scheduler": "tests-autoland-linux64-talos-7-3600", 12:17:26 INFO - "branch": "autoland", 12:17:26 INFO - "repo_path": "integration/autoland", 12:17:26 INFO - "revision": "ff3d89bec675e5a8ceec87b60b9d121f7daa15fb", 12:17:26 INFO - "stage_platform": "linux64", 12:17:26 INFO - "builduid": "3d5081f34d564847bdabb73ac1c01358", 12:17:26 INFO - "slavebuilddir": "test" 12:17:26 INFO - } 12:17:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/GMjyknKaSEuZeRN8SHkKyg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 12:17:26 INFO - Running post-action listener: _resource_record_post_action 12:17:26 INFO - [mozharness: 2016-08-24 19:17:26.258556Z] Finished read-buildbot-config step (success) 12:17:26 INFO - [mozharness: 2016-08-24 19:17:26.258643Z] Running download-and-extract step. 12:17:26 INFO - Running pre-action listener: _resource_record_pre_action 12:17:26 INFO - Running main action method: download_and_extract 12:17:26 INFO - mkdir: /builds/slave/test/build/tests 12:17:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:17:26 INFO - trying https://queue.taskcluster.net/v1/task/GMjyknKaSEuZeRN8SHkKyg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 12:17:26 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 12:17:26 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 12:17:26 INFO - Downloaded 1361 bytes. 12:17:26 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 12:17:26 INFO - Using the following test package requirements: 12:17:26 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 12:17:26 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 12:17:26 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:17:26 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 12:17:26 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 12:17:26 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 12:17:26 INFO - u'jsshell-linux-x86_64.zip'], 12:17:26 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 12:17:26 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:17:26 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 12:17:26 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 12:17:26 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:17:26 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 12:17:26 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:17:26 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 12:17:26 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:17:26 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 12:17:26 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:17:26 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:17:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:17:26 INFO - trying https://queue.taskcluster.net/v1/task/GMjyknKaSEuZeRN8SHkKyg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 12:17:26 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 12:17:26 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 12:17:27 INFO - Downloaded 20324257 bytes. 12:17:27 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 12:17:31 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 12:17:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:17:31 INFO - trying https://queue.taskcluster.net/v1/task/GMjyknKaSEuZeRN8SHkKyg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 12:17:31 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 12:17:31 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 12:17:32 INFO - Downloaded 20324257 bytes. 12:17:32 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 12:17:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:17:37 INFO - trying https://queue.taskcluster.net/v1/task/GMjyknKaSEuZeRN8SHkKyg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 12:17:37 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 12:17:37 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 12:17:38 INFO - Downloaded 14413981 bytes. 12:17:38 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 12:17: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')]} 12:17:38 INFO - trying https://queue.taskcluster.net/v1/task/GMjyknKaSEuZeRN8SHkKyg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 12:17:38 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 12:17:38 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 12:17:39 INFO - Downloaded 55752178 bytes. 12:17:39 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 12:17:39 INFO - mkdir: /builds/slave/test/properties 12:17:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:17:39 INFO - Writing to file /builds/slave/test/properties/build_url 12:17:39 INFO - Contents: 12:17:39 INFO - build_url:https://queue.taskcluster.net/v1/task/GMjyknKaSEuZeRN8SHkKyg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 12:17:40 INFO - Running post-action listener: _resource_record_post_action 12:17:40 INFO - Running post-action listener: set_extra_try_arguments 12:17:40 INFO - [mozharness: 2016-08-24 19:17:40.216163Z] Finished download-and-extract step (success) 12:17:40 INFO - [mozharness: 2016-08-24 19:17:40.216456Z] Running populate-webroot step. 12:17:40 INFO - Running pre-action listener: _resource_record_pre_action 12:17:40 INFO - Running main action method: populate_webroot 12:17:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:17:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:17:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:17:40 INFO - '--tppagecycles', 12:17:40 INFO - '7'], 12:17:40 INFO - 'tests': ['tsvgm']}}, 12:17:40 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:17:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:17:40 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:17:40 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:17:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:17:40 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:17:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:17:40 INFO - 'talos_options': ['--disable-e10s'], 12:17:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:17:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:17:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:17:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:17:40 INFO - 'talos_options': ['--disable-e10s'], 12:17:40 INFO - 'tests': ['damp', 'tps']}, 12:17:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:17:40 INFO - 'tests': ['damp', 'tps']}, 12:17:40 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:17:40 INFO - 'tests': ['dromaeo_dom']}, 12:17:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:17:40 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:17:40 INFO - 'tests': ['basic_compositor_video']}, 12:17:40 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:17:40 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:17:40 INFO - 'tests': ['a11yr', 12:17:40 INFO - 'ts_paint', 12:17:40 INFO - 'tpaint', 12:17:40 INFO - 'sessionrestore', 12:17:40 INFO - 'sessionrestore_no_auto_restore', 12:17:40 INFO - 'tabpaint']}, 12:17:40 INFO - 'other-e10s': {'tests': ['a11yr', 12:17:40 INFO - 'ts_paint', 12:17:40 INFO - 'tpaint', 12:17:40 INFO - 'sessionrestore', 12:17:40 INFO - 'sessionrestore_no_auto_restore', 12:17:40 INFO - 'tabpaint']}, 12:17:40 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:17:40 INFO - 'ts_paint', 12:17:40 INFO - 'tpaint', 12:17:40 INFO - 'sessionrestore', 12:17:40 INFO - 'sessionrestore_no_auto_restore', 12:17:40 INFO - 'tabpaint']}, 12:17:40 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:17:40 INFO - 'ts_paint', 12:17:40 INFO - 'tpaint', 12:17:40 INFO - 'sessionrestore', 12:17:40 INFO - 'sessionrestore_no_auto_restore', 12:17:40 INFO - 'tabpaint']}, 12:17:40 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:17:40 INFO - 'tests': ['a11yr', 12:17:40 INFO - 'ts_paint', 12:17:40 INFO - 'tpaint', 12:17:40 INFO - 'sessionrestore', 12:17:40 INFO - 'sessionrestore_no_auto_restore', 12:17:40 INFO - 'tabpaint']}, 12:17:40 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:17:40 INFO - 'tests': ['a11yr', 12:17:40 INFO - 'ts_paint', 12:17:40 INFO - 'tpaint', 12:17:40 INFO - 'sessionrestore', 12:17:40 INFO - 'sessionrestore_no_auto_restore', 12:17:40 INFO - 'tabpaint']}, 12:17:40 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:17:40 INFO - 'tests': ['tsvgx', 12:17:40 INFO - 'tsvgr_opacity', 12:17:40 INFO - 'tart', 12:17:40 INFO - 'tscrollx', 12:17:40 INFO - 'cart']}, 12:17:40 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:17:40 INFO - 'tsvgr_opacity', 12:17:40 INFO - 'tart', 12:17:40 INFO - 'tscrollx', 12:17:40 INFO - 'cart']}, 12:17:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:17:40 INFO - 'talos_options': ['--disable-e10s'], 12:17:40 INFO - 'tests': ['tp5o']}, 12:17:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:17:40 INFO - 'tests': ['tp5o']}, 12:17:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:17:40 INFO - 'talos_options': ['--disable-e10s', 12:17:40 INFO - '--xperf_path', 12:17:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:17:40 INFO - 'tests': ['tp5n']}, 12:17:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:17:40 INFO - 'talos_options': ['--xperf_path', 12:17:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:17:40 INFO - 'tests': ['tp5n']}}, 12:17:40 INFO - 'talos.zip': {'path': '', 12:17:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:17:40 INFO - Running post-action listener: _resource_record_post_action 12:17:40 INFO - [mozharness: 2016-08-24 19:17:40.232951Z] Finished populate-webroot step (success) 12:17:40 INFO - [mozharness: 2016-08-24 19:17:40.233043Z] Running create-virtualenv step. 12:17:40 INFO - Running pre-action listener: _resource_record_pre_action 12:17:40 INFO - Running main action method: create_virtualenv 12:17:40 INFO - Creating virtualenv /builds/slave/test/build/venv 12:17:40 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 12:17:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:17:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:17:40 INFO - Using real prefix '/usr' 12:17:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:17:40 INFO - Installing distribute.............................................................................................................................................................................................done. 12:17:42 INFO - Installing pip.................done. 12:17:42 INFO - Return code: 0 12:17:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:17:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:17:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:17:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:17:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:17:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:42 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 0x7f8a648fcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c93230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c8d090>, '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 0x2c909b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c90e40>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1472061355.267774-331982381', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:17:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 12:17:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 12:17:42 INFO - Using env: {'DISPLAY': ':0', 12:17:42 INFO - 'HOME': '/home/cltbld', 12:17:42 INFO - 'LANG': 'en_US.UTF-8', 12:17:42 INFO - 'LANGUAGE': 'en_US:en', 12:17:42 INFO - 'LOGNAME': 'cltbld', 12:17:42 INFO - 'MAIL': '/var/mail/cltbld', 12:17:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:17:42 INFO - 'MOZ_NO_REMOTE': '1', 12:17:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:17:42 INFO - 'NO_EM_RESTART': '1', 12:17:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:17:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:17:42 INFO - 'PWD': '/builds/slave/test', 12:17:42 INFO - 'SHELL': '/bin/bash', 12:17:42 INFO - 'SHLVL': '1', 12:17:42 INFO - 'TERM': 'linux', 12:17:42 INFO - 'TMOUT': '86400', 12:17:42 INFO - 'USER': 'cltbld', 12:17:42 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1472061355.267774-331982381', 12:17:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:17:42 INFO - '_': '/tools/buildbot/bin/python'} 12:17:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:17:43 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 12:17:43 INFO - Cleaning up... 12:17:43 INFO - Return code: 0 12:17:43 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:17:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:17:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:17:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:17:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:17:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:43 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 0x7f8a648fcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c93230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c8d090>, '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 0x2c909b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c90e40>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1472061355.267774-331982381', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:17:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 12:17:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 12:17:43 INFO - Using env: {'DISPLAY': ':0', 12:17:43 INFO - 'HOME': '/home/cltbld', 12:17:43 INFO - 'LANG': 'en_US.UTF-8', 12:17:43 INFO - 'LANGUAGE': 'en_US:en', 12:17:43 INFO - 'LOGNAME': 'cltbld', 12:17:43 INFO - 'MAIL': '/var/mail/cltbld', 12:17:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:17:43 INFO - 'MOZ_NO_REMOTE': '1', 12:17:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:17:43 INFO - 'NO_EM_RESTART': '1', 12:17:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:17:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:17:43 INFO - 'PWD': '/builds/slave/test', 12:17:43 INFO - 'SHELL': '/bin/bash', 12:17:43 INFO - 'SHLVL': '1', 12:17:43 INFO - 'TERM': 'linux', 12:17:43 INFO - 'TMOUT': '86400', 12:17:43 INFO - 'USER': 'cltbld', 12:17:43 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1472061355.267774-331982381', 12:17:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:17:43 INFO - '_': '/tools/buildbot/bin/python'} 12:17:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:17:43 INFO - Downloading/unpacking psutil>=3.1.1 12:17: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 12:17: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 12:17: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 12:17: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 12:17: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 12:17: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 12:17:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:17:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:17:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:17:45 INFO - Installing collected packages: psutil 12:17:45 INFO - Running setup.py install for psutil 12:17:45 INFO - building 'psutil._psutil_linux' extension 12:17:45 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 12:17:45 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 12:17:45 INFO - building 'psutil._psutil_posix' extension 12:17:45 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 12:17:45 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 12:17:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:17:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:17:45 INFO - Successfully installed psutil 12:17:45 INFO - Cleaning up... 12:17:45 INFO - Return code: 0 12:17:45 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:17: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')]} 12:17:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:17:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17: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')]} 12:17:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:17:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:45 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 0x7f8a648fcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c93230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c8d090>, '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 0x2c909b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c90e40>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1472061355.267774-331982381', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:17:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 12:17:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 12:17:45 INFO - Using env: {'DISPLAY': ':0', 12:17:45 INFO - 'HOME': '/home/cltbld', 12:17:45 INFO - 'LANG': 'en_US.UTF-8', 12:17:45 INFO - 'LANGUAGE': 'en_US:en', 12:17:45 INFO - 'LOGNAME': 'cltbld', 12:17:45 INFO - 'MAIL': '/var/mail/cltbld', 12:17:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:17:45 INFO - 'MOZ_NO_REMOTE': '1', 12:17:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:17:45 INFO - 'NO_EM_RESTART': '1', 12:17:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:17:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:17:45 INFO - 'PWD': '/builds/slave/test', 12:17:45 INFO - 'SHELL': '/bin/bash', 12:17:45 INFO - 'SHLVL': '1', 12:17:45 INFO - 'TERM': 'linux', 12:17:45 INFO - 'TMOUT': '86400', 12:17:45 INFO - 'USER': 'cltbld', 12:17:45 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1472061355.267774-331982381', 12:17:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:17:45 INFO - '_': '/tools/buildbot/bin/python'} 12:17:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:17:46 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:17:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:17:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:17:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:17:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:17:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:17:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:17:47 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:17:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:17:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:17:47 INFO - Installing collected packages: mozsystemmonitor 12:17:47 INFO - Running setup.py install for mozsystemmonitor 12:17:48 INFO - Successfully installed mozsystemmonitor 12:17:48 INFO - Cleaning up... 12:17:48 INFO - Return code: 0 12:17:48 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:17: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')]} 12:17:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:17:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17: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')]} 12:17:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:17:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:48 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 0x7f8a648fcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c93230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c8d090>, '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 0x2c909b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c90e40>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1472061355.267774-331982381', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:17:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 12:17:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 12:17:48 INFO - Using env: {'DISPLAY': ':0', 12:17:48 INFO - 'HOME': '/home/cltbld', 12:17:48 INFO - 'LANG': 'en_US.UTF-8', 12:17:48 INFO - 'LANGUAGE': 'en_US:en', 12:17:48 INFO - 'LOGNAME': 'cltbld', 12:17:48 INFO - 'MAIL': '/var/mail/cltbld', 12:17:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:17:48 INFO - 'MOZ_NO_REMOTE': '1', 12:17:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:17:48 INFO - 'NO_EM_RESTART': '1', 12:17:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:17:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:17:48 INFO - 'PWD': '/builds/slave/test', 12:17:48 INFO - 'SHELL': '/bin/bash', 12:17:48 INFO - 'SHLVL': '1', 12:17:48 INFO - 'TERM': 'linux', 12:17:48 INFO - 'TMOUT': '86400', 12:17:48 INFO - 'USER': 'cltbld', 12:17:48 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1472061355.267774-331982381', 12:17:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:17:48 INFO - '_': '/tools/buildbot/bin/python'} 12:17:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:17:48 INFO - Downloading/unpacking jsonschema==2.5.1 12:17:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:17:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:17:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:17:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:17:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:17:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:17:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:17:50 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:17:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:17:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:17:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:17:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:17:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:17:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:17:50 INFO - Downloading functools32-3.2.3-2.tar.gz 12:17:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:17:50 INFO - warning: no files found matching '*.txt' 12:17:50 INFO - no previously-included directories found matching 'build' 12:17:50 INFO - no previously-included directories found matching 'dist' 12:17:50 INFO - no previously-included directories found matching '.git*' 12:17:50 INFO - Installing collected packages: jsonschema, functools32 12:17:50 INFO - Running setup.py install for functools32 12:17:50 INFO - warning: no files found matching '*.txt' 12:17:50 INFO - no previously-included directories found matching 'build' 12:17:50 INFO - no previously-included directories found matching 'dist' 12:17:50 INFO - no previously-included directories found matching '.git*' 12:17:50 INFO - Successfully installed jsonschema functools32 12:17:50 INFO - Cleaning up... 12:17:50 INFO - Return code: 0 12:17:50 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:17:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:17:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:17:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:17:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:17:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f8a648fcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c93230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c8d090>, '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 0x2c909b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c90e40>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1472061355.267774-331982381', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:17:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 12:17:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 12:17:50 INFO - Using env: {'DISPLAY': ':0', 12:17:50 INFO - 'HOME': '/home/cltbld', 12:17:50 INFO - 'LANG': 'en_US.UTF-8', 12:17:50 INFO - 'LANGUAGE': 'en_US:en', 12:17:50 INFO - 'LOGNAME': 'cltbld', 12:17:50 INFO - 'MAIL': '/var/mail/cltbld', 12:17:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:17:50 INFO - 'MOZ_NO_REMOTE': '1', 12:17:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:17:50 INFO - 'NO_EM_RESTART': '1', 12:17:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:17:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:17:50 INFO - 'PWD': '/builds/slave/test', 12:17:50 INFO - 'SHELL': '/bin/bash', 12:17:50 INFO - 'SHLVL': '1', 12:17:50 INFO - 'TERM': 'linux', 12:17:50 INFO - 'TMOUT': '86400', 12:17:50 INFO - 'USER': 'cltbld', 12:17:50 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1472061355.267774-331982381', 12:17:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:17:50 INFO - '_': '/tools/buildbot/bin/python'} 12:17:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:17:50 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:17:50 INFO - Cleaning up... 12:17:50 INFO - Return code: 0 12:17:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:17:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:17:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:17:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:17:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:17:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f8a648fcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c93230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c8d090>, '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 0x2c909b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c90e40>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1472061355.267774-331982381', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:17:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:17:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 12:17:50 INFO - Using env: {'DISPLAY': ':0', 12:17:50 INFO - 'HOME': '/home/cltbld', 12:17:50 INFO - 'LANG': 'en_US.UTF-8', 12:17:50 INFO - 'LANGUAGE': 'en_US:en', 12:17:50 INFO - 'LOGNAME': 'cltbld', 12:17:50 INFO - 'MAIL': '/var/mail/cltbld', 12:17:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:17:50 INFO - 'MOZ_NO_REMOTE': '1', 12:17:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:17:50 INFO - 'NO_EM_RESTART': '1', 12:17:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:17:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:17:50 INFO - 'PWD': '/builds/slave/test', 12:17:50 INFO - 'SHELL': '/bin/bash', 12:17:50 INFO - 'SHLVL': '1', 12:17:50 INFO - 'TERM': 'linux', 12:17:50 INFO - 'TMOUT': '86400', 12:17:50 INFO - 'USER': 'cltbld', 12:17:50 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1472061355.267774-331982381', 12:17:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:17:50 INFO - '_': '/tools/buildbot/bin/python'} 12:17:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:17:51 INFO - Downloading/unpacking blobuploader==1.2.4 12:17:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:17:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:17:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:17:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:17:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:17:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:17:53 INFO - Downloading blobuploader-1.2.4.tar.gz 12:17:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:17:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:17:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:17:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:17:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:17:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:17:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:17:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:17:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:17:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:17:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:17:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:17:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:17:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:17:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:17:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:17:53 INFO - Downloading docopt-0.6.1.tar.gz 12:17:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:17:53 INFO - Installing collected packages: blobuploader, requests, docopt 12:17:53 INFO - Running setup.py install for blobuploader 12:17:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:17:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:17:53 INFO - Running setup.py install for requests 12:17:54 INFO - Running setup.py install for docopt 12:17:54 INFO - Successfully installed blobuploader requests docopt 12:17:54 INFO - Cleaning up... 12:17:54 INFO - Return code: 0 12:17:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:17:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:17:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:17:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:17:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:17:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:54 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 0x7f8a648fcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c93230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c8d090>, '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 0x2c909b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c90e40>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1472061355.267774-331982381', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:17:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 12:17:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:17:54 INFO - Using env: {'DISPLAY': ':0', 12:17:54 INFO - 'HOME': '/home/cltbld', 12:17:54 INFO - 'LANG': 'en_US.UTF-8', 12:17:54 INFO - 'LANGUAGE': 'en_US:en', 12:17:54 INFO - 'LOGNAME': 'cltbld', 12:17:54 INFO - 'MAIL': '/var/mail/cltbld', 12:17:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:17:54 INFO - 'MOZ_NO_REMOTE': '1', 12:17:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:17:54 INFO - 'NO_EM_RESTART': '1', 12:17:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:17:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:17:54 INFO - 'PWD': '/builds/slave/test', 12:17:54 INFO - 'SHELL': '/bin/bash', 12:17:54 INFO - 'SHLVL': '1', 12:17:54 INFO - 'TERM': 'linux', 12:17:54 INFO - 'TMOUT': '86400', 12:17:54 INFO - 'USER': 'cltbld', 12:17:54 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1472061355.267774-331982381', 12:17:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:17:54 INFO - '_': '/tools/buildbot/bin/python'} 12:17:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:17:54 INFO - Running setup.py (path:/tmp/pip-u79SRC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:17:54 INFO - Running setup.py (path:/tmp/pip-_bjERU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:17:54 INFO - Running setup.py (path:/tmp/pip-aZdgFJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:17:54 INFO - Running setup.py (path:/tmp/pip-9FZoG8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:17:54 INFO - Running setup.py (path:/tmp/pip-aulVAt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:17:55 INFO - Running setup.py (path:/tmp/pip-pkZ75r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:17:55 INFO - Running setup.py (path:/tmp/pip-50fBf8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:17:55 INFO - Running setup.py (path:/tmp/pip-j0nfhZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:17:55 INFO - Running setup.py (path:/tmp/pip-qFlMpg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:17:55 INFO - Running setup.py (path:/tmp/pip-rrKqfn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:17:55 INFO - Running setup.py (path:/tmp/pip-2yYHxc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:17:55 INFO - Running setup.py (path:/tmp/pip-_rOTXb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:17:55 INFO - Running setup.py (path:/tmp/pip-0fUGXo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:17:55 INFO - Running setup.py (path:/tmp/pip-MM9G7W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:17:55 INFO - Running setup.py (path:/tmp/pip-_lG8i6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:17:55 INFO - Running setup.py (path:/tmp/pip-oukLGD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:17:55 INFO - Running setup.py (path:/tmp/pip-LPN9os-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:17:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:17:55 INFO - Running setup.py install for manifestparser 12:17:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:17:56 INFO - Running setup.py install for mozcrash 12:17:56 INFO - Running setup.py install for mozdebug 12:17:56 INFO - Running setup.py install for mozdevice 12:17:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:17:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:17:56 INFO - Running setup.py install for mozfile 12:17:56 INFO - Running setup.py install for mozhttpd 12:17:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:17:56 INFO - Running setup.py install for mozinfo 12:17:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:17:56 INFO - Running setup.py install for mozInstall 12:17:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:17:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:17:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:17:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:17:56 INFO - Running setup.py install for mozleak 12:17:56 INFO - Running setup.py install for mozlog 12:17:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:17:56 INFO - Running setup.py install for moznetwork 12:17:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:17:57 INFO - Running setup.py install for mozprocess 12:17:57 INFO - Running setup.py install for mozprofile 12:17:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:17:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:17:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:17:57 INFO - Running setup.py install for mozrunner 12:17:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:17:57 INFO - Running setup.py install for mozscreenshot 12:17:57 INFO - Running setup.py install for moztest 12:17:57 INFO - Running setup.py install for mozversion 12:17:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:17:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:17:57 INFO - Cleaning up... 12:17:57 INFO - Return code: 0 12:17:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:17:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:17:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:17:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:17:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:17:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:57 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 0x7f8a648fcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c93230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c8d090>, '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 0x2c909b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c90e40>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1472061355.267774-331982381', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:17:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 12:17:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:17:57 INFO - Using env: {'DISPLAY': ':0', 12:17:57 INFO - 'HOME': '/home/cltbld', 12:17:57 INFO - 'LANG': 'en_US.UTF-8', 12:17:57 INFO - 'LANGUAGE': 'en_US:en', 12:17:57 INFO - 'LOGNAME': 'cltbld', 12:17:57 INFO - 'MAIL': '/var/mail/cltbld', 12:17:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:17:57 INFO - 'MOZ_NO_REMOTE': '1', 12:17:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:17:57 INFO - 'NO_EM_RESTART': '1', 12:17:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:17:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:17:57 INFO - 'PWD': '/builds/slave/test', 12:17:57 INFO - 'SHELL': '/bin/bash', 12:17:57 INFO - 'SHLVL': '1', 12:17:57 INFO - 'TERM': 'linux', 12:17:57 INFO - 'TMOUT': '86400', 12:17:57 INFO - 'USER': 'cltbld', 12:17:57 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1472061355.267774-331982381', 12:17:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:17:57 INFO - '_': '/tools/buildbot/bin/python'} 12:17:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:17:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:17:57 INFO - Running setup.py (path:/tmp/pip-NldkIE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:17:57 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 12:17:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:17:57 INFO - Running setup.py (path:/tmp/pip-QdLIq8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:17:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:17:58 INFO - Running setup.py (path:/tmp/pip-VFtddN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:17:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 12:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:17:58 INFO - Running setup.py (path:/tmp/pip-uMwAYo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:17:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:17:58 INFO - Running setup.py (path:/tmp/pip-Bsz_9t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:17:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 12:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:17:58 INFO - Running setup.py (path:/tmp/pip-CIJhCw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:17:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 12:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:17:58 INFO - Running setup.py (path:/tmp/pip-m4AhSA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:17:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 12:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:17:58 INFO - Running setup.py (path:/tmp/pip-GkLb_n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:17:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 12:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:17:58 INFO - Running setup.py (path:/tmp/pip-Jj5jNY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:17:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 12:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:17:58 INFO - Running setup.py (path:/tmp/pip-1rloF9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:17:58 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)) 12:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:17:58 INFO - Running setup.py (path:/tmp/pip-qOon97-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:17:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 12:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:17:58 INFO - Running setup.py (path:/tmp/pip-r8e9JA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:17:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 12:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:17:58 INFO - Running setup.py (path:/tmp/pip-XGthNO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:17:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 12:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:17:58 INFO - Running setup.py (path:/tmp/pip-HfMGE5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:17:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 12:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:17:58 INFO - Running setup.py (path:/tmp/pip-m3hY9X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:17:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 12:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:17:59 INFO - Running setup.py (path:/tmp/pip-C30S7T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:17:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 12:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:17:59 INFO - Running setup.py (path:/tmp/pip-UIgn_4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:17:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 12:17:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:17:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:17:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 12:17:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:17:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:17:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:17:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:17:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:17:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:17:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:17:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:17:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:18:01 INFO - Downloading blessings-1.6.tar.gz 12:18:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:18:01 INFO - Installing collected packages: blessings 12:18:01 INFO - Running setup.py install for blessings 12:18:01 INFO - Successfully installed blessings 12:18:01 INFO - Cleaning up... 12:18:01 INFO - Return code: 0 12:18:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:18:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:18:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:18:01 INFO - Reading from file tmpfile_stdout 12:18:01 INFO - Current package versions: 12:18:01 INFO - argparse == 1.2.1 12:18:01 INFO - blessings == 1.6 12:18:01 INFO - blobuploader == 1.2.4 12:18:01 INFO - docopt == 0.6.1 12:18:01 INFO - functools32 == 3.2.3-2 12:18:01 INFO - jsonschema == 2.5.1 12:18:01 INFO - manifestparser == 1.1 12:18:01 INFO - mozInstall == 1.12 12:18:01 INFO - mozcrash == 0.17 12:18:01 INFO - mozdebug == 0.1 12:18:01 INFO - mozdevice == 0.48 12:18:01 INFO - mozfile == 1.2 12:18:01 INFO - mozhttpd == 0.7 12:18:01 INFO - mozinfo == 0.9 12:18:01 INFO - mozleak == 0.1 12:18:01 INFO - mozlog == 3.3 12:18:01 INFO - moznetwork == 0.27 12:18:01 INFO - mozprocess == 0.23 12:18:01 INFO - mozprofile == 0.28 12:18:01 INFO - mozrunner == 6.12 12:18:01 INFO - mozscreenshot == 0.1 12:18:01 INFO - mozsystemmonitor == 0.3 12:18:01 INFO - moztest == 0.7 12:18:01 INFO - mozversion == 1.4 12:18:01 INFO - psutil == 3.1.1 12:18:01 INFO - requests == 1.2.3 12:18:01 INFO - wsgiref == 0.1.2 12:18:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:18:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:18:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:18:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:18:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:18:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18:01 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 0x7f8a648fcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c93230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c8d090>, '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 0x2c909b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c90e40>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1472061355.267774-331982381', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:18:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 12:18:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:18:01 INFO - Using env: {'DISPLAY': ':0', 12:18:01 INFO - 'HOME': '/home/cltbld', 12:18:01 INFO - 'LANG': 'en_US.UTF-8', 12:18:01 INFO - 'LANGUAGE': 'en_US:en', 12:18:01 INFO - 'LOGNAME': 'cltbld', 12:18:01 INFO - 'MAIL': '/var/mail/cltbld', 12:18:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:18:01 INFO - 'MOZ_NO_REMOTE': '1', 12:18:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:18:01 INFO - 'NO_EM_RESTART': '1', 12:18:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:18:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:18:01 INFO - 'PWD': '/builds/slave/test', 12:18:01 INFO - 'SHELL': '/bin/bash', 12:18:01 INFO - 'SHLVL': '1', 12:18:01 INFO - 'TERM': 'linux', 12:18:01 INFO - 'TMOUT': '86400', 12:18:01 INFO - 'USER': 'cltbld', 12:18:01 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1472061355.267774-331982381', 12:18:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:18:01 INFO - '_': '/tools/buildbot/bin/python'} 12:18:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:18:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 12:18:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 12:18:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 12:18:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 12:18:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 12:18:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 12:18:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 12:18:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 12:18:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 12:18:01 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 12:18:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 12:18:01 INFO - Cleaning up... 12:18:01 INFO - Return code: 0 12:18:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:18:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:18:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:18:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:18:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:18:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18:01 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 0x7f8a648fcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c93230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c8d090>, '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 0x2c909b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c90e40>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1472061355.267774-331982381', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:18:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 12:18:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 12:18:01 INFO - Using env: {'DISPLAY': ':0', 12:18:01 INFO - 'HOME': '/home/cltbld', 12:18:01 INFO - 'LANG': 'en_US.UTF-8', 12:18:01 INFO - 'LANGUAGE': 'en_US:en', 12:18:01 INFO - 'LOGNAME': 'cltbld', 12:18:01 INFO - 'MAIL': '/var/mail/cltbld', 12:18:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:18:01 INFO - 'MOZ_NO_REMOTE': '1', 12:18:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:18:01 INFO - 'NO_EM_RESTART': '1', 12:18:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:18:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:18:01 INFO - 'PWD': '/builds/slave/test', 12:18:01 INFO - 'SHELL': '/bin/bash', 12:18:01 INFO - 'SHLVL': '1', 12:18:01 INFO - 'TERM': 'linux', 12:18:01 INFO - 'TMOUT': '86400', 12:18:01 INFO - 'USER': 'cltbld', 12:18:01 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1472061355.267774-331982381', 12:18:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:18:01 INFO - '_': '/tools/buildbot/bin/python'} 12:18:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:18:01 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:18:01 INFO - Cleaning up... 12:18:01 INFO - Return code: 0 12:18:01 INFO - Running post-action listener: _resource_record_post_action 12:18:01 INFO - Running post-action listener: _start_resource_monitoring 12:18:01 INFO - Starting resource monitoring. 12:18:01 INFO - [mozharness: 2016-08-24 19:18:01.978645Z] Finished create-virtualenv step (success) 12:18:01 INFO - [mozharness: 2016-08-24 19:18:01.979108Z] Running install step. 12:18:01 INFO - Running pre-action listener: _resource_record_pre_action 12:18:01 INFO - Running main action method: install 12:18:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:18:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:18:02 INFO - Reading from file tmpfile_stdout 12:18:02 INFO - Detecting whether we're running mozinstall >=1.0... 12:18:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:18:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:18:02 INFO - Reading from file tmpfile_stdout 12:18:02 INFO - Output received: 12:18:02 INFO - Usage: mozinstall [options] installer 12:18:02 INFO - Options: 12:18:02 INFO - -h, --help show this help message and exit 12:18:02 INFO - -d DEST, --destination=DEST 12:18:02 INFO - Directory to install application into. [default: 12:18:02 INFO - "/builds/slave/test"] 12:18:02 INFO - --app=APP Application being installed. [default: firefox] 12:18:02 INFO - mkdir: /builds/slave/test/build/application 12:18:02 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'] 12:18:02 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 12:18:18 INFO - Reading from file tmpfile_stdout 12:18:18 INFO - Output received: 12:18:18 INFO - /builds/slave/test/build/application/firefox/firefox 12:18:18 INFO - Running post-action listener: _resource_record_post_action 12:18:18 INFO - [mozharness: 2016-08-24 19:18:18.341775Z] Finished install step (success) 12:18:18 INFO - [mozharness: 2016-08-24 19:18:18.342021Z] Running run-tests step. 12:18:18 INFO - Running pre-action listener: _resource_record_pre_action 12:18:18 INFO - Running main action method: run_tests 12:18:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:18:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:18:18 INFO - Python 2.7.3 12:18:18 INFO - Return code: 0 12:18:18 INFO - grabbing minidump binary from tooltool 12:18:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:18:18 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 0x2c8d090>, '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 0x2c909b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c90e40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:18:18 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 12:18:18 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 12:18:18 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 12:18:18 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:18:18 INFO - Return code: 0 12:18:18 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:18:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:18:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:18:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:18:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:18:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GMjyknKaSEuZeRN8SHkKyg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 12:18:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GMjyknKaSEuZeRN8SHkKyg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-069 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 12:18:18 INFO - Using env: {'DISPLAY': ':0', 12:18:18 INFO - 'HOME': '/home/cltbld', 12:18:18 INFO - 'LANG': 'en_US.UTF-8', 12:18:18 INFO - 'LANGUAGE': 'en_US:en', 12:18:18 INFO - 'LOGNAME': 'cltbld', 12:18:18 INFO - 'MAIL': '/var/mail/cltbld', 12:18:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:18:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:18:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:18:18 INFO - 'MOZ_NO_REMOTE': '1', 12:18:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:18:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:18:18 INFO - 'NO_EM_RESTART': '1', 12:18:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:18:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:18:18 INFO - 'PWD': '/builds/slave/test', 12:18:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:18:18 INFO - 'SHELL': '/bin/bash', 12:18:18 INFO - 'SHLVL': '1', 12:18:18 INFO - 'TERM': 'linux', 12:18:18 INFO - 'TMOUT': '86400', 12:18:18 INFO - 'USER': 'cltbld', 12:18:18 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1472061355.267774-331982381', 12:18:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:18:18 INFO - '_': '/tools/buildbot/bin/python'} 12:18:18 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GMjyknKaSEuZeRN8SHkKyg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 12:18:18 INFO - mozversion application_buildid: 20160824091826 12:18:18 INFO - mozversion application_changeset: ff3d89bec675e5a8ceec87b60b9d121f7daa15fb 12:18:18 INFO - mozversion application_display_name: Nightly 12:18:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:18:18 INFO - mozversion application_name: Firefox 12:18:18 INFO - mozversion application_remotingname: firefox 12:18:18 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 12:18:18 INFO - mozversion application_vendor: Mozilla 12:18:18 INFO - mozversion application_version: 51.0a1 12:18:18 INFO - mozversion platform_buildid: 20160824091826 12:18:18 INFO - mozversion platform_changeset: ff3d89bec675e5a8ceec87b60b9d121f7daa15fb 12:18:18 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 12:18:18 INFO - mozversion platform_version: 51.0a1 12:18:18 INFO - using testdate: 1472066298 12:18:18 INFO - actual date: 1472066298 12:18:18 INFO - starting webserver on 'localhost:57447' 12:18:18 INFO - SUITE-START | Running 2 tests 12:18:18 INFO - TEST-START | dromaeo_css 12:18:18 INFO - operating with platform_type : linux_ 12:18:18 INFO - Initialising browser for dromaeo_css test... 12:18:18 INFO - TEST-INFO | started process 6116 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7mgOMX/profile http://localhost:57447/getInfo.html) 12:18:23 INFO - PROCESS | 6116 | __metrics Screen width/height:1600/1200 12:18:23 INFO - PROCESS | 6116 | colorDepth:24 12:18:23 INFO - PROCESS | 6116 | Browser inner width/height: 1024/697 12:18:23 INFO - PROCESS | 6116 | __metrics 12:18:24 ERROR - PROCESS | 6116 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2991: TypeError: this.tabs is undefined 12:18:25 INFO - TEST-INFO | 6116: exit 0 12:18:25 INFO - Browser initialized. 12:18:25 INFO - Running cycle 1/1 for dromaeo_css test... 12:18:25 INFO - TEST-INFO | started process 6238 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7mgOMX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:18:37 INFO - PROCESS | 6238 | RSS: Main: 192372736 12:18:37 INFO - PROCESS | 6238 | 12:19:27 INFO - PROCESS | 6238 | 1472066367486 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 12:21:40 INFO - PROCESS | 6238 | Cycle 1(1): loaded http://localhost:57447/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57447/tests/dromaeo/cssquery-ext.html) 12:21:41 INFO - PROCESS | 6238 | RSS: Main: 212758528 12:21:41 INFO - PROCESS | 6238 | 12:24:43 INFO - PROCESS | 6238 | Cycle 1(1): loaded http://localhost:57447/tests/dromaeo/cssquery-ext.html (next: http://localhost:57447/tests/dromaeo/cssquery-jquery.html) 12:24:44 INFO - PROCESS | 6238 | RSS: Main: 206307328 12:24:44 INFO - PROCESS | 6238 | 12:27:46 INFO - PROCESS | 6238 | Cycle 1(1): loaded http://localhost:57447/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57447/tests/dromaeo/cssquery-mootools.html) 12:27:47 INFO - PROCESS | 6238 | RSS: Main: 204857344 12:27:47 INFO - PROCESS | 6238 | 12:30:49 INFO - PROCESS | 6238 | Cycle 1(1): loaded http://localhost:57447/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57447/tests/dromaeo/cssquery-prototype.html) 12:30:49 INFO - PROCESS | 6238 | RSS: Main: 196538368 12:30:49 INFO - PROCESS | 6238 | 12:33:52 INFO - PROCESS | 6238 | Cycle 1(1): loaded http://localhost:57447/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57447/tests/dromaeo/cssquery-yui.html) 12:33:53 INFO - PROCESS | 6238 | RSS: Main: 198766592 12:33:53 INFO - PROCESS | 6238 | 12:36:55 INFO - PROCESS | 6238 | Cycle 1(1): loaded http://localhost:57447/tests/dromaeo/cssquery-yui.html (next: http://localhost:57447/tests/dromaeo/cssquery-dojo.html) 12:36:56 INFO - PROCESS | 6238 | RSS: Main: 200089600 12:36:56 INFO - PROCESS | 6238 | 12:36:56 INFO - PROCESS | 6238 | __start_tp_report 12:36:56 INFO - PROCESS | 6238 | _x_x_mozilla_page_load 12:36:56 INFO - PROCESS | 6238 | _x_x_mozilla_page_load_details 12:36:56 INFO - PROCESS | 6238 | |i|pagename|runs| 12:36:56 INFO - PROCESS | 6238 | |0;dojo.html;2604.414006848459;2619;2641.5509363408223;2641.5773476243803;2655.163623458609;4598.70108442951;4622.260438329868;4664.673472856902;4700.1539722849875;4714.434267887854;4563.520830312811;4588.770561471922;4611.953880461195;4628.560286772759;4714.929276060861;4209.515905670841;4274.914501709964;4317.266064768981;4319.2441322768545;4428.689991700582;4366.345048242757;4369.97305633176;4374.321980093091;4427.959429534057;4442.2448183808665;4276.037891474424;4299.742015479082;4301.849435269782;4326.4159338489535;4343.04453020335;4296.248156572618;4304.5480224576595;4324.200022995725;4336.56634336567;4383.736975781431;4319.503257125408;4343.67422443318;4345.326474396474;4392.253316936129;4394.36281739146;4616.3537104805355;4644.349791029259;4671.369365135697;4689.062187562467;4818.469968303484;4967.82612608557;4992.87517812054;5008.449070602231;5015.498450154992;5036.7733451994745;4945.8268960586565;5025.246213068032;5035.949640503584;5040.042391945519;5093.592512598983;4684.929726054078;4700;4718.268668356411;4724.007958328721;4774.140654682121;5083.491650834961;5111.003354345867;5121.974390128025;5144.691318520826;5177.58579313654;4857.028594281158;4945.2582112683385;4954.653174277838;4956.752162391866;5007.849764506997;4975.402951645753;4984.501549845059;4988.052270068748;5016.749162541858;5017.623678224148;4944.90110197794;4962.652614316963;4968.677035992649;4988.102141614544;5037.168867136955;4822.614190864722;4969.90060198794;4970.65205435616;4980.178270585386;5022.497750225021;4183.372494125905;4226.725262857904;4245.8513952011535;4249.171411574775;4279.679024073207;3741.7754934704003;3741.9625803741615;3790.166163444038;3791.7914514701406;3835.1562656215588;4329.415528903621;4333.436653235122;4334.537371492076;4357.085012147421;4358.433403657505;4959.305697202394;5040.218766091261;5042.6470147090085;5109.463506331782;5142.04872098663;4285.657147428261;4300.376445415397;4319.157764235943;4331.306990881444;4364.476262848479;4560.657950653648;4565.109803588269;4574.839880604163;4605.03294308199;4618.122556714214;4769.73766442849;4778.856634300976;4780.737059461763;4788.11419887322;4843.4430040545785;4949.034938187019;4982.352294201731;5006.974965125151;5057.747112644427;5069.9746501267255;4669.813207471663;4735.147673418817;4768.117898188846;4768.117898188846;4780.784864681167;4980.203167493184;4981.800727970841;4983.601311894967;5042.773075211698;5045.646804723634;5017.698938063728;5050;5055.342805435417;5056.873578160576;5130.384353877558;4707.19977603815;4873.269009648439;4880.292357608198;4938.358013458371;4939.16034274167;4936.629752768485;4947.109520286383;4947.554720075211;4986.850394488171;5022.372203474566;4801.68789028712;4857.53853383928;4859.878503037311;4895.804167833389;4913.894373765874;4819.518048195152;4875.902481950412;4876.122297986397;4991.750412479289;5052.747362631927;4802.591779698765;4815.277708343637;4822.397200349957;4883.169861123689;4885.218365061573 12:36:56 INFO - PROCESS | 6238 | |1;ext.html;551.8978988887055;552.3978863039287;561.2479277767791;566.9574781891359;571.7884382778371;33820.66179338206;38143.42784858226;38328.233435331276;38355.80822095893;38419;37842.24315513688;37958;38215.80892095536;38309.65916192934;38437.80781096098;7591.9240807591905;7725.18885517021;7739.88390174145;7741.264579864904;7746.8450630987345;7591.924080759177;7601.163871974079;7655.732049378273;7668.309852113337;7677.347425468842;7683.231676832328;7688.730894418696;7714.035745531809;7724.227577242259;7745.496542724705;7581.772546823604;7623.733169339046;7637.389008879276;7675.309222169975;7677.117131529862;7538.434617403716;7619.733309334202;7653.732119375795;7698.884516732253;7716.074071111447;35389.46915796239;35428;35441;35442.8227858859;36070.63929360725;2997.7901546891726;3072.3855228954076;3162.7153556180056;3327.9168020799675;3425.74306926979;27797;27924.86037569799;28423.85788071067;28564.571531427046;29087.709122908713;3427.8971630851115;3440.2431465077643;3443.733721846926;3448.9655103448895;3472.2013936794424;243456;243843;243866;243866;243877.99999999822;30901.8454907724;53234.20148697773;53420.19869701958;53431.19853202205;53611;31085.68914310828;32843;32950;33075.83462082674;33169.83415082909;12266;12315.199512031868;12326.137170398166;12343.444544995496;12361.381930903419;9880.061394167542;9964.402135871871;10008.849867251996;10015.69952901414;10030;7703.8844417333785;7771.300582947561;7792.532448053022;7799.259070388304;7818.843623127505;2993.7904346695523;3004.3690824926575;3004.519276915683;3055.541668749661;3093.7989030713384;767.7888580640368;900.819836032783;921.2814005076051;933.285523616012;987.6888780034266;27272.863635681693;27855.582166267523;27969.440611187663;28347;28586.857065714954;940.6566603189923;949.0651708067548;950.3727539823683;957.1481381570408;969.0793745941243;14117.223552704494;14939.402423903139;14964.501905687212;15036.723614881239;15123.621909452351;387387;391643;394335;394360;395291;48984.265236021485;49544.50455495471;49617.50382496129;49659.25511117336;49787;1105.5080489182396;1119.5745616665615;1133.886611338876;1133.9546418143182;1161.4715304536417;25856;26919.865400672872;27954.602269886833;28103.71896281011;28275.434491309647;42531.57468425276;43010.13979720326;43142.78428607837;43246;43300.35049474324;323379;324878;325046;326286;327790;21148;25041.74958250467;25494.872525637253;25505;25506.362340941625;38258.234835303694;38891.80554097325;38982.22035559216;39007;40391.1921761569;33657.663423365455;33910.321793564486;33984;34675.306493870485;35131.64868351386;33383.666163339025;33704.49443258402;34033.65966340305;34308.14229644279;34789.82605087059;33561;35953.280934380644;36964.44553331756;37068.25863482661;38911.80544097262;29702.851485742434;32611.34777304488;33881.83059084689;34016.14959626029;34372;25015.374615634755;25558.74441255638;25773.484530309663;26141.869290653423;26417 12:36:56 INFO - PROCESS | 6238 | |2;jquery.html;368.2726614935503;370.26317627920446;372.46179270953473;381.0968005826192;384.2411237805335;16075.919620401895;16970.745438818412;17577.736333954985;17722.113894305265;17750.46748597541;15766.842331576681;16224.513264602081;16520.58698532537;16590.585235369123;16635.41776037839;4975.676581022222;5249.238860365244;5258.6581872178185;5259.894802103956;5262.210668399733;3763.303788799081;5196.428392876799;5830.096335068071;6083.726232319534;6111.724972376232;6150.938490615104;6166.414190651881;6167.167432396636;6170.105334726462;6174.8147555573405;5150;5397.62216644835;5440.510354068133;5501.559875209973;5509.669419834822;5232.476752324776;5261.894762104775;5312.867178320535;5315.096433606296;5327.493888080626;12342.629721108382;12666.430010649543;12666.87333126666;12671.619851404472;12679.049071319596;1771.1055916761952;2018.2330714328607;2067.8449116316337;2178.302943058222;2362.9527409451885;9019.729408117766;9092.318076144249;9229.400088994194;9567.617295308179;9644.421334719938;1649.5546202525252;1709.7777288952482;1723.6466524362475;1729.7876988461503;1752.5268177592106;66488.66755666239;66735.3326466734;67526.66236668834;67817;68735;9642.903570964201;9657.565409556586;9983.351082179635;10048.59805607782;10074.194064474825;13341.399637016357;13497.932510337385;13558.186508809504;13567.118137321042;13578.321083945762;6795.898061529081;6843.794686159423;6847.760328388483;7079.610621415769;7141.428685705131;6588.04473351371;6588.176477940257;6633.966830165915;6660.135162154605;6878.8624227516175;4210.473690788652;4230.957690423118;4238.329852193098;4296.656267498593;4360.760158191267;1524.9847501524844;1615.200475764504;1623.5697540151868;1798.6492633936518;1807.7830660320847;805.3637626275294;816.4040250617082;832.3133414932705;896.4800415758845;965.3628605120728;16555.6688866222;17022.914885425493;17044;17146.22841972114;17550.210240539207;843.3506200225914;846.0439703135418;852.377764232114;853.4580541356283;861.4271509446148;9498.715038548855;9644.710658680251;9759.804803904024;10120.595176193017;10130.138938190188;386242;418934;419500;421352;426463;82388;83648;84126.15873841305;86738;87301;875.3959767760352;914.3142643017736;929.0709290709291;941.7692665296909;951.205743204432;15984.680306394039;16039.438619648723;16300.42948496797;16610;16676.416325428552;38025;38407.80796096002;38417.4237386445;39248.607513925635;40720.592794072865;54419.727901361824;56177.43822561722;56214.43785562092;56942;57006.429935700115;6555.967220163869;7781.5331080135375;7877.606119694107;7912.84174316522;7941.166177551274;10173.62656041425;11511.53953841837;12228.510859565518;12405.75188496243;12997.675058123623;10585.470726463493;10915.39965301916;10967.50646220938;11045.944770276097;11066.336019838835;10407.271490995558;10478.63324783629;10559.788804224027;10561.683149505527;10779.19156063314;10810.918908109126;11068.667939961813;11079.501422436171;11210.55157793679;11226.361804975988;7583.5070720403;7584.81037974033;7762.456628036209;7790.298873101448;7961.960190199012;8853.247473964786;10287.279890407599;10560.577576897145;10598.89401105979;11308.151888608223 12:36:56 INFO - PROCESS | 6238 | |3;mootools.html;1229.8585662648795;1264.8924841388482;1325.3174615073237;1635;1637.3205119875252;6763.729450821974;7293.124825020998;7460.776176714694;7914.050313962332;7934.9206507934905;7625.313721765054;7733.806654833632;7734.419918506106;7754.7673569793;7777.183395743436;2170.0560256288527;2177.7168968034134;2202.3392982105383;2210.4473881529616;2213.0373287619855;2174.9891250543724;2202.944926376845;2218.811401030914;2220.3449982255274;2221.1892659179366;2186.3987403464016;2188.5622875424897;2195.5169862630196;2197.516546359798;2221.8444708870384;2125.830793063809;2130.808227259546;2137.0917360122044;2140.989295053515;2142.528643698384;2123.7557680866744;2148.4414052346347;2161.081540345347;2162.4918144236094;2163.1888041984257;7870;7888.368930485604;7893.447458677895;7897.6840926362875;7936.206379362017;4439.711418757803;4506.684532082755;4538.614217791492;4574.862754117382;4575.062112266977;2811.381496070861;2851.5152424087955;2947.7347038766397;2951.0704128199764;2951.7933744637885;892.3530440430701;916.9633214671405;924.5469719837231;951.857221416786;963.7301555564453;10489.31819431742;10494.055535001886;10506.474676266233;10524.684259472227;10555.155587553054;3885.7668539887695;4030.1738143680477;4186.22085613613;4193.245215861174;4198.790060496963;9093.863592046124;9098.772530686654;9099.772505687279;9108.590113444778;9129.771755706028;4470.754108524063;4501.392312037899;4503.864884053483;4506.459224892968;4511.796969136397;3677.154254521475;3937.2519221348425;4018.9148929789376;4083.9387409188885;4094.0583665757044;3521.137321356233;3591.8204089795404;3621.320223034935;3636.654517820803;3694.353488139565;1132.7677826045806;1136.7612801311818;1137.26078049267;1137.5790957345835;1148.2995372822572;804.6982381606897;808.2564041082219;820.0897004325194;824.389951435945;826.2687521543477;5135.460776618401;5271.156614941591;5317.787288508416;5347;5428.864278392993;393.93893946437777;396.97221194516686;406.17749058157466;409.8299205829607;411.44044100023945;3542.6634469725336;3578.2306804037257;3597.37046016946;3700.9814950925074;3724.0689827543115;8915.153060459246;9600.567974441166;9601.807963840824;9629.085236902483;9643.614255429704;9457.10157535033;9645.565949532287;9666.371685840399;9667.854982175273;9668.694726211872;6865;6954.374106330454;6955.1653801543125;7043.330883566053;7051.294870512907;5120.923186152137;5153.561947234377;5158.97420512895;5252.816151434681;5296.443873393238;8583.313334933315;8716.520591367536;8747.081556436482;8761.211490965843;8847.646094156162;8877.467351958903;8998.370114092213;9032.14194651507;9072.954635227046;9099.863502047343;5920.526357891272;6309.305976342691;6485.221773387224;6632.502562307943;6658.700358483783;7422.517536360119;7469.215732348025;7494.5503269803985;7500.849983000418;7505.624718763931;6592.373724496165;6657.567258128206;6703.3296670332575;6710.66446677674;6868.62222577763;6586.341365863375;6670.899936501053;6763.830904227434;6778.694958726771;6850.623215723183;6074.210352654127;6158.291796443466;6178.104174894525;6178.567500274938;6186.597871138361;4529.614982726505;4589.495155532955;4627.537246275346;4629.814807407666;4632.281996290446;4565.497795242454;4623.583877451046;4633.4903160652975;4683.531646835426;4809.735464549343 12:36:56 INFO - PROCESS | 6238 | |4;prototype.html;288.3598411526411;299.7167676545664;304.8186329134167;305.8470764617691;305.97093276138764;4759.952400475994;4896.510348965111;4941.456439791625;5007.949920500799;5079.923801142986;4878.560929516343;4919.532644398785;4931.901361972758;4933.876653083675;4951.876203094925;3915.2561013407503;3916.610867370916;3921.901952451183;3921.960780392202;3922.293987082331;3635.94580552336;3885.7668539887695;3914.628110329514;3919.9608003920025;3926.3128952433353;3806.0675134592066;3823.3500304948225;3843.6925045996395;3843.8846834595006;3850.8267127979307;3814.5994670559608;3825.3114439400897;3826.3112639724836;3828.25349056934;3832.176082142325;3370.69663730263;3375.7468189885612;3378.3581119587448;3385.1029477188317;3395.1172695099203;4788.9521104788855;4920.360353154103;4941.505849415065;4958.826441074545;4983.227599722049;4380.145871555048;4383.7150585212175;4389.912201755979;4394.516603173648;4405.31717583775;5158.664686795384;5171.5087066728975;5173.715445650488;5177.767000484987;5201.869953251161;3570.9107272318142;3650.689691376236;3671.081490215285;3700.1489657378684;3721.1999420124803;5368.221607866876;5409.188621706776;5409.215663728776;5423.403425623218;5484.61607687462;3747.6814470769746;3773.6981041516615;3778.3387907116144;3784.262068896539;3791.7249650209656;3797.886063418102;3855.2867719471988;3856.2865869814173;3859.7877116758286;3862.208247309295;4275.700700950966;4319.503257125408;4323;4329.328954012133;4354.651627869763;5108.361454818148;5109.233614957711;5112.258722485293;5133.8716532087;5176.637635365563;1246.1152581666936;1262.0976002158318;1275.4260582737804;1284.2918917839438;1301.9674508137182;856.5888373580716;873.2446433834814;889.3418870036127;900.2168113741087;901.6979311930577;4494.16857881293;4523.344115103291;4528.252838281646;4538.659600529973;4546.363309208682;5367.597430192751;5368.436314187033;5374.623776335698;5397.4347439242965;5408;4537.251353526631;4538.523455037173;4547.363369128325;4548.499665036843;4552.339910712928;2743.3553115017953;2854.71452854717;2869.2253091665552;2870.181998130523;2910.898118565882;5063.0380227756605;5070.898582028339;5078.695278283315;5089.618278629117;5093.981203759263;5310.7610157543;5457.645253058538;5496.615236933456;5543.722813859291;5547.805826796123;5085.4914508548845;5092.567131793765;5096.159133742965;5096.898062038738;5121.769520371667;5403.297571315861;5414.377346605191;5415.59383046281;5421.728913554385;5422.810201642924;4983.775730092227;5269.1569348903995;5309.867253318698;5316.867078323073;5336.199570064521;5053.974730126326;5086.567641750493;5105.1576489880235;5122.61907141285;5141.015712822593;3764.7929363884155;3775.6601905828607;3787.886363409102;3832.137769001952;3837.7313588049687;5153.793848246029;5198.544407565888;5415.323084614423;5483.2049352844415;5508.228847961369;5214.921776173284;5224.346956630421;5225.242339860775;5261.921071184011;5263.894722105613;5249.238860365149;5256.237845512303;5268.736563171749;5272.920906186487;5296.496832800878;4909.779059942382;5170.302009228856;5193.948060519498;5196.389119373007;5216.426193118678;5302.1781623848365;5314.681119132864;5333.626646134733;5342.973285133549;5349.57203423733;5219.634625576173;5227.947720522899;5231.665925189204;5234.424213336454;5235.581153507786 12:36:56 INFO - PROCESS | 6238 | |5;yui.html;629.3266205160479;705.9188193357766;710.424556109551;714.3249629100499;732.9340359367656;12563.309018004018;13184.736305273913;13341.332933353342;13763.518276860312;13772.173669579819;13323.067385283033;13538.323083845793;13541.255230962293;13550.796738048937;13562.321883905815;634.8095571328583;765.4259305520859;780.6292011294646;782.4718315137288;785.3285440947993;758.7534051433279;778.6534991928594;783.4202690009381;785.45018487059;787.1302211056785;813.3574476163853;815.3192084609358;816.5141740664295;816.6733306677318;822.0176888618104;811.7727036429809;813.3655748516167;815.4821688227988;816.2653611749414;816.383630359081;588.2646691635456;593.6378808926552;594.6937327276456;594.913737508059;595.0271306414;13204.273764942924;13224.86775132246;13243.801342979863;13243.933780331134;13272.734545309137;13379.130356526795;13652.658683532893;13835.861641383659;13876.930615346859;14133.858661413356;11000.724981875437;11053;11143.275687080395;11165.665030049111;11198.776024479546;3238.2713889374936;3286.0306209668206;3298.8515516801804;3303.339332133559;3338.4992251162275;65686.67156664234;66544.66727666331;67120.6643966782;67170.66414667944;68021;9996.3002589818;10245.436500992368;10531.473426328806;10594.894051059391;10699.625513107005;20778.064987075617;20783.896080519804;20784.688229676565;20849.374518764158;20908.89545552293;6971.58170509771;7006.124234470692;7087.362137407658;7133.607651579213;7328.9267107329315;3734.5518537775097;3821.6178382162116;3858.6527212551005;3863.7874916879277;3872.1674839909556;2902.753265972374;2998.1455285244037;2998.295400580862;3011.9548206776917;3018.320877802477;517.2938938349126;522.8457605006456;526.4051621667492;533.4025891002102;538.1362912525418;543.6683622989973;554.5591254952323;555.958303127259;572.5877368294821;580.9651420914759;7237.421006319481;7468.178500364956;7763.767086987399;8083.636236369378;8163.877541836877;570.5549671256426;589.7788329376484;598.8772301678146;601.7532811547333;606.5117580347774;3705.8517659293866;3729.160938788805;3796.240751849641;3920.725549211528;3979.6617287530307;51438.74280628573;62113.75772484615;95310;96641.51679241558;98318.50840745894;48823;68140.6592967042;77964.61017694876;80262.59868700619;80675;72835.63582182056;73091.63454182695;73096.63451682708;73158.26841731515;75206.62396687982;7063.858722825617;7082.468814838805;7524.774256772305;7534.698612055676;7547.0943486781935;42626.573734263504;42930.35604465998;43177.78411107924;43198;44134.33798492961;59212.40787592069;62055.37944620496;62253.37746622476;63616.68191659012;65111;10394.428306443218;10442.791144177227;10464.476776161313;10504.527296271839;10546.578136874747;11335.886641133484;11649.242799218024;11829.467673954521;11838.763224735285;12055.457504412498;9871.40771553709;9909.702708918743;9917.256205784452;9930.304878658713;10115.39307641544;9805.166560842408;10350.844737329096;10769.138468922623;10781.730456738644;10811.56753729842;9658.517074146124;10022.498875056071;10071.949640251752;10236.744081398025;10449.05958463742;8834.955825220834;8844.778880528038;8966.372353935161;9347;9541.618335266512;7489.850202996018;8755.299576033774;8832.646694132163;8876.378653494194;9027.277817774693 12:36:56 INFO - PROCESS | 6238 | __end_tp_report 12:36:56 INFO - PROCESS | 6238 | __start_cc_report 12:36:56 INFO - PROCESS | 6238 | _x_x_mozilla_cycle_collect,374 12:36:56 INFO - PROCESS | 6238 | __end_cc_report 12:36:56 INFO - PROCESS | 6238 | __startTimestamp1472067416004__endTimestamp 12:36:56 INFO - PROCESS | 6238 | 12:36:56 INFO - PROCESS | 6238 | ------- Summary: start ------- 12:36:56 INFO - PROCESS | 6238 | Number of tests: 6 12:36:56 INFO - PROCESS | 6238 | 12:36:56 INFO - PROCESS | 6238 | [#0] dojo.html Cycles:165 Average:4650.56 Median:4780.78 stddev:481.26 (10.1%) stddev-sans-first:455.18 12:36:56 INFO - PROCESS | 6238 | Values: 2604.4 2619.0 2641.6 2641.6 2655.2 4598.7 4622.3 4664.7 4700.2 4714.4 4563.5 4588.8 4612.0 4628.6 4714.9 4209.5 4274.9 4317.3 4319.2 4428.7 4366.3 4370.0 4374.3 4428.0 4442.2 4276.0 4299.7 4301.8 4326.4 4343.0 4296.2 4304.5 4324.2 4336.6 4383.7 4319.5 4343.7 4345.3 4392.3 4394.4 4616.4 4644.3 4671.4 4689.1 4818.5 4967.8 4992.9 5008.4 5015.5 5036.8 4945.8 5025.2 5035.9 5040.0 5093.6 4684.9 4700.0 4718.3 4724.0 4774.1 5083.5 5111.0 5122.0 5144.7 5177.6 4857.0 4945.3 4954.7 4956.8 5007.8 4975.4 4984.5 4988.1 5016.7 5017.6 4944.9 4962.7 4968.7 4988.1 5037.2 4822.6 4969.9 4970.7 4980.2 5022.5 4183.4 4226.7 4245.9 4249.2 4279.7 3741.8 3742.0 3790.2 3791.8 3835.2 4329.4 4333.4 4334.5 4357.1 4358.4 4959.3 5040.2 5042.6 5109.5 5142.0 4285.7 4300.4 4319.2 4331.3 4364.5 4560.7 4565.1 4574.8 4605.0 4618.1 4769.7 4778.9 4780.7 4788.1 4843.4 4949.0 4982.4 5007.0 5057.7 5070.0 4669.8 4735.1 4768.1 4768.1 4780.8 4980.2 4981.8 4983.6 5042.8 5045.6 5017.7 5050.0 5055.3 5056.9 5130.4 4707.2 4873.3 4880.3 4938.4 4939.2 4936.6 4947.1 4947.6 4986.9 5022.4 4801.7 4857.5 4859.9 4895.8 4913.9 4819.5 4875.9 4876.1 4991.8 5052.7 4802.6 4815.3 4822.4 4883.2 4885.2 12:36:56 INFO - PROCESS | 6238 | 12:36:56 INFO - PROCESS | 6238 | [#1] ext.html Cycles:180 Average:45958.61 Median:35260.56 stddev:86230.49 (244.6%) stddev-sans-first:86404.99 12:36:56 INFO - PROCESS | 6238 | Values: 551.9 552.4 561.2 567.0 571.8 33820.7 38143.4 38328.2 38355.8 38419.0 37842.2 37958.0 38215.8 38309.7 38437.8 7591.9 7725.2 7739.9 7741.3 7746.8 7591.9 7601.2 7655.7 7668.3 7677.3 7683.2 7688.7 7714.0 7724.2 7745.5 7581.8 7623.7 7637.4 7675.3 7677.1 7538.4 7619.7 7653.7 7698.9 7716.1 35389.5 35428.0 35441.0 35442.8 36070.6 2997.8 3072.4 3162.7 3327.9 3425.7 27797.0 27924.9 28423.9 28564.6 29087.7 3427.9 3440.2 3443.7 3449.0 3472.2 243456.0 243843.0 243866.0 243866.0 243878.0 30901.8 53234.2 53420.2 53431.2 53611.0 31085.7 32843.0 32950.0 33075.8 33169.8 12266.0 12315.2 12326.1 12343.4 12361.4 9880.1 9964.4 10008.8 10015.7 10030.0 7703.9 7771.3 7792.5 7799.3 7818.8 2993.8 3004.4 3004.5 3055.5 3093.8 767.8 900.8 921.3 933.3 987.7 27272.9 27855.6 27969.4 28347.0 28586.9 940.7 949.1 950.4 957.1 969.1 14117.2 14939.4 14964.5 15036.7 15123.6 387387.0 391643.0 394335.0 394360.0 395291.0 48984.3 49544.5 49617.5 49659.3 49787.0 1105.5 1119.6 1133.9 1134.0 1161.5 25856.0 26919.9 27954.6 28103.7 28275.4 42531.6 43010.1 43142.8 43246.0 43300.4 323379.0 324878.0 325046.0 326286.0 327790.0 21148.0 25041.7 25494.9 25505.0 25506.4 38258.2 38891.8 38982.2 39007.0 40391.2 33657.7 33910.3 33984.0 34675.3 35131.6 33383.7 33704.5 34033.7 34308.1 34789.8 33561.0 35953.3 36964.4 37068.3 38911.8 29702.9 32611.3 33881.8 34016.1 34372.0 25015.4 25558.7 25773.5 26141.9 26417.0 12:36:56 INFO - PROCESS | 6238 | 12:36:56 INFO - PROCESS | 6238 | [#2] jquery.html Cycles:180 Average:25219.57 Median:215350.66 stddev:68561.66 (31.8%) stddev-sans-first:68728.60 12:36:56 INFO - PROCESS | 6238 | Values: 368.3 370.3 372.5 381.1 384.2 16075.9 16970.7 17577.7 17722.1 17750.5 15766.8 16224.5 16520.6 16590.6 16635.4 4975.7 5249.2 5258.7 5259.9 5262.2 3763.3 5196.4 5830.1 6083.7 6111.7 6150.9 6166.4 6167.2 6170.1 6174.8 5150.0 5397.6 5440.5 5501.6 5509.7 5232.5 5261.9 5312.9 5315.1 5327.5 12342.6 12666.4 12666.9 12671.6 12679.0 1771.1 2018.2 2067.8 2178.3 2363.0 9019.7 9092.3 9229.4 9567.6 9644.4 1649.6 1709.8 1723.6 1729.8 1752.5 66488.7 66735.3 67526.7 67817.0 68735.0 9642.9 9657.6 9983.4 10048.6 10074.2 13341.4 13497.9 13558.2 13567.1 13578.3 6795.9 6843.8 6847.8 7079.6 7141.4 6588.0 6588.2 6634.0 6660.1 6878.9 4210.5 4231.0 4238.3 4296.7 4360.8 1525.0 1615.2 1623.6 1798.6 1807.8 805.4 816.4 832.3 896.5 965.4 16555.7 17022.9 17044.0 17146.2 17550.2 843.4 846.0 852.4 853.5 861.4 9498.7 9644.7 9759.8 10120.6 10130.1 386242.0 418934.0 419500.0 421352.0 426463.0 82388.0 83648.0 84126.2 86738.0 87301.0 875.4 914.3 929.1 941.8 951.2 15984.7 16039.4 16300.4 16610.0 16676.4 38025.0 38407.8 38417.4 39248.6 40720.6 54419.7 56177.4 56214.4 56942.0 57006.4 6556.0 7781.5 7877.6 7912.8 7941.2 10173.6 11511.5 12228.5 12405.8 12997.7 10585.5 10915.4 10967.5 11045.9 11066.3 10407.3 10478.6 10559.8 10561.7 10779.2 10810.9 11068.7 11079.5 11210.6 11226.4 7583.5 7584.8 7762.5 7790.3 7962.0 8853.2 10287.3 10560.6 10598.9 11308.2 12:36:56 INFO - PROCESS | 6238 | 12:36:56 INFO - PROCESS | 6238 | [#3] mootools.html Cycles:180 Average:5072.09 Median:5128.19 stddev:2865.46 (55.9%) stddev-sans-first:2858.95 12:36:56 INFO - PROCESS | 6238 | Values: 1229.9 1264.9 1325.3 1635.0 1637.3 6763.7 7293.1 7460.8 7914.1 7934.9 7625.3 7733.8 7734.4 7754.8 7777.2 2170.1 2177.7 2202.3 2210.4 2213.0 2175.0 2202.9 2218.8 2220.3 2221.2 2186.4 2188.6 2195.5 2197.5 2221.8 2125.8 2130.8 2137.1 2141.0 2142.5 2123.8 2148.4 2161.1 2162.5 2163.2 7870.0 7888.4 7893.4 7897.7 7936.2 4439.7 4506.7 4538.6 4574.9 4575.1 2811.4 2851.5 2947.7 2951.1 2951.8 892.4 917.0 924.5 951.9 963.7 10489.3 10494.1 10506.5 10524.7 10555.2 3885.8 4030.2 4186.2 4193.2 4198.8 9093.9 9098.8 9099.8 9108.6 9129.8 4470.8 4501.4 4503.9 4506.5 4511.8 3677.2 3937.3 4018.9 4083.9 4094.1 3521.1 3591.8 3621.3 3636.7 3694.4 1132.8 1136.8 1137.3 1137.6 1148.3 804.7 808.3 820.1 824.4 826.3 5135.5 5271.2 5317.8 5347.0 5428.9 393.9 397.0 406.2 409.8 411.4 3542.7 3578.2 3597.4 3701.0 3724.1 8915.2 9600.6 9601.8 9629.1 9643.6 9457.1 9645.6 9666.4 9667.9 9668.7 6865.0 6954.4 6955.2 7043.3 7051.3 5120.9 5153.6 5159.0 5252.8 5296.4 8583.3 8716.5 8747.1 8761.2 8847.6 8877.5 8998.4 9032.1 9073.0 9099.9 5920.5 6309.3 6485.2 6632.5 6658.7 7422.5 7469.2 7494.6 7500.8 7505.6 6592.4 6657.6 6703.3 6710.7 6868.6 6586.3 6670.9 6763.8 6778.7 6850.6 6074.2 6158.3 6178.1 6178.6 6186.6 4529.6 4589.5 4627.5 4629.8 4632.3 4565.5 4623.6 4633.5 4683.5 4809.7 12:36:56 INFO - PROCESS | 6238 | 12:36:56 INFO - PROCESS | 6238 | [#4] prototype.html Cycles:180 Average:4328.91 Median:4946.69 stddev:1271.51 (25.7%) stddev-sans-first:1238.38 12:36:56 INFO - PROCESS | 6238 | Values: 288.4 299.7 304.8 305.8 306.0 4760.0 4896.5 4941.5 5007.9 5079.9 4878.6 4919.5 4931.9 4933.9 4951.9 3915.3 3916.6 3921.9 3922.0 3922.3 3635.9 3885.8 3914.6 3920.0 3926.3 3806.1 3823.4 3843.7 3843.9 3850.8 3814.6 3825.3 3826.3 3828.3 3832.2 3370.7 3375.7 3378.4 3385.1 3395.1 4789.0 4920.4 4941.5 4958.8 4983.2 4380.1 4383.7 4389.9 4394.5 4405.3 5158.7 5171.5 5173.7 5177.8 5201.9 3570.9 3650.7 3671.1 3700.1 3721.2 5368.2 5409.2 5409.2 5423.4 5484.6 3747.7 3773.7 3778.3 3784.3 3791.7 3797.9 3855.3 3856.3 3859.8 3862.2 4275.7 4319.5 4323.0 4329.3 4354.7 5108.4 5109.2 5112.3 5133.9 5176.6 1246.1 1262.1 1275.4 1284.3 1302.0 856.6 873.2 889.3 900.2 901.7 4494.2 4523.3 4528.3 4538.7 4546.4 5367.6 5368.4 5374.6 5397.4 5408.0 4537.3 4538.5 4547.4 4548.5 4552.3 2743.4 2854.7 2869.2 2870.2 2910.9 5063.0 5070.9 5078.7 5089.6 5094.0 5310.8 5457.6 5496.6 5543.7 5547.8 5085.5 5092.6 5096.2 5096.9 5121.8 5403.3 5414.4 5415.6 5421.7 5422.8 4983.8 5269.2 5309.9 5316.9 5336.2 5054.0 5086.6 5105.2 5122.6 5141.0 3764.8 3775.7 3787.9 3832.1 3837.7 5153.8 5198.5 5415.3 5483.2 5508.2 5214.9 5224.3 5225.2 5261.9 5263.9 5249.2 5256.2 5268.7 5272.9 5296.5 4909.8 5170.3 5193.9 5196.4 5216.4 5302.2 5314.7 5333.6 5343.0 5349.6 5219.6 5227.9 5231.7 5234.4 5235.6 12:36:56 INFO - PROCESS | 6238 | 12:36:56 INFO - PROCESS | 6238 | [#5] yui.html Cycles:180 Average:16858.36 Median:584.61 stddev:23560.24 (4030.0%) stddev-sans-first:23594.82 12:36:56 INFO - PROCESS | 6238 | Values: 629.3 705.9 710.4 714.3 732.9 12563.3 13184.7 13341.3 13763.5 13772.2 13323.1 13538.3 13541.3 13550.8 13562.3 634.8 765.4 780.6 782.5 785.3 758.8 778.7 783.4 785.5 787.1 813.4 815.3 816.5 816.7 822.0 811.8 813.4 815.5 816.3 816.4 588.3 593.6 594.7 594.9 595.0 13204.3 13224.9 13243.8 13243.9 13272.7 13379.1 13652.7 13835.9 13876.9 14133.9 11000.7 11053.0 11143.3 11165.7 11198.8 3238.3 3286.0 3298.9 3303.3 3338.5 65686.7 66544.7 67120.7 67170.7 68021.0 9996.3 10245.4 10531.5 10594.9 10699.6 20778.1 20783.9 20784.7 20849.4 20908.9 6971.6 7006.1 7087.4 7133.6 7328.9 3734.6 3821.6 3858.7 3863.8 3872.2 2902.8 2998.1 2998.3 3012.0 3018.3 517.3 522.8 526.4 533.4 538.1 543.7 554.6 556.0 572.6 581.0 7237.4 7468.2 7763.8 8083.6 8163.9 570.6 589.8 598.9 601.8 606.5 3705.9 3729.2 3796.2 3920.7 3979.7 51438.7 62113.8 95310.0 96641.5 98318.5 48823.0 68140.7 77964.6 80262.6 80675.0 72835.6 73091.6 73096.6 73158.3 75206.6 7063.9 7082.5 7524.8 7534.7 7547.1 42626.6 42930.4 43177.8 43198.0 44134.3 59212.4 62055.4 62253.4 63616.7 65111.0 10394.4 10442.8 10464.5 10504.5 10546.6 11335.9 11649.2 11829.5 11838.8 12055.5 9871.4 9909.7 9917.3 9930.3 10115.4 9805.2 10350.8 10769.1 10781.7 10811.6 9658.5 10022.5 10071.9 10236.7 10449.1 8835.0 8844.8 8966.4 9347.0 9541.6 7489.9 8755.3 8832.6 8876.4 9027.3 12:36:56 INFO - PROCESS | 6238 | -------- Summary: end -------- 12:36:56 INFO - PROCESS | 6238 | 12:36:57 INFO - TEST-INFO | 6238: exit 0 12:36:57 INFO - TEST-OK | dromaeo_css | took 1118493ms 12:36:57 INFO - TEST-START | kraken 12:36:57 INFO - operating with platform_type : linux_ 12:36:57 INFO - Initialising browser for kraken test... 12:36:57 INFO - TEST-INFO | started process 6597 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxIDndd/profile http://localhost:57447/getInfo.html) 12:37:02 INFO - PROCESS | 6597 | __metrics Screen width/height:1600/1200 12:37:02 INFO - PROCESS | 6597 | colorDepth:24 12:37:02 INFO - PROCESS | 6597 | Browser inner width/height: 1024/697 12:37:02 INFO - PROCESS | 6597 | __metrics 12:37:02 ERROR - PROCESS | 6597 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2991: TypeError: this.tabs is undefined 12:37:03 INFO - TEST-INFO | 6597: exit 0 12:37:03 INFO - Browser initialized. 12:37:03 INFO - Running cycle 1/1 for kraken test... 12:37:03 INFO - TEST-INFO | started process 6715 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxIDndd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:37:15 INFO - PROCESS | 6715 | RSS: Main: 192368640 12:37:15 INFO - PROCESS | 6715 | 12:37:18 INFO - PROCESS | 6715 | Cycle 1(1): loaded http://localhost:57447/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57447/tests/kraken/driver.html?testName=audio-beat-detection) 12:37:19 INFO - PROCESS | 6715 | RSS: Main: 205639680 12:37:19 INFO - PROCESS | 6715 | 12:37:22 INFO - PROCESS | 6715 | Cycle 1(1): loaded http://localhost:57447/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57447/tests/kraken/driver.html?testName=audio-dft) 12:37:23 INFO - PROCESS | 6715 | RSS: Main: 204562432 12:37:23 INFO - PROCESS | 6715 | 12:37:26 INFO - PROCESS | 6715 | Cycle 1(1): loaded http://localhost:57447/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57447/tests/kraken/driver.html?testName=audio-fft) 12:37:26 INFO - PROCESS | 6715 | RSS: Main: 196890624 12:37:26 INFO - PROCESS | 6715 | 12:37:28 INFO - PROCESS | 6715 | Cycle 1(1): loaded http://localhost:57447/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57447/tests/kraken/driver.html?testName=audio-oscillator) 12:37:29 INFO - PROCESS | 6715 | RSS: Main: 197472256 12:37:29 INFO - PROCESS | 6715 | 12:37:31 INFO - PROCESS | 6715 | Cycle 1(1): loaded http://localhost:57447/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57447/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:37:32 INFO - PROCESS | 6715 | RSS: Main: 197857280 12:37:32 INFO - PROCESS | 6715 | 12:37:35 INFO - PROCESS | 6715 | Cycle 1(1): loaded http://localhost:57447/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57447/tests/kraken/driver.html?testName=imaging-darkroom) 12:37:36 INFO - PROCESS | 6715 | RSS: Main: 197996544 12:37:36 INFO - PROCESS | 6715 | 12:37:39 INFO - PROCESS | 6715 | Cycle 1(1): loaded http://localhost:57447/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57447/tests/kraken/driver.html?testName=imaging-desaturate) 12:37:40 INFO - PROCESS | 6715 | RSS: Main: 193527808 12:37:40 INFO - PROCESS | 6715 | 12:37:43 INFO - PROCESS | 6715 | Cycle 1(1): loaded http://localhost:57447/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57447/tests/kraken/driver.html?testName=json-parse-financial) 12:37:44 INFO - PROCESS | 6715 | RSS: Main: 195653632 12:37:44 INFO - PROCESS | 6715 | 12:37:45 INFO - PROCESS | 6715 | Cycle 1(1): loaded http://localhost:57447/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57447/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:37:46 INFO - PROCESS | 6715 | RSS: Main: 196001792 12:37:46 INFO - PROCESS | 6715 | 12:37:48 INFO - PROCESS | 6715 | Cycle 1(1): loaded http://localhost:57447/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57447/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:37:49 INFO - PROCESS | 6715 | RSS: Main: 196300800 12:37:49 INFO - PROCESS | 6715 | 12:37:51 INFO - PROCESS | 6715 | Cycle 1(1): loaded http://localhost:57447/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57447/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:37:52 INFO - PROCESS | 6715 | RSS: Main: 196444160 12:37:52 INFO - PROCESS | 6715 | 12:37:54 INFO - PROCESS | 6715 | Cycle 1(1): loaded http://localhost:57447/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57447/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:37:55 INFO - PROCESS | 6715 | RSS: Main: 196816896 12:37:55 INFO - PROCESS | 6715 | 12:37:58 INFO - PROCESS | 6715 | Cycle 1(1): loaded http://localhost:57447/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57447/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:37:59 INFO - PROCESS | 6715 | RSS: Main: 196939776 12:37:59 INFO - PROCESS | 6715 | 12:38:00 INFO - PROCESS | 6715 | Cycle 1(1): loaded http://localhost:57447/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57447/tests/kraken/driver.html?testName=ai-astar) 12:38:01 INFO - PROCESS | 6715 | RSS: Main: 199712768 12:38:01 INFO - PROCESS | 6715 | 12:38:01 INFO - PROCESS | 6715 | __start_tp_report 12:38:01 INFO - PROCESS | 6715 | _x_x_mozilla_page_load 12:38:01 INFO - PROCESS | 6715 | _x_x_mozilla_page_load_details 12:38:01 INFO - PROCESS | 6715 | |i|pagename|runs| 12:38:01 INFO - PROCESS | 6715 | |0;ai-astar;110;114;117;118;116;117;117;118;115;131 12:38:01 INFO - PROCESS | 6715 | |1;audio-beat-detection;162;133;149;179;130;153;149;130;189;127 12:38:01 INFO - PROCESS | 6715 | |2;audio-dft;168;176;164;163;165;164;163;165;163;164 12:38:01 INFO - PROCESS | 6715 | |3;audio-fft;78;79;78;174;79;78;76;76;166;78 12:38:01 INFO - PROCESS | 6715 | |4;audio-oscillator;87;88;156;88;88;87;141;88;87;138 12:38:01 INFO - PROCESS | 6715 | |5;imaging-gaussian-blur;118;117;118;117;118;117;117;118;118;119 12:38:01 INFO - PROCESS | 6715 | |6;imaging-darkroom;149;147;148;148;149;147;150;148;149;149 12:38:01 INFO - PROCESS | 6715 | |7;imaging-desaturate;96;96;95;95;97;97;97;97;97;96 12:38:01 INFO - PROCESS | 6715 | |8;json-parse-financial;67;68;69;68;69;69;68;70;69;69 12:38:01 INFO - PROCESS | 6715 | |9;json-stringify-tinderbox;66;66;65;66;65;65;66;66;68;65 12:38:01 INFO - PROCESS | 6715 | |10;stanford-crypto-aes;84;83;84;88;87;89;86;91;83;84 12:38:01 INFO - PROCESS | 6715 | |11;stanford-crypto-ccm;147;136;138;141;134;146;135;141;165;133 12:38:01 INFO - PROCESS | 6715 | |12;stanford-crypto-pbkdf2;174;175;174;173;173;177;176;179;179;178 12:38:01 INFO - PROCESS | 6715 | |13;stanford-crypto-sha256-iterative;75;69;71;70;68;69;70;71;68;69 12:38:01 INFO - PROCESS | 6715 | __end_tp_report 12:38:01 INFO - PROCESS | 6715 | __start_cc_report 12:38:01 INFO - PROCESS | 6715 | _x_x_mozilla_cycle_collect,926 12:38:01 INFO - PROCESS | 6715 | __end_cc_report 12:38:01 INFO - PROCESS | 6715 | __startTimestamp1472067481164__endTimestamp 12:38:01 INFO - PROCESS | 6715 | 12:38:01 INFO - PROCESS | 6715 | ------- Summary: start ------- 12:38:01 INFO - PROCESS | 6715 | Number of tests: 14 12:38:01 INFO - PROCESS | 6715 | 12:38:01 INFO - PROCESS | 6715 | [#0] ai-astar Cycles:10 Average:117.30 Median:117.00 stddev:5.38 (4.6%) stddev-sans-first:5.01 12:38:01 INFO - PROCESS | 6715 | Values: 110.0 114.0 117.0 118.0 116.0 117.0 117.0 118.0 115.0 131.0 12:38:01 INFO - PROCESS | 6715 | 12:38:01 INFO - PROCESS | 6715 | [#1] audio-beat-detection Cycles:10 Average:150.10 Median:151.00 stddev:21.43 (14.2%) stddev-sans-first:22.30 12:38:01 INFO - PROCESS | 6715 | Values: 162.0 133.0 149.0 179.0 130.0 153.0 149.0 130.0 189.0 127.0 12:38:01 INFO - PROCESS | 6715 | 12:38:01 INFO - PROCESS | 6715 | [#2] audio-dft Cycles:10 Average:165.50 Median:164.50 stddev:3.98 (2.4%) stddev-sans-first:4.12 12:38:01 INFO - PROCESS | 6715 | Values: 168.0 176.0 164.0 163.0 165.0 164.0 163.0 165.0 163.0 164.0 12:38:01 INFO - PROCESS | 6715 | 12:38:01 INFO - PROCESS | 6715 | [#3] audio-fft Cycles:10 Average:96.20 Median:78.00 stddev:38.96 (49.9%) stddev-sans-first:40.76 12:38:01 INFO - PROCESS | 6715 | Values: 78.0 79.0 78.0 174.0 79.0 78.0 76.0 76.0 166.0 78.0 12:38:01 INFO - PROCESS | 6715 | 12:38:01 INFO - PROCESS | 6715 | [#4] audio-oscillator Cycles:10 Average:104.80 Median:87.50 stddev:28.11 (32.1%) stddev-sans-first:29.07 12:38:01 INFO - PROCESS | 6715 | Values: 87.0 88.0 156.0 88.0 88.0 87.0 141.0 88.0 87.0 138.0 12:38:01 INFO - PROCESS | 6715 | 12:38:01 INFO - PROCESS | 6715 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 12:38:01 INFO - PROCESS | 6715 | Values: 118.0 117.0 118.0 117.0 118.0 117.0 117.0 118.0 118.0 119.0 12:38:01 INFO - PROCESS | 6715 | 12:38:01 INFO - PROCESS | 6715 | [#6] imaging-darkroom Cycles:10 Average:148.40 Median:149.00 stddev:0.97 (0.6%) stddev-sans-first:1.00 12:38:01 INFO - PROCESS | 6715 | Values: 149.0 147.0 148.0 148.0 149.0 147.0 150.0 148.0 149.0 149.0 12:38:01 INFO - PROCESS | 6715 | 12:38:01 INFO - PROCESS | 6715 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:97.00 stddev:0.82 (0.8%) stddev-sans-first:0.87 12:38:01 INFO - PROCESS | 6715 | Values: 96.0 96.0 95.0 95.0 97.0 97.0 97.0 97.0 97.0 96.0 12:38:01 INFO - PROCESS | 6715 | 12:38:01 INFO - PROCESS | 6715 | [#8] json-parse-financial Cycles:10 Average:68.60 Median:69.00 stddev:0.84 (1.2%) stddev-sans-first:0.67 12:38:01 INFO - PROCESS | 6715 | Values: 67.0 68.0 69.0 68.0 69.0 69.0 68.0 70.0 69.0 69.0 12:38:01 INFO - PROCESS | 6715 | 12:38:01 INFO - PROCESS | 6715 | [#9] json-stringify-tinderbox Cycles:10 Average:65.80 Median:66.00 stddev:0.92 (1.4%) stddev-sans-first:0.97 12:38:01 INFO - PROCESS | 6715 | Values: 66.0 66.0 65.0 66.0 65.0 65.0 66.0 66.0 68.0 65.0 12:38:01 INFO - PROCESS | 6715 | 12:38:01 INFO - PROCESS | 6715 | [#10] stanford-crypto-aes Cycles:10 Average:85.90 Median:86.50 stddev:2.77 (3.2%) stddev-sans-first:2.85 12:38:01 INFO - PROCESS | 6715 | Values: 84.0 83.0 84.0 88.0 87.0 89.0 86.0 91.0 83.0 84.0 12:38:01 INFO - PROCESS | 6715 | 12:38:01 INFO - PROCESS | 6715 | [#11] stanford-crypto-ccm Cycles:10 Average:141.60 Median:141.00 stddev:9.52 (6.8%) stddev-sans-first:9.90 12:38:01 INFO - PROCESS | 6715 | Values: 147.0 136.0 138.0 141.0 134.0 146.0 135.0 141.0 165.0 133.0 12:38:01 INFO - PROCESS | 6715 | 12:38:01 INFO - PROCESS | 6715 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.80 Median:176.50 stddev:2.35 (1.3%) stddev-sans-first:2.40 12:38:01 INFO - PROCESS | 6715 | Values: 174.0 175.0 174.0 173.0 173.0 177.0 176.0 179.0 179.0 178.0 12:38:01 INFO - PROCESS | 6715 | 12:38:01 INFO - PROCESS | 6715 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.00 Median:70.00 stddev:2.05 (2.9%) stddev-sans-first:1.13 12:38:01 INFO - PROCESS | 6715 | Values: 75.0 69.0 71.0 70.0 68.0 69.0 70.0 71.0 68.0 69.0 12:38:01 INFO - PROCESS | 6715 | -------- Summary: end -------- 12:38:01 INFO - PROCESS | 6715 | 12:38:02 INFO - TEST-INFO | 6715: exit 0 12:38:02 INFO - TEST-OK | kraken | took 65269ms 12:38:02 INFO - SUITE-END | took 1183s 12:38:02 INFO - Completed test suite (00:19:44) 12:38:02 INFO - javascript benchmark 12:38:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6282.92064042004, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2604.414006848459, 2619.0, 2641.5509363408223, 2641.5773476243803, 2655.163623458609, 4598.70108442951, 4622.260438329868, 4664.673472856902, 4700.1539722849875, 4714.434267887854, 4563.520830312811, 4588.770561471922, 4611.953880461195, 4628.560286772759, 4714.929276060861, 4209.515905670841, 4274.914501709964, 4317.266064768981, 4319.2441322768545, 4428.689991700582, 4366.345048242757, 4369.97305633176, 4374.321980093091, 4427.959429534057, 4442.2448183808665, 4276.037891474424, 4299.742015479082, 4301.849435269782, 4326.4159338489535, 4343.04453020335, 4296.248156572618, 4304.5480224576595, 4324.200022995725, 4336.56634336567, 4383.736975781431, 4319.503257125408, 4343.67422443318, 4345.326474396474, 4392.253316936129, 4394.36281739146, 4616.3537104805355, 4644.349791029259, 4671.369365135697, 4689.062187562467, 4818.469968303484, 4967.82612608557, 4992.87517812054, 5008.449070602231, 5015.498450154992, 5036.7733451994745, 4945.8268960586565, 5025.246213068032, 5035.949640503584, 5040.042391945519, 5093.592512598983, 4684.929726054078, 4700.0, 4718.268668356411, 4724.007958328721, 4774.140654682121, 5083.491650834961, 5111.003354345867, 5121.974390128025, 5144.691318520826, 5177.58579313654, 4857.028594281158, 4945.2582112683385, 4954.653174277838, 4956.752162391866, 5007.849764506997, 4975.402951645753, 4984.501549845059, 4988.052270068748, 5016.749162541858, 5017.623678224148, 4944.90110197794, 4962.652614316963, 4968.677035992649, 4988.102141614544, 5037.168867136955, 4822.614190864722, 4969.90060198794, 4970.65205435616, 4980.178270585386, 5022.497750225021, 4183.372494125905, 4226.725262857904, 4245.8513952011535, 4249.171411574775, 4279.679024073207, 3741.7754934704003, 3741.9625803741615, 3790.166163444038, 3791.7914514701406, 3835.1562656215588, 4329.415528903621, 4333.436653235122, 4334.537371492076, 4357.085012147421, 4358.433403657505, 4959.305697202394, 5040.218766091261, 5042.6470147090085, 5109.463506331782, 5142.04872098663, 4285.657147428261, 4300.376445415397, 4319.157764235943, 4331.306990881444, 4364.476262848479, 4560.657950653648, 4565.109803588269, 4574.839880604163, 4605.03294308199, 4618.122556714214, 4769.73766442849, 4778.856634300976, 4780.737059461763, 4788.11419887322, 4843.4430040545785, 4949.034938187019, 4982.352294201731, 5006.974965125151, 5057.747112644427, 5069.9746501267255, 4669.813207471663, 4735.147673418817, 4768.117898188846, 4768.117898188846, 4780.784864681167, 4980.203167493184, 4981.800727970841, 4983.601311894967, 5042.773075211698, 5045.646804723634, 5017.698938063728, 5050.0, 5055.342805435417, 5056.873578160576, 5130.384353877558, 4707.19977603815, 4873.269009648439, 4880.292357608198, 4938.358013458371, 4939.16034274167, 4936.629752768485, 4947.109520286383, 4947.554720075211, 4986.850394488171, 5022.372203474566, 4801.68789028712, 4857.53853383928, 4859.878503037311, 4895.804167833389, 4913.894373765874, 4819.518048195152, 4875.902481950412, 4876.122297986397, 4991.750412479289, 5052.747362631927, 4802.591779698765, 4815.277708343637, 4822.397200349957, 4883.169861123689, 4885.218365061573], "value": 4620.14162808758, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [551.8978988887055, 552.3978863039287, 561.2479277767791, 566.9574781891359, 571.7884382778371, 33820.66179338206, 38143.42784858226, 38328.233435331276, 38355.80822095893, 38419.0, 37842.24315513688, 37958.0, 38215.80892095536, 38309.65916192934, 38437.80781096098, 7591.9240807591905, 7725.18885517021, 7739.88390174145, 7741.264579864904, 7746.8450630987345, 7591.924080759177, 7601.163871974079, 7655.732049378273, 7668.309852113337, 7677.347425468842, 7683.231676832328, 7688.730894418696, 7714.035745531809, 7724.227577242259, 7745.496542724705, 7581.772546823604, 7623.733169339046, 7637.389008879276, 7675.309222169975, 7677.117131529862, 7538.434617403716, 7619.733309334202, 7653.732119375795, 7698.884516732253, 7716.074071111447, 35389.46915796239, 35428.0, 35441.0, 35442.8227858859, 36070.63929360725, 2997.7901546891726, 3072.3855228954076, 3162.7153556180056, 3327.9168020799675, 3425.74306926979, 27797.0, 27924.86037569799, 28423.85788071067, 28564.571531427046, 29087.709122908713, 3427.8971630851115, 3440.2431465077643, 3443.733721846926, 3448.9655103448895, 3472.2013936794424, 243456.0, 243843.0, 243866.0, 243866.0, 243877.99999999822, 30901.8454907724, 53234.20148697773, 53420.19869701958, 53431.19853202205, 53611.0, 31085.68914310828, 32843.0, 32950.0, 33075.83462082674, 33169.83415082909, 12266.0, 12315.199512031868, 12326.137170398166, 12343.444544995496, 12361.381930903419, 9880.061394167542, 9964.402135871871, 10008.849867251996, 10015.69952901414, 10030.0, 7703.8844417333785, 7771.300582947561, 7792.532448053022, 7799.259070388304, 7818.843623127505, 2993.7904346695523, 3004.3690824926575, 3004.519276915683, 3055.541668749661, 3093.7989030713384, 767.7888580640368, 900.819836032783, 921.2814005076051, 933.285523616012, 987.6888780034266, 27272.863635681693, 27855.582166267523, 27969.440611187663, 28347.0, 28586.857065714954, 940.6566603189923, 949.0651708067548, 950.3727539823683, 957.1481381570408, 969.0793745941243, 14117.223552704494, 14939.402423903139, 14964.501905687212, 15036.723614881239, 15123.621909452351, 387387.0, 391643.0, 394335.0, 394360.0, 395291.0, 48984.265236021485, 49544.50455495471, 49617.50382496129, 49659.25511117336, 49787.0, 1105.5080489182396, 1119.5745616665615, 1133.886611338876, 1133.9546418143182, 1161.4715304536417, 25856.0, 26919.865400672872, 27954.602269886833, 28103.71896281011, 28275.434491309647, 42531.57468425276, 43010.13979720326, 43142.78428607837, 43246.0, 43300.35049474324, 323379.0, 324878.0, 325046.0, 326286.0, 327790.0, 21148.0, 25041.74958250467, 25494.872525637253, 25505.0, 25506.362340941625, 38258.234835303694, 38891.80554097325, 38982.22035559216, 39007.0, 40391.1921761569, 33657.663423365455, 33910.321793564486, 33984.0, 34675.306493870485, 35131.64868351386, 33383.666163339025, 33704.49443258402, 34033.65966340305, 34308.14229644279, 34789.82605087059, 33561.0, 35953.280934380644, 36964.44553331756, 37068.25863482661, 38911.80544097262, 29702.851485742434, 32611.34777304488, 33881.83059084689, 34016.14959626029, 34372.0, 25015.374615634755, 25558.74441255638, 25773.484530309663, 26141.869290653423, 26417.0], "value": 16101.21186830036, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [368.2726614935503, 370.26317627920446, 372.46179270953473, 381.0968005826192, 384.2411237805335, 16075.919620401895, 16970.745438818412, 17577.736333954985, 17722.113894305265, 17750.46748597541, 15766.842331576681, 16224.513264602081, 16520.58698532537, 16590.585235369123, 16635.41776037839, 4975.676581022222, 5249.238860365244, 5258.6581872178185, 5259.894802103956, 5262.210668399733, 3763.303788799081, 5196.428392876799, 5830.096335068071, 6083.726232319534, 6111.724972376232, 6150.938490615104, 6166.414190651881, 6167.167432396636, 6170.105334726462, 6174.8147555573405, 5150.0, 5397.62216644835, 5440.510354068133, 5501.559875209973, 5509.669419834822, 5232.476752324776, 5261.894762104775, 5312.867178320535, 5315.096433606296, 5327.493888080626, 12342.629721108382, 12666.430010649543, 12666.87333126666, 12671.619851404472, 12679.049071319596, 1771.1055916761952, 2018.2330714328607, 2067.8449116316337, 2178.302943058222, 2362.9527409451885, 9019.729408117766, 9092.318076144249, 9229.400088994194, 9567.617295308179, 9644.421334719938, 1649.5546202525252, 1709.7777288952482, 1723.6466524362475, 1729.7876988461503, 1752.5268177592106, 66488.66755666239, 66735.3326466734, 67526.66236668834, 67817.0, 68735.0, 9642.903570964201, 9657.565409556586, 9983.351082179635, 10048.59805607782, 10074.194064474825, 13341.399637016357, 13497.932510337385, 13558.186508809504, 13567.118137321042, 13578.321083945762, 6795.898061529081, 6843.794686159423, 6847.760328388483, 7079.610621415769, 7141.428685705131, 6588.04473351371, 6588.176477940257, 6633.966830165915, 6660.135162154605, 6878.8624227516175, 4210.473690788652, 4230.957690423118, 4238.329852193098, 4296.656267498593, 4360.760158191267, 1524.9847501524844, 1615.200475764504, 1623.5697540151868, 1798.6492633936518, 1807.7830660320847, 805.3637626275294, 816.4040250617082, 832.3133414932705, 896.4800415758845, 965.3628605120728, 16555.6688866222, 17022.914885425493, 17044.0, 17146.22841972114, 17550.210240539207, 843.3506200225914, 846.0439703135418, 852.377764232114, 853.4580541356283, 861.4271509446148, 9498.715038548855, 9644.710658680251, 9759.804803904024, 10120.595176193017, 10130.138938190188, 386242.0, 418934.0, 419500.0, 421352.0, 426463.0, 82388.0, 83648.0, 84126.15873841305, 86738.0, 87301.0, 875.3959767760352, 914.3142643017736, 929.0709290709291, 941.7692665296909, 951.205743204432, 15984.680306394039, 16039.438619648723, 16300.42948496797, 16610.0, 16676.416325428552, 38025.0, 38407.80796096002, 38417.4237386445, 39248.607513925635, 40720.592794072865, 54419.727901361824, 56177.43822561722, 56214.43785562092, 56942.0, 57006.429935700115, 6555.967220163869, 7781.5331080135375, 7877.606119694107, 7912.84174316522, 7941.166177551274, 10173.62656041425, 11511.53953841837, 12228.510859565518, 12405.75188496243, 12997.675058123623, 10585.470726463493, 10915.39965301916, 10967.50646220938, 11045.944770276097, 11066.336019838835, 10407.271490995558, 10478.63324783629, 10559.788804224027, 10561.683149505527, 10779.19156063314, 10810.918908109126, 11068.667939961813, 11079.501422436171, 11210.55157793679, 11226.361804975988, 7583.5070720403, 7584.81037974033, 7762.456628036209, 7790.298873101448, 7961.960190199012, 8853.247473964786, 10287.279890407599, 10560.577576897145, 10598.89401105979, 11308.151888608223], "value": 8219.725486538911, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1229.8585662648795, 1264.8924841388482, 1325.3174615073237, 1635.0, 1637.3205119875252, 6763.729450821974, 7293.124825020998, 7460.776176714694, 7914.050313962332, 7934.9206507934905, 7625.313721765054, 7733.806654833632, 7734.419918506106, 7754.7673569793, 7777.183395743436, 2170.0560256288527, 2177.7168968034134, 2202.3392982105383, 2210.4473881529616, 2213.0373287619855, 2174.9891250543724, 2202.944926376845, 2218.811401030914, 2220.3449982255274, 2221.1892659179366, 2186.3987403464016, 2188.5622875424897, 2195.5169862630196, 2197.516546359798, 2221.8444708870384, 2125.830793063809, 2130.808227259546, 2137.0917360122044, 2140.989295053515, 2142.528643698384, 2123.7557680866744, 2148.4414052346347, 2161.081540345347, 2162.4918144236094, 2163.1888041984257, 7870.0, 7888.368930485604, 7893.447458677895, 7897.6840926362875, 7936.206379362017, 4439.711418757803, 4506.684532082755, 4538.614217791492, 4574.862754117382, 4575.062112266977, 2811.381496070861, 2851.5152424087955, 2947.7347038766397, 2951.0704128199764, 2951.7933744637885, 892.3530440430701, 916.9633214671405, 924.5469719837231, 951.857221416786, 963.7301555564453, 10489.31819431742, 10494.055535001886, 10506.474676266233, 10524.684259472227, 10555.155587553054, 3885.7668539887695, 4030.1738143680477, 4186.22085613613, 4193.245215861174, 4198.790060496963, 9093.863592046124, 9098.772530686654, 9099.772505687279, 9108.590113444778, 9129.771755706028, 4470.754108524063, 4501.392312037899, 4503.864884053483, 4506.459224892968, 4511.796969136397, 3677.154254521475, 3937.2519221348425, 4018.9148929789376, 4083.9387409188885, 4094.0583665757044, 3521.137321356233, 3591.8204089795404, 3621.320223034935, 3636.654517820803, 3694.353488139565, 1132.7677826045806, 1136.7612801311818, 1137.26078049267, 1137.5790957345835, 1148.2995372822572, 804.6982381606897, 808.2564041082219, 820.0897004325194, 824.389951435945, 826.2687521543477, 5135.460776618401, 5271.156614941591, 5317.787288508416, 5347.0, 5428.864278392993, 393.93893946437777, 396.97221194516686, 406.17749058157466, 409.8299205829607, 411.44044100023945, 3542.6634469725336, 3578.2306804037257, 3597.37046016946, 3700.9814950925074, 3724.0689827543115, 8915.153060459246, 9600.567974441166, 9601.807963840824, 9629.085236902483, 9643.614255429704, 9457.10157535033, 9645.565949532287, 9666.371685840399, 9667.854982175273, 9668.694726211872, 6865.0, 6954.374106330454, 6955.1653801543125, 7043.330883566053, 7051.294870512907, 5120.923186152137, 5153.561947234377, 5158.97420512895, 5252.816151434681, 5296.443873393238, 8583.313334933315, 8716.520591367536, 8747.081556436482, 8761.211490965843, 8847.646094156162, 8877.467351958903, 8998.370114092213, 9032.14194651507, 9072.954635227046, 9099.863502047343, 5920.526357891272, 6309.305976342691, 6485.221773387224, 6632.502562307943, 6658.700358483783, 7422.517536360119, 7469.215732348025, 7494.5503269803985, 7500.849983000418, 7505.624718763931, 6592.373724496165, 6657.567258128206, 6703.3296670332575, 6710.66446677674, 6868.62222577763, 6586.341365863375, 6670.899936501053, 6763.830904227434, 6778.694958726771, 6850.623215723183, 6074.210352654127, 6158.291796443466, 6178.104174894525, 6178.567500274938, 6186.597871138361, 4529.614982726505, 4589.495155532955, 4627.537246275346, 4629.814807407666, 4632.281996290446, 4565.497795242454, 4623.583877451046, 4633.4903160652975, 4683.531646835426, 4809.735464549343], "value": 4012.0153740516184, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [288.3598411526411, 299.7167676545664, 304.8186329134167, 305.8470764617691, 305.97093276138764, 4759.952400475994, 4896.510348965111, 4941.456439791625, 5007.949920500799, 5079.923801142986, 4878.560929516343, 4919.532644398785, 4931.901361972758, 4933.876653083675, 4951.876203094925, 3915.2561013407503, 3916.610867370916, 3921.901952451183, 3921.960780392202, 3922.293987082331, 3635.94580552336, 3885.7668539887695, 3914.628110329514, 3919.9608003920025, 3926.3128952433353, 3806.0675134592066, 3823.3500304948225, 3843.6925045996395, 3843.8846834595006, 3850.8267127979307, 3814.5994670559608, 3825.3114439400897, 3826.3112639724836, 3828.25349056934, 3832.176082142325, 3370.69663730263, 3375.7468189885612, 3378.3581119587448, 3385.1029477188317, 3395.1172695099203, 4788.9521104788855, 4920.360353154103, 4941.505849415065, 4958.826441074545, 4983.227599722049, 4380.145871555048, 4383.7150585212175, 4389.912201755979, 4394.516603173648, 4405.31717583775, 5158.664686795384, 5171.5087066728975, 5173.715445650488, 5177.767000484987, 5201.869953251161, 3570.9107272318142, 3650.689691376236, 3671.081490215285, 3700.1489657378684, 3721.1999420124803, 5368.221607866876, 5409.188621706776, 5409.215663728776, 5423.403425623218, 5484.61607687462, 3747.6814470769746, 3773.6981041516615, 3778.3387907116144, 3784.262068896539, 3791.7249650209656, 3797.886063418102, 3855.2867719471988, 3856.2865869814173, 3859.7877116758286, 3862.208247309295, 4275.700700950966, 4319.503257125408, 4323.0, 4329.328954012133, 4354.651627869763, 5108.361454818148, 5109.233614957711, 5112.258722485293, 5133.8716532087, 5176.637635365563, 1246.1152581666936, 1262.0976002158318, 1275.4260582737804, 1284.2918917839438, 1301.9674508137182, 856.5888373580716, 873.2446433834814, 889.3418870036127, 900.2168113741087, 901.6979311930577, 4494.16857881293, 4523.344115103291, 4528.252838281646, 4538.659600529973, 4546.363309208682, 5367.597430192751, 5368.436314187033, 5374.623776335698, 5397.4347439242965, 5408.0, 4537.251353526631, 4538.523455037173, 4547.363369128325, 4548.499665036843, 4552.339910712928, 2743.3553115017953, 2854.71452854717, 2869.2253091665552, 2870.181998130523, 2910.898118565882, 5063.0380227756605, 5070.898582028339, 5078.695278283315, 5089.618278629117, 5093.981203759263, 5310.7610157543, 5457.645253058538, 5496.615236933456, 5543.722813859291, 5547.805826796123, 5085.4914508548845, 5092.567131793765, 5096.159133742965, 5096.898062038738, 5121.769520371667, 5403.297571315861, 5414.377346605191, 5415.59383046281, 5421.728913554385, 5422.810201642924, 4983.775730092227, 5269.1569348903995, 5309.867253318698, 5316.867078323073, 5336.199570064521, 5053.974730126326, 5086.567641750493, 5105.1576489880235, 5122.61907141285, 5141.015712822593, 3764.7929363884155, 3775.6601905828607, 3787.886363409102, 3832.137769001952, 3837.7313588049687, 5153.793848246029, 5198.544407565888, 5415.323084614423, 5483.2049352844415, 5508.228847961369, 5214.921776173284, 5224.346956630421, 5225.242339860775, 5261.921071184011, 5263.894722105613, 5249.238860365149, 5256.237845512303, 5268.736563171749, 5272.920906186487, 5296.496832800878, 4909.779059942382, 5170.302009228856, 5193.948060519498, 5196.389119373007, 5216.426193118678, 5302.1781623848365, 5314.681119132864, 5333.626646134733, 5342.973285133549, 5349.57203423733, 5219.634625576173, 5227.947720522899, 5231.665925189204, 5234.424213336454, 5235.581153507786], "value": 3920.9538005650434, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [629.3266205160479, 705.9188193357766, 710.424556109551, 714.3249629100499, 732.9340359367656, 12563.309018004018, 13184.736305273913, 13341.332933353342, 13763.518276860312, 13772.173669579819, 13323.067385283033, 13538.323083845793, 13541.255230962293, 13550.796738048937, 13562.321883905815, 634.8095571328583, 765.4259305520859, 780.6292011294646, 782.4718315137288, 785.3285440947993, 758.7534051433279, 778.6534991928594, 783.4202690009381, 785.45018487059, 787.1302211056785, 813.3574476163853, 815.3192084609358, 816.5141740664295, 816.6733306677318, 822.0176888618104, 811.7727036429809, 813.3655748516167, 815.4821688227988, 816.2653611749414, 816.383630359081, 588.2646691635456, 593.6378808926552, 594.6937327276456, 594.913737508059, 595.0271306414, 13204.273764942924, 13224.86775132246, 13243.801342979863, 13243.933780331134, 13272.734545309137, 13379.130356526795, 13652.658683532893, 13835.861641383659, 13876.930615346859, 14133.858661413356, 11000.724981875437, 11053.0, 11143.275687080395, 11165.665030049111, 11198.776024479546, 3238.2713889374936, 3286.0306209668206, 3298.8515516801804, 3303.339332133559, 3338.4992251162275, 65686.67156664234, 66544.66727666331, 67120.6643966782, 67170.66414667944, 68021.0, 9996.3002589818, 10245.436500992368, 10531.473426328806, 10594.894051059391, 10699.625513107005, 20778.064987075617, 20783.896080519804, 20784.688229676565, 20849.374518764158, 20908.89545552293, 6971.58170509771, 7006.124234470692, 7087.362137407658, 7133.607651579213, 7328.9267107329315, 3734.5518537775097, 3821.6178382162116, 3858.6527212551005, 3863.7874916879277, 3872.1674839909556, 2902.753265972374, 2998.1455285244037, 2998.295400580862, 3011.9548206776917, 3018.320877802477, 517.2938938349126, 522.8457605006456, 526.4051621667492, 533.4025891002102, 538.1362912525418, 543.6683622989973, 554.5591254952323, 555.958303127259, 572.5877368294821, 580.9651420914759, 7237.421006319481, 7468.178500364956, 7763.767086987399, 8083.636236369378, 8163.877541836877, 570.5549671256426, 589.7788329376484, 598.8772301678146, 601.7532811547333, 606.5117580347774, 3705.8517659293866, 3729.160938788805, 3796.240751849641, 3920.725549211528, 3979.6617287530307, 51438.74280628573, 62113.75772484615, 95310.0, 96641.51679241558, 98318.50840745894, 48823.0, 68140.6592967042, 77964.61017694876, 80262.59868700619, 80675.0, 72835.63582182056, 73091.63454182695, 73096.63451682708, 73158.26841731515, 75206.62396687982, 7063.858722825617, 7082.468814838805, 7524.774256772305, 7534.698612055676, 7547.0943486781935, 42626.573734263504, 42930.35604465998, 43177.78411107924, 43198.0, 44134.33798492961, 59212.40787592069, 62055.37944620496, 62253.37746622476, 63616.68191659012, 65111.0, 10394.428306443218, 10442.791144177227, 10464.476776161313, 10504.527296271839, 10546.578136874747, 11335.886641133484, 11649.242799218024, 11829.467673954521, 11838.763224735285, 12055.457504412498, 9871.40771553709, 9909.702708918743, 9917.256205784452, 9930.304878658713, 10115.39307641544, 9805.166560842408, 10350.844737329096, 10769.138468922623, 10781.730456738644, 10811.56753729842, 9658.517074146124, 10022.498875056071, 10071.949640251752, 10236.744081398025, 10449.05958463742, 8834.955825220834, 8844.778880528038, 8966.372353935161, 9347.0, 9541.618335266512, 7489.850202996018, 8755.299576033774, 8832.646694132163, 8876.378653494194, 9027.277817774693], "value": 6394.3731821954725, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1603.9999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 114.0, 117.0, 118.0, 116.0, 117.0, 117.0, 118.0, 115.0, 131.0], "value": 117.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 133.0, 149.0, 179.0, 130.0, 153.0, 149.0, 130.0, 189.0, 127.0], "value": 150.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 176.0, 164.0, 163.0, 165.0, 164.0, 163.0, 165.0, 163.0, 164.0], "value": 165.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 79.0, 78.0, 174.0, 79.0, 78.0, 76.0, 76.0, 166.0, 78.0], "value": 96.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 88.0, 156.0, 88.0, 88.0, 87.0, 141.0, 88.0, 87.0, 138.0], "value": 104.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 118.0, 117.0, 118.0, 117.0, 117.0, 118.0, 118.0, 119.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 147.0, 148.0, 148.0, 149.0, 147.0, 150.0, 148.0, 149.0, 149.0], "value": 148.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 95.0, 97.0, 97.0, 97.0, 97.0, 97.0, 96.0], "value": 96.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 69.0, 68.0, 69.0, 69.0, 68.0, 70.0, 69.0, 69.0], "value": 68.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 65.0, 66.0, 65.0, 65.0, 66.0, 66.0, 68.0, 65.0], "value": 65.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 84.0, 88.0, 87.0, 89.0, 86.0, 91.0, 83.0, 84.0], "value": 85.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 136.0, 138.0, 141.0, 134.0, 146.0, 135.0, 141.0, 165.0, 133.0], "value": 141.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 175.0, 174.0, 173.0, 173.0, 177.0, 176.0, 179.0, 179.0, 178.0], "value": 175.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 69.0, 71.0, 70.0, 68.0, 69.0, 70.0, 71.0, 68.0, 69.0], "value": 70.0, "unit": "score"}]}]} 12:38:02 INFO - Return code: 0 12:38:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:38:02 ERROR - # TBPL SUCCESS # 12:38:02 INFO - Running post-action listener: _resource_record_post_action 12:38:02 INFO - [mozharness: 2016-08-24 19:38:02.985593Z] Finished run-tests step (success) 12:38:02 INFO - Running post-run listener: _resource_record_post_run 12:38:03 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 0; Write bytes: 405688320; Read time: 0; Write time: 435472 12:38:03 INFO - TinderboxPrint: CPU usage
13.4% 12:38:03 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 12:38:03 INFO - TinderboxPrint: I/O write bytes / time
405,688,320 / 435,472 12:38:03 INFO - TinderboxPrint: CPU idle
8,289.6 (86.6%) 12:38:03 INFO - TinderboxPrint: CPU user
1,218.4 (12.7%) 12:38:03 INFO - TinderboxPrint: Swap in / out
0 / 0 12:38:03 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 116015104; Read time: 0; Write time: 193628 12:38:03 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 0; Write bytes: 289673216; Read time: 0; Write time: 241844 12:38:03 INFO - Running post-run listener: _upload_blobber_files 12:38:03 INFO - Blob upload gear active. 12:38:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:38:03 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 12:38:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Autoland-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:38:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Autoland-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:38:04 INFO - (blobuploader) - INFO - Open directory for files ... 12:38:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 12:38:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:38:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:38:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 12:38:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:38:04 INFO - (blobuploader) - INFO - Done attempting. 12:38:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:38:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:38:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:38:09 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:38:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:38:09 INFO - (blobuploader) - INFO - Done attempting. 12:38:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 12:38:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:38:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:38:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 12:38:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:38:09 INFO - (blobuploader) - INFO - Done attempting. 12:38:09 INFO - (blobuploader) - INFO - Iteration through files over. 12:38:09 INFO - Return code: 0 12:38:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:38:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:38:09 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/ee4afff8a881647ad48085bd72217399fc41447454ad0816a2fd0ef9c20f622e59076c4e34729ab5285c5b83d6bfc961100aa14914038b7c6e14c2a1060b3c8e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/c61acbe4d5f4d1b50328f088740c00cf3e3dc63bc418b18576e7a46dca933d6ed07e5eeb8013e5380df47b8772ff0f4dfba5e488ad81d11a06799244fc5daf7c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/d17b5152b3901319f2950e4f2339ae400cad6607137e653a16ae2cb86bf5a2c567d1ef8065b1fe821a8fa28d2feed95a4dc16d61b3cfe3d0205602f11e44420b"} 12:38:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:38:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:38:09 INFO - Contents: 12:38:09 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/ee4afff8a881647ad48085bd72217399fc41447454ad0816a2fd0ef9c20f622e59076c4e34729ab5285c5b83d6bfc961100aa14914038b7c6e14c2a1060b3c8e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/c61acbe4d5f4d1b50328f088740c00cf3e3dc63bc418b18576e7a46dca933d6ed07e5eeb8013e5380df47b8772ff0f4dfba5e488ad81d11a06799244fc5daf7c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/d17b5152b3901319f2950e4f2339ae400cad6607137e653a16ae2cb86bf5a2c567d1ef8065b1fe821a8fa28d2feed95a4dc16d61b3cfe3d0205602f11e44420b"} 12:38:09 INFO - Running post-run listener: copy_logs_to_upload_dir 12:38:09 INFO - Copying logs to upload dir... 12:38:09 INFO - mkdir: /builds/slave/test/build/upload/logs 12:38:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.855595 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-08-24 12:38:09.138780) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-24 12:38:09.142686) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1472061355.267774-331982381 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/ee4afff8a881647ad48085bd72217399fc41447454ad0816a2fd0ef9c20f622e59076c4e34729ab5285c5b83d6bfc961100aa14914038b7c6e14c2a1060b3c8e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/c61acbe4d5f4d1b50328f088740c00cf3e3dc63bc418b18576e7a46dca933d6ed07e5eeb8013e5380df47b8772ff0f4dfba5e488ad81d11a06799244fc5daf7c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/d17b5152b3901319f2950e4f2339ae400cad6607137e653a16ae2cb86bf5a2c567d1ef8065b1fe821a8fa28d2feed95a4dc16d61b3cfe3d0205602f11e44420b"} 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.011354 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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/ee4afff8a881647ad48085bd72217399fc41447454ad0816a2fd0ef9c20f622e59076c4e34729ab5285c5b83d6bfc961100aa14914038b7c6e14c2a1060b3c8e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/c61acbe4d5f4d1b50328f088740c00cf3e3dc63bc418b18576e7a46dca933d6ed07e5eeb8013e5380df47b8772ff0f4dfba5e488ad81d11a06799244fc5daf7c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/d17b5152b3901319f2950e4f2339ae400cad6607137e653a16ae2cb86bf5a2c567d1ef8065b1fe821a8fa28d2feed95a4dc16d61b3cfe3d0205602f11e44420b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-24 12:38:09.169126) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 12:38:09.169520) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1472061355.267774-331982381 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004468 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 12:38:09.255596) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-24 12:38:09.255948) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-24 12:38:09.256303) ========= ========= Total master_lag: 0.15 =========