builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-014 starttime: 1472500464.38 results: success (0) buildid: 20160829120534 builduid: 8c8e0d5d33f1413987e81be44bdf0a83 revision: f91e6ea2609b042516ede688859cfcb02b7e4415 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-29 12:54:24.385466) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-29 12:54:24.387275) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-29 12:54:24.387593) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-29 12:54:24.451276) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 12:54:24.451676) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=31acecf42b6a79ec49471d4a000001bb-1472500115.148332-892760239 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-29 12:54:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 104M=0s 2016-08-29 12:54:24 (104 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.224971 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 12:54:24.729431) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 12:54:24.729753) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=31acecf42b6a79ec49471d4a000001bb-1472500115.148332-892760239 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020082 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 12:54:24.781762) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-08-29 12:54:24.782501) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev f91e6ea2609b042516ede688859cfcb02b7e4415 --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 f91e6ea2609b042516ede688859cfcb02b7e4415 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=31acecf42b6a79ec49471d4a000001bb-1472500115.148332-892760239 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-29 12:54:24,860 truncating revision to first 12 chars 2016-08-29 12:54:24,860 Setting DEBUG logging. 2016-08-29 12:54:24,860 attempt 1/10 2016-08-29 12:54:24,860 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/f91e6ea2609b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-29 12:54:26,878 unpacking tar archive at: autoland-f91e6ea2609b/testing/mozharness/ program finished with exit code 0 elapsedTime=2.317297 ========= master_lag: 0.12 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-08-29 12:54:27.219199) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-29 12:54:27.220028) ========= script_repo_revision: f91e6ea2609b042516ede688859cfcb02b7e4415 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-29 12:54:27.221231) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-29 12:54:27.221984) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-29 12:54:27.234806) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-08-29 12:54:27.235175) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=31acecf42b6a79ec49471d4a000001bb-1472500115.148332-892760239 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:54:27 INFO - MultiFileLogger online at 20160829 12:54:27 in /builds/slave/test 12:54:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 12:54:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:54:27 INFO - {'append_to_log': False, 12:54:27 INFO - 'base_work_dir': '/builds/slave/test', 12:54:27 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 12:54:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:54:27 INFO - 'branch': 'Autoland-Non-PGO', 12:54:27 INFO - 'buildbot_json_path': 'buildprops.json', 12:54:27 INFO - 'config_files': ('talos/linux_config.py',), 12:54:27 INFO - 'default_actions': ('clobber', 12:54:27 INFO - 'read-buildbot-config', 12:54:27 INFO - 'download-and-extract', 12:54:27 INFO - 'populate-webroot', 12:54:27 INFO - 'create-virtualenv', 12:54:27 INFO - 'install', 12:54:27 INFO - 'run-tests'), 12:54:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:54:27 INFO - 'download_minidump_stackwalk': True, 12:54:27 INFO - 'download_symbols': 'ondemand', 12:54:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:54:27 INFO - 'tooltool.py': '/tools/tooltool.py', 12:54:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:54:27 INFO - '/tools/misc-python/virtualenv.py')}, 12:54:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:54:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:54:27 INFO - 'installer_path': 'installer.exe', 12:54:27 INFO - 'log_level': 'info', 12:54:27 INFO - 'log_name': 'talos', 12:54:27 INFO - 'log_to_console': True, 12:54:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:54:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:54:27 INFO - 'opt_config_files': (), 12:54:27 INFO - 'pip_index': False, 12:54:27 INFO - 'sps_profile': False, 12:54:27 INFO - 'sps_profile_interval': 0, 12:54:27 INFO - 'suite': 'dromaeojs', 12:54:27 INFO - 'system_bits': '32', 12:54:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:54:27 INFO - 'title': 'talos-linux64-ix-014', 12:54:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:54:27 INFO - 'use_talos_json': True, 12:54:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:54:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:54:27 INFO - 'work_dir': 'build'} 12:54:27 INFO - [mozharness: 2016-08-29 19:54:27.503704Z] Running clobber step. 12:54:27 INFO - Running pre-action listener: _resource_record_pre_action 12:54:27 INFO - Running main action method: clobber 12:54:27 INFO - rmtree: /builds/slave/test/build 12:54:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:54:27 INFO - Running post-action listener: _resource_record_post_action 12:54:27 INFO - [mozharness: 2016-08-29 19:54:27.917819Z] Finished clobber step (success) 12:54:27 INFO - [mozharness: 2016-08-29 19:54:27.917921Z] Running read-buildbot-config step. 12:54:27 INFO - Running pre-action listener: _resource_record_pre_action 12:54:27 INFO - Running main action method: read_buildbot_config 12:54:27 INFO - Using buildbot properties: 12:54:27 INFO - { 12:54:27 INFO - "project": "", 12:54:27 INFO - "product": "firefox", 12:54:27 INFO - "script_repo_revision": "production", 12:54:27 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 12:54:27 INFO - "repository": "", 12:54:27 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 12:54:27 INFO - "buildid": "20160829120534", 12:54:27 INFO - "pgo_build": "False", 12:54:27 INFO - "basedir": "/builds/slave/test", 12:54:27 INFO - "buildnumber": 340, 12:54:27 INFO - "slavename": "talos-linux64-ix-014", 12:54:27 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 12:54:27 INFO - "platform": "ubuntu64_hw", 12:54:27 INFO - "scheduler": "tests-autoland-linux64-talos", 12:54:27 INFO - "branch": "autoland", 12:54:27 INFO - "repo_path": "integration/autoland", 12:54:27 INFO - "revision": "f91e6ea2609b042516ede688859cfcb02b7e4415", 12:54:27 INFO - "stage_platform": "linux64", 12:54:27 INFO - "builduid": "8c8e0d5d33f1413987e81be44bdf0a83", 12:54:27 INFO - "slavebuilddir": "test" 12:54:27 INFO - } 12:54:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/MNjN4BJaSziOsauQkbuxWA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 12:54:27 INFO - Running post-action listener: _resource_record_post_action 12:54:27 INFO - [mozharness: 2016-08-29 19:54:27.920513Z] Finished read-buildbot-config step (success) 12:54:27 INFO - [mozharness: 2016-08-29 19:54:27.920614Z] Running download-and-extract step. 12:54:27 INFO - Running pre-action listener: _resource_record_pre_action 12:54:27 INFO - Running main action method: download_and_extract 12:54:27 INFO - mkdir: /builds/slave/test/build/tests 12:54:27 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:54:27 INFO - trying https://queue.taskcluster.net/v1/task/MNjN4BJaSziOsauQkbuxWA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 12:54:27 INFO - Downloading https://queue.taskcluster.net/v1/task/MNjN4BJaSziOsauQkbuxWA/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:54:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MNjN4BJaSziOsauQkbuxWA/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:54:28 INFO - Downloaded 1361 bytes. 12:54:28 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 12:54:28 INFO - Using the following test package requirements: 12:54:28 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 12:54:28 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 12:54:28 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:54:28 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 12:54:28 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 12:54:28 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 12:54:28 INFO - u'jsshell-linux-x86_64.zip'], 12:54:28 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 12:54:28 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:54:28 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 12:54:28 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 12:54:28 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:54:28 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 12:54:28 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:54:28 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 12:54:28 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:54:28 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 12:54:28 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:54:28 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:54:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:54:28 INFO - trying https://queue.taskcluster.net/v1/task/MNjN4BJaSziOsauQkbuxWA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 12:54:28 INFO - Downloading https://queue.taskcluster.net/v1/task/MNjN4BJaSziOsauQkbuxWA/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:54:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MNjN4BJaSziOsauQkbuxWA/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:54:29 INFO - Downloaded 20308050 bytes. 12:54:29 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:54:33 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:54:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:54:33 INFO - trying https://queue.taskcluster.net/v1/task/MNjN4BJaSziOsauQkbuxWA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 12:54:33 INFO - Downloading https://queue.taskcluster.net/v1/task/MNjN4BJaSziOsauQkbuxWA/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:54:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MNjN4BJaSziOsauQkbuxWA/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:54:34 INFO - Downloaded 20308050 bytes. 12:54:34 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:54:39 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:54:39 INFO - trying https://queue.taskcluster.net/v1/task/MNjN4BJaSziOsauQkbuxWA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 12:54:39 INFO - Downloading https://queue.taskcluster.net/v1/task/MNjN4BJaSziOsauQkbuxWA/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:54:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MNjN4BJaSziOsauQkbuxWA/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:54:40 INFO - Downloaded 14413998 bytes. 12:54:40 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:54:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:54:40 INFO - trying https://queue.taskcluster.net/v1/task/MNjN4BJaSziOsauQkbuxWA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 12:54:40 INFO - Downloading https://queue.taskcluster.net/v1/task/MNjN4BJaSziOsauQkbuxWA/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:54:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MNjN4BJaSziOsauQkbuxWA/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:54:41 INFO - Downloaded 55866908 bytes. 12:54:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MNjN4BJaSziOsauQkbuxWA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 12:54:41 INFO - mkdir: /builds/slave/test/properties 12:54:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:54:41 INFO - Writing to file /builds/slave/test/properties/build_url 12:54:41 INFO - Contents: 12:54:41 INFO - build_url:https://queue.taskcluster.net/v1/task/MNjN4BJaSziOsauQkbuxWA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 12:54:42 INFO - Running post-action listener: _resource_record_post_action 12:54:42 INFO - Running post-action listener: set_extra_try_arguments 12:54:42 INFO - [mozharness: 2016-08-29 19:54:42.525661Z] Finished download-and-extract step (success) 12:54:42 INFO - [mozharness: 2016-08-29 19:54:42.525889Z] Running populate-webroot step. 12:54:42 INFO - Running pre-action listener: _resource_record_pre_action 12:54:42 INFO - Running main action method: populate_webroot 12:54:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:54:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:54:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:54:42 INFO - '--tppagecycles', 12:54:42 INFO - '7'], 12:54:42 INFO - 'tests': ['tsvgm']}}, 12:54:42 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:54:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:54:42 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:54:42 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:54:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:54:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:54:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:54:42 INFO - 'talos_options': ['--disable-e10s'], 12:54:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:54:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:54:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:54:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:54:42 INFO - 'talos_options': ['--disable-e10s'], 12:54:42 INFO - 'tests': ['damp', 'tps']}, 12:54:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:54:42 INFO - 'tests': ['damp', 'tps']}, 12:54:42 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:54:42 INFO - 'tests': ['dromaeo_dom']}, 12:54:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:54:42 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:54:42 INFO - 'tests': ['basic_compositor_video']}, 12:54:42 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:54:42 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:54:42 INFO - 'tests': ['a11yr', 12:54:42 INFO - 'ts_paint', 12:54:42 INFO - 'tpaint', 12:54:42 INFO - 'sessionrestore', 12:54:42 INFO - 'sessionrestore_no_auto_restore', 12:54:42 INFO - 'tabpaint']}, 12:54:42 INFO - 'other-e10s': {'tests': ['a11yr', 12:54:42 INFO - 'ts_paint', 12:54:42 INFO - 'tpaint', 12:54:42 INFO - 'sessionrestore', 12:54:42 INFO - 'sessionrestore_no_auto_restore', 12:54:42 INFO - 'tabpaint']}, 12:54:42 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:54:42 INFO - 'ts_paint', 12:54:42 INFO - 'tpaint', 12:54:42 INFO - 'sessionrestore', 12:54:42 INFO - 'sessionrestore_no_auto_restore', 12:54:42 INFO - 'tabpaint']}, 12:54:42 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:54:42 INFO - 'ts_paint', 12:54:42 INFO - 'tpaint', 12:54:42 INFO - 'sessionrestore', 12:54:42 INFO - 'sessionrestore_no_auto_restore', 12:54:42 INFO - 'tabpaint']}, 12:54:42 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:54:42 INFO - 'tests': ['a11yr', 12:54:42 INFO - 'ts_paint', 12:54:42 INFO - 'tpaint', 12:54:42 INFO - 'sessionrestore', 12:54:42 INFO - 'sessionrestore_no_auto_restore', 12:54:42 INFO - 'tabpaint']}, 12:54:42 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:54:42 INFO - 'tests': ['a11yr', 12:54:42 INFO - 'ts_paint', 12:54:42 INFO - 'tpaint', 12:54:42 INFO - 'sessionrestore', 12:54:42 INFO - 'sessionrestore_no_auto_restore', 12:54:42 INFO - 'tabpaint']}, 12:54:42 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:54:42 INFO - 'tests': ['tsvgx', 12:54:42 INFO - 'tsvgr_opacity', 12:54:42 INFO - 'tart', 12:54:42 INFO - 'tscrollx', 12:54:42 INFO - 'cart']}, 12:54:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:54:42 INFO - 'tsvgr_opacity', 12:54:42 INFO - 'tart', 12:54:42 INFO - 'tscrollx', 12:54:42 INFO - 'cart']}, 12:54:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:54:42 INFO - 'talos_options': ['--disable-e10s'], 12:54:42 INFO - 'tests': ['tp5o']}, 12:54:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:54:42 INFO - 'tests': ['tp5o']}, 12:54:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:54:42 INFO - 'talos_options': ['--disable-e10s', 12:54:42 INFO - '--xperf_path', 12:54:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:54:42 INFO - 'tests': ['tp5n']}, 12:54:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:54:42 INFO - 'talos_options': ['--xperf_path', 12:54:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:54:42 INFO - 'tests': ['tp5n']}}, 12:54:42 INFO - 'talos.zip': {'path': '', 12:54:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:54:42 INFO - Running post-action listener: _resource_record_post_action 12:54:42 INFO - [mozharness: 2016-08-29 19:54:42.547955Z] Finished populate-webroot step (success) 12:54:42 INFO - [mozharness: 2016-08-29 19:54:42.548045Z] Running create-virtualenv step. 12:54:42 INFO - Running pre-action listener: _resource_record_pre_action 12:54:42 INFO - Running main action method: create_virtualenv 12:54:42 INFO - Creating virtualenv /builds/slave/test/build/venv 12:54:42 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:54:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:54:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:54:42 INFO - Using real prefix '/usr' 12:54:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:54:43 INFO - Installing distribute.............................................................................................................................................................................................done. 12:54:45 INFO - Installing pip.................done. 12:54:45 INFO - Return code: 0 12:54:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:54: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:54:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:54:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54: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:54:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:54:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4503b41f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2785230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x277f090>, '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 0x27829b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2782e40>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1472500115.148332-892760239', '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:54: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', 'pip>=1.5'] in /builds/slave/test/build 12:54: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 pip>=1.5 12:54:45 INFO - Using env: {'DISPLAY': ':0', 12:54:45 INFO - 'HOME': '/home/cltbld', 12:54:45 INFO - 'LANG': 'en_US.UTF-8', 12:54:45 INFO - 'LANGUAGE': 'en_US:en', 12:54:45 INFO - 'LOGNAME': 'cltbld', 12:54:45 INFO - 'MAIL': '/var/mail/cltbld', 12:54:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:54:45 INFO - 'MOZ_NO_REMOTE': '1', 12:54:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:54:45 INFO - 'NO_EM_RESTART': '1', 12:54:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:54:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:54:45 INFO - 'PWD': '/builds/slave/test', 12:54:45 INFO - 'SHELL': '/bin/bash', 12:54:45 INFO - 'SHLVL': '1', 12:54:45 INFO - 'TERM': 'linux', 12:54:45 INFO - 'TMOUT': '86400', 12:54:45 INFO - 'USER': 'cltbld', 12:54:45 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1472500115.148332-892760239', 12:54:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:54:45 INFO - '_': '/tools/buildbot/bin/python'} 12:54:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:54:45 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:54:45 INFO - Cleaning up... 12:54:45 INFO - Return code: 0 12:54:45 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:54: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:54:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:54:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54: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:54:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:54:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54: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', '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 0x7f4503b41f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2785230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x277f090>, '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 0x27829b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2782e40>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1472500115.148332-892760239', '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:54: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', 'psutil>=3.1.1'] in /builds/slave/test/build 12:54: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 psutil>=3.1.1 12:54:45 INFO - Using env: {'DISPLAY': ':0', 12:54:45 INFO - 'HOME': '/home/cltbld', 12:54:45 INFO - 'LANG': 'en_US.UTF-8', 12:54:45 INFO - 'LANGUAGE': 'en_US:en', 12:54:45 INFO - 'LOGNAME': 'cltbld', 12:54:45 INFO - 'MAIL': '/var/mail/cltbld', 12:54:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:54:45 INFO - 'MOZ_NO_REMOTE': '1', 12:54:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:54:45 INFO - 'NO_EM_RESTART': '1', 12:54:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:54:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:54:45 INFO - 'PWD': '/builds/slave/test', 12:54:45 INFO - 'SHELL': '/bin/bash', 12:54:45 INFO - 'SHLVL': '1', 12:54:45 INFO - 'TERM': 'linux', 12:54:45 INFO - 'TMOUT': '86400', 12:54:45 INFO - 'USER': 'cltbld', 12:54:45 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1472500115.148332-892760239', 12:54:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:54:45 INFO - '_': '/tools/buildbot/bin/python'} 12:54:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:54:45 INFO - Downloading/unpacking psutil>=3.1.1 12:54:45 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:54:45 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:54:45 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:54:45 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:54:45 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:54:45 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:54:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:54:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:54:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:54:47 INFO - Installing collected packages: psutil 12:54:47 INFO - Running setup.py install for psutil 12:54:47 INFO - building 'psutil._psutil_linux' extension 12:54:47 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:54:48 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:54:48 INFO - building 'psutil._psutil_posix' extension 12:54:48 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:54:48 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:54:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:54:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:54:49 INFO - Successfully installed psutil 12:54:49 INFO - Cleaning up... 12:54:49 INFO - Return code: 0 12:54:49 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:54:49 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:54:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:54:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:49 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:54:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:54:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:49 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 0x7f4503b41f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2785230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x277f090>, '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 0x27829b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2782e40>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1472500115.148332-892760239', '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:54:49 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:54:49 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:54:49 INFO - Using env: {'DISPLAY': ':0', 12:54:49 INFO - 'HOME': '/home/cltbld', 12:54:49 INFO - 'LANG': 'en_US.UTF-8', 12:54:49 INFO - 'LANGUAGE': 'en_US:en', 12:54:49 INFO - 'LOGNAME': 'cltbld', 12:54:49 INFO - 'MAIL': '/var/mail/cltbld', 12:54:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:54:49 INFO - 'MOZ_NO_REMOTE': '1', 12:54:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:54:49 INFO - 'NO_EM_RESTART': '1', 12:54:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:54:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:54:49 INFO - 'PWD': '/builds/slave/test', 12:54:49 INFO - 'SHELL': '/bin/bash', 12:54:49 INFO - 'SHLVL': '1', 12:54:49 INFO - 'TERM': 'linux', 12:54:49 INFO - 'TMOUT': '86400', 12:54:49 INFO - 'USER': 'cltbld', 12:54:49 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1472500115.148332-892760239', 12:54:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:54:49 INFO - '_': '/tools/buildbot/bin/python'} 12:54:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:54:49 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:54:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:54:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:54:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:54:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:54:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:54:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:54:51 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:54:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:54:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:54:51 INFO - Installing collected packages: mozsystemmonitor 12:54:51 INFO - Running setup.py install for mozsystemmonitor 12:54:51 INFO - Successfully installed mozsystemmonitor 12:54:51 INFO - Cleaning up... 12:54:51 INFO - Return code: 0 12:54:51 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:54:51 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:54:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:54:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:51 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:54:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:54:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:51 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 0x7f4503b41f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2785230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x277f090>, '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 0x27829b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2782e40>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1472500115.148332-892760239', '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:54:51 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:54:51 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:54:51 INFO - Using env: {'DISPLAY': ':0', 12:54:51 INFO - 'HOME': '/home/cltbld', 12:54:51 INFO - 'LANG': 'en_US.UTF-8', 12:54:51 INFO - 'LANGUAGE': 'en_US:en', 12:54:51 INFO - 'LOGNAME': 'cltbld', 12:54:51 INFO - 'MAIL': '/var/mail/cltbld', 12:54:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:54:51 INFO - 'MOZ_NO_REMOTE': '1', 12:54:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:54:51 INFO - 'NO_EM_RESTART': '1', 12:54:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:54:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:54:51 INFO - 'PWD': '/builds/slave/test', 12:54:51 INFO - 'SHELL': '/bin/bash', 12:54:51 INFO - 'SHLVL': '1', 12:54:51 INFO - 'TERM': 'linux', 12:54:51 INFO - 'TMOUT': '86400', 12:54:51 INFO - 'USER': 'cltbld', 12:54:51 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1472500115.148332-892760239', 12:54:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:54:51 INFO - '_': '/tools/buildbot/bin/python'} 12:54:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:54:51 INFO - Downloading/unpacking jsonschema==2.5.1 12:54: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:54: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:54: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:54: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:54: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:54: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:54:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:54:53 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:54: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:54: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:54: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:54: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:54: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:54: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:54:53 INFO - Downloading functools32-3.2.3-2.tar.gz 12:54:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:54:53 INFO - warning: no files found matching '*.txt' 12:54:53 INFO - no previously-included directories found matching 'build' 12:54:53 INFO - no previously-included directories found matching 'dist' 12:54:53 INFO - no previously-included directories found matching '.git*' 12:54:53 INFO - Installing collected packages: jsonschema, functools32 12:54:53 INFO - Running setup.py install for functools32 12:54:53 INFO - warning: no files found matching '*.txt' 12:54:53 INFO - no previously-included directories found matching 'build' 12:54:53 INFO - no previously-included directories found matching 'dist' 12:54:53 INFO - no previously-included directories found matching '.git*' 12:54:53 INFO - Successfully installed jsonschema functools32 12:54:53 INFO - Cleaning up... 12:54:53 INFO - Return code: 0 12:54:53 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:54:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:54:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:54:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:54:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:54:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:53 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 0x7f4503b41f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2785230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x277f090>, '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 0x27829b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2782e40>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1472500115.148332-892760239', '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:54:53 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:54:53 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:54:53 INFO - Using env: {'DISPLAY': ':0', 12:54:53 INFO - 'HOME': '/home/cltbld', 12:54:53 INFO - 'LANG': 'en_US.UTF-8', 12:54:53 INFO - 'LANGUAGE': 'en_US:en', 12:54:53 INFO - 'LOGNAME': 'cltbld', 12:54:53 INFO - 'MAIL': '/var/mail/cltbld', 12:54:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:54:53 INFO - 'MOZ_NO_REMOTE': '1', 12:54:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:54:53 INFO - 'NO_EM_RESTART': '1', 12:54:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:54:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:54:53 INFO - 'PWD': '/builds/slave/test', 12:54:53 INFO - 'SHELL': '/bin/bash', 12:54:53 INFO - 'SHLVL': '1', 12:54:53 INFO - 'TERM': 'linux', 12:54:53 INFO - 'TMOUT': '86400', 12:54:53 INFO - 'USER': 'cltbld', 12:54:54 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1472500115.148332-892760239', 12:54:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:54:54 INFO - '_': '/tools/buildbot/bin/python'} 12:54:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:54:54 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:54:54 INFO - Cleaning up... 12:54:54 INFO - Return code: 0 12:54:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:54: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:54:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:54:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54: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:54:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:54:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:54 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 0x7f4503b41f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2785230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x277f090>, '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 0x27829b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2782e40>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1472500115.148332-892760239', '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:54:54 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:54:54 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:54:54 INFO - Using env: {'DISPLAY': ':0', 12:54:54 INFO - 'HOME': '/home/cltbld', 12:54:54 INFO - 'LANG': 'en_US.UTF-8', 12:54:54 INFO - 'LANGUAGE': 'en_US:en', 12:54:54 INFO - 'LOGNAME': 'cltbld', 12:54:54 INFO - 'MAIL': '/var/mail/cltbld', 12:54:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:54:54 INFO - 'MOZ_NO_REMOTE': '1', 12:54:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:54:54 INFO - 'NO_EM_RESTART': '1', 12:54:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:54:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:54:54 INFO - 'PWD': '/builds/slave/test', 12:54:54 INFO - 'SHELL': '/bin/bash', 12:54:54 INFO - 'SHLVL': '1', 12:54:54 INFO - 'TERM': 'linux', 12:54:54 INFO - 'TMOUT': '86400', 12:54:54 INFO - 'USER': 'cltbld', 12:54:54 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1472500115.148332-892760239', 12:54:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:54:54 INFO - '_': '/tools/buildbot/bin/python'} 12:54:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:54:54 INFO - Downloading/unpacking blobuploader==1.2.4 12:54:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:54:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:54:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:54:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:54:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:54:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:54:56 INFO - Downloading blobuploader-1.2.4.tar.gz 12:54:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:54:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:54:56 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:54:56 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:54:56 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:54:56 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:54:56 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:54:56 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:54:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:54:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:54:56 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:54:56 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:54:56 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:54:56 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:54:56 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:54:56 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:54:56 INFO - Downloading docopt-0.6.1.tar.gz 12:54:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:54:57 INFO - Installing collected packages: blobuploader, requests, docopt 12:54:57 INFO - Running setup.py install for blobuploader 12:54:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:54:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:54:57 INFO - Running setup.py install for requests 12:54:57 INFO - Running setup.py install for docopt 12:54:57 INFO - Successfully installed blobuploader requests docopt 12:54:57 INFO - Cleaning up... 12:54:57 INFO - Return code: 0 12:54:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:54: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:54:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:54:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54: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:54:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:54:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:57 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 0x7f4503b41f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2785230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x277f090>, '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 0x27829b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2782e40>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1472500115.148332-892760239', '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:54:57 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:54:57 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:54:57 INFO - Using env: {'DISPLAY': ':0', 12:54:57 INFO - 'HOME': '/home/cltbld', 12:54:57 INFO - 'LANG': 'en_US.UTF-8', 12:54:57 INFO - 'LANGUAGE': 'en_US:en', 12:54:57 INFO - 'LOGNAME': 'cltbld', 12:54:57 INFO - 'MAIL': '/var/mail/cltbld', 12:54:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:54:57 INFO - 'MOZ_NO_REMOTE': '1', 12:54:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:54:57 INFO - 'NO_EM_RESTART': '1', 12:54:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:54:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:54:57 INFO - 'PWD': '/builds/slave/test', 12:54:57 INFO - 'SHELL': '/bin/bash', 12:54:57 INFO - 'SHLVL': '1', 12:54:57 INFO - 'TERM': 'linux', 12:54:57 INFO - 'TMOUT': '86400', 12:54:57 INFO - 'USER': 'cltbld', 12:54:57 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1472500115.148332-892760239', 12:54:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:54:57 INFO - '_': '/tools/buildbot/bin/python'} 12:54:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:54:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:54:57 INFO - Running setup.py (path:/tmp/pip-nU5rQi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:54:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:54:57 INFO - Running setup.py (path:/tmp/pip-Bn_4YW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:54:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:54:58 INFO - Running setup.py (path:/tmp/pip-t5vvzl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:54:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:54:58 INFO - Running setup.py (path:/tmp/pip-8U8_Y5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:54:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:54:58 INFO - Running setup.py (path:/tmp/pip-x_9FcQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:54:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:54:58 INFO - Running setup.py (path:/tmp/pip-hGclmk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:54:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:54:58 INFO - Running setup.py (path:/tmp/pip-gBRvfM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:54:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:54:58 INFO - Running setup.py (path:/tmp/pip-sd4mCo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:54:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:54:58 INFO - Running setup.py (path:/tmp/pip-27ktCo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:54:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:54:58 INFO - Running setup.py (path:/tmp/pip-INdZCE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:54:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:54:58 INFO - Running setup.py (path:/tmp/pip-OKRczf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:54:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:54:58 INFO - Running setup.py (path:/tmp/pip-IsuNMm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:54:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:54:58 INFO - Running setup.py (path:/tmp/pip-5x_0B7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:54:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:54:58 INFO - Running setup.py (path:/tmp/pip-69lafa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:54:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:54:58 INFO - Running setup.py (path:/tmp/pip-cdofQ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:54:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:54:58 INFO - Running setup.py (path:/tmp/pip-x713t9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:54:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:54:59 INFO - Running setup.py (path:/tmp/pip-COPzHo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:54:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:54:59 INFO - Running setup.py install for manifestparser 12:54:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:54:59 INFO - Running setup.py install for mozcrash 12:54:59 INFO - Running setup.py install for mozdebug 12:54:59 INFO - Running setup.py install for mozdevice 12:54:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:54:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:54:59 INFO - Running setup.py install for mozfile 12:54:59 INFO - Running setup.py install for mozhttpd 12:54:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:54:59 INFO - Running setup.py install for mozinfo 12:54:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:54:59 INFO - Running setup.py install for mozInstall 12:54:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:54:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:54:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:54:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:54:59 INFO - Running setup.py install for mozleak 12:54:59 INFO - Running setup.py install for mozlog 12:55:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:55:00 INFO - Running setup.py install for moznetwork 12:55:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:55:00 INFO - Running setup.py install for mozprocess 12:55:00 INFO - Running setup.py install for mozprofile 12:55:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:55:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:55:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:55:00 INFO - Running setup.py install for mozrunner 12:55:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:55:00 INFO - Running setup.py install for mozscreenshot 12:55:00 INFO - Running setup.py install for moztest 12:55:00 INFO - Running setup.py install for mozversion 12:55:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:55:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:55:00 INFO - Cleaning up... 12:55:00 INFO - Return code: 0 12:55:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:55:00 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:55:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:55:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:55:00 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:55:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:55:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:55:00 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 0x7f4503b41f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2785230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x277f090>, '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 0x27829b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2782e40>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1472500115.148332-892760239', '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:55:00 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:55:00 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:55:00 INFO - Using env: {'DISPLAY': ':0', 12:55:00 INFO - 'HOME': '/home/cltbld', 12:55:00 INFO - 'LANG': 'en_US.UTF-8', 12:55:00 INFO - 'LANGUAGE': 'en_US:en', 12:55:00 INFO - 'LOGNAME': 'cltbld', 12:55:00 INFO - 'MAIL': '/var/mail/cltbld', 12:55:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:55:00 INFO - 'MOZ_NO_REMOTE': '1', 12:55:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:55:00 INFO - 'NO_EM_RESTART': '1', 12:55:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:55:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:55:00 INFO - 'PWD': '/builds/slave/test', 12:55:00 INFO - 'SHELL': '/bin/bash', 12:55:00 INFO - 'SHLVL': '1', 12:55:00 INFO - 'TERM': 'linux', 12:55:00 INFO - 'TMOUT': '86400', 12:55:00 INFO - 'USER': 'cltbld', 12:55:00 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1472500115.148332-892760239', 12:55:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:55:00 INFO - '_': '/tools/buildbot/bin/python'} 12:55:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:55:01 INFO - Running setup.py (path:/tmp/pip-T_xsuW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:55:01 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:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:55:01 INFO - Running setup.py (path:/tmp/pip-v05wKs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:55:01 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:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:55:01 INFO - Running setup.py (path:/tmp/pip-M9aM1T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:55:01 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:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:55:01 INFO - Running setup.py (path:/tmp/pip-GpnAuU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:55:01 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:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:55:01 INFO - Running setup.py (path:/tmp/pip-e3Vg9J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:55:01 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:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:55:01 INFO - Running setup.py (path:/tmp/pip-B0Dek8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:55:01 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:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:55:01 INFO - Running setup.py (path:/tmp/pip-vHQPDG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:55:01 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:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:55:01 INFO - Running setup.py (path:/tmp/pip-Ii28or-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:55:01 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:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:55:01 INFO - Running setup.py (path:/tmp/pip-4vMZy_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:55:01 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:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:55:01 INFO - Running setup.py (path:/tmp/pip-Vmfi3A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:55:01 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:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:55:01 INFO - Running setup.py (path:/tmp/pip-jjQESM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:55:01 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:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:55:01 INFO - Running setup.py (path:/tmp/pip-EjWrhP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:55:01 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:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:55:01 INFO - Running setup.py (path:/tmp/pip-eYaJwm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:55:02 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:55:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:55:02 INFO - Running setup.py (path:/tmp/pip-D8UKNt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:55:02 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:55:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:55:02 INFO - Running setup.py (path:/tmp/pip-qxboWW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:55:02 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:55:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:55:02 INFO - Running setup.py (path:/tmp/pip-Hj5j2M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:55:02 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:55:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:55:02 INFO - Running setup.py (path:/tmp/pip-1yKzrV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:55:02 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:55:02 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:55:02 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:55:02 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:55:02 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:55:02 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:55:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:55:02 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:55:02 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:55:02 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:55:02 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:55:02 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:55:02 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:55:04 INFO - Downloading blessings-1.6.tar.gz 12:55:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:55:04 INFO - Installing collected packages: blessings 12:55:04 INFO - Running setup.py install for blessings 12:55:04 INFO - Successfully installed blessings 12:55:04 INFO - Cleaning up... 12:55:04 INFO - Return code: 0 12:55:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:55:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:55:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:55:04 INFO - Reading from file tmpfile_stdout 12:55:04 INFO - Current package versions: 12:55:04 INFO - argparse == 1.2.1 12:55:04 INFO - blessings == 1.6 12:55:04 INFO - blobuploader == 1.2.4 12:55:04 INFO - docopt == 0.6.1 12:55:04 INFO - functools32 == 3.2.3-2 12:55:04 INFO - jsonschema == 2.5.1 12:55:04 INFO - manifestparser == 1.1 12:55:04 INFO - mozInstall == 1.12 12:55:04 INFO - mozcrash == 0.17 12:55:04 INFO - mozdebug == 0.1 12:55:04 INFO - mozdevice == 0.48 12:55:04 INFO - mozfile == 1.2 12:55:04 INFO - mozhttpd == 0.7 12:55:04 INFO - mozinfo == 0.9 12:55:04 INFO - mozleak == 0.1 12:55:04 INFO - mozlog == 3.3 12:55:04 INFO - moznetwork == 0.27 12:55:04 INFO - mozprocess == 0.23 12:55:04 INFO - mozprofile == 0.28 12:55:04 INFO - mozrunner == 6.12 12:55:04 INFO - mozscreenshot == 0.1 12:55:04 INFO - mozsystemmonitor == 0.3 12:55:04 INFO - moztest == 0.7 12:55:04 INFO - mozversion == 1.4 12:55:04 INFO - psutil == 3.1.1 12:55:04 INFO - requests == 1.2.3 12:55:04 INFO - wsgiref == 0.1.2 12:55:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:55:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:55:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:55:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:55:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:55:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:55:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:55:04 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 0x7f4503b41f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2785230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x277f090>, '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 0x27829b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2782e40>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1472500115.148332-892760239', '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:55:04 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:55:04 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:55:04 INFO - Using env: {'DISPLAY': ':0', 12:55:04 INFO - 'HOME': '/home/cltbld', 12:55:04 INFO - 'LANG': 'en_US.UTF-8', 12:55:04 INFO - 'LANGUAGE': 'en_US:en', 12:55:04 INFO - 'LOGNAME': 'cltbld', 12:55:04 INFO - 'MAIL': '/var/mail/cltbld', 12:55:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:55:04 INFO - 'MOZ_NO_REMOTE': '1', 12:55:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:55:04 INFO - 'NO_EM_RESTART': '1', 12:55:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:55:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:55:04 INFO - 'PWD': '/builds/slave/test', 12:55:04 INFO - 'SHELL': '/bin/bash', 12:55:04 INFO - 'SHLVL': '1', 12:55:04 INFO - 'TERM': 'linux', 12:55:04 INFO - 'TMOUT': '86400', 12:55:04 INFO - 'USER': 'cltbld', 12:55:04 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1472500115.148332-892760239', 12:55:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:55:04 INFO - '_': '/tools/buildbot/bin/python'} 12:55:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:55:04 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:55:04 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:55:04 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:55:04 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:55:04 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:55:04 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:55:04 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:55:04 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:55:04 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:55:04 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:55:04 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:55:04 INFO - Cleaning up... 12:55:04 INFO - Return code: 0 12:55:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:55:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:55:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:55:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:55:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:55:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:55:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:55:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4503b41f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2785230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x277f090>, '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 0x27829b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2782e40>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1472500115.148332-892760239', '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:55:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 12:55:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 12:55:04 INFO - Using env: {'DISPLAY': ':0', 12:55:04 INFO - 'HOME': '/home/cltbld', 12:55:04 INFO - 'LANG': 'en_US.UTF-8', 12:55:04 INFO - 'LANGUAGE': 'en_US:en', 12:55:04 INFO - 'LOGNAME': 'cltbld', 12:55:04 INFO - 'MAIL': '/var/mail/cltbld', 12:55:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:55:04 INFO - 'MOZ_NO_REMOTE': '1', 12:55:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:55:04 INFO - 'NO_EM_RESTART': '1', 12:55:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:55:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:55:04 INFO - 'PWD': '/builds/slave/test', 12:55:04 INFO - 'SHELL': '/bin/bash', 12:55:04 INFO - 'SHLVL': '1', 12:55:04 INFO - 'TERM': 'linux', 12:55:04 INFO - 'TMOUT': '86400', 12:55:04 INFO - 'USER': 'cltbld', 12:55:04 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1472500115.148332-892760239', 12:55:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:55:04 INFO - '_': '/tools/buildbot/bin/python'} 12:55:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:55:05 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:55:05 INFO - Cleaning up... 12:55:05 INFO - Return code: 0 12:55:05 INFO - Running post-action listener: _resource_record_post_action 12:55:05 INFO - Running post-action listener: _start_resource_monitoring 12:55:05 INFO - Starting resource monitoring. 12:55:05 INFO - [mozharness: 2016-08-29 19:55:05.173205Z] Finished create-virtualenv step (success) 12:55:05 INFO - [mozharness: 2016-08-29 19:55:05.174185Z] Running install step. 12:55:05 INFO - Running pre-action listener: _resource_record_pre_action 12:55:05 INFO - Running main action method: install 12:55:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:55:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:55:05 INFO - Reading from file tmpfile_stdout 12:55:05 INFO - Detecting whether we're running mozinstall >=1.0... 12:55:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:55:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:55:05 INFO - Reading from file tmpfile_stdout 12:55:05 INFO - Output received: 12:55:05 INFO - Usage: mozinstall [options] installer 12:55:05 INFO - Options: 12:55:05 INFO - -h, --help show this help message and exit 12:55:05 INFO - -d DEST, --destination=DEST 12:55:05 INFO - Directory to install application into. [default: 12:55:05 INFO - "/builds/slave/test"] 12:55:05 INFO - --app=APP Application being installed. [default: firefox] 12:55:05 INFO - mkdir: /builds/slave/test/build/application 12:55:05 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:55:05 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:55:21 INFO - Reading from file tmpfile_stdout 12:55:21 INFO - Output received: 12:55:21 INFO - /builds/slave/test/build/application/firefox/firefox 12:55:21 INFO - Running post-action listener: _resource_record_post_action 12:55:21 INFO - [mozharness: 2016-08-29 19:55:21.601661Z] Finished install step (success) 12:55:21 INFO - [mozharness: 2016-08-29 19:55:21.601947Z] Running run-tests step. 12:55:21 INFO - Running pre-action listener: _resource_record_pre_action 12:55:21 INFO - Running main action method: run_tests 12:55:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:55:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:55:21 INFO - Python 2.7.3 12:55:21 INFO - Return code: 0 12:55:21 INFO - grabbing minidump binary from tooltool 12:55:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:55:21 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 0x277f090>, '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 0x27829b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2782e40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:55:21 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:55:21 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:55:21 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:55:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:55:21 INFO - Return code: 0 12:55:21 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:55:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:55:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:55:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:55:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:55:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MNjN4BJaSziOsauQkbuxWA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 12:55:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/MNjN4BJaSziOsauQkbuxWA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-014 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 12:55:21 INFO - Using env: {'DISPLAY': ':0', 12:55:21 INFO - 'HOME': '/home/cltbld', 12:55:21 INFO - 'LANG': 'en_US.UTF-8', 12:55:21 INFO - 'LANGUAGE': 'en_US:en', 12:55:21 INFO - 'LOGNAME': 'cltbld', 12:55:21 INFO - 'MAIL': '/var/mail/cltbld', 12:55:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:55:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:55:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:55:21 INFO - 'MOZ_NO_REMOTE': '1', 12:55:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:55:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:55:21 INFO - 'NO_EM_RESTART': '1', 12:55:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:55:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:55:21 INFO - 'PWD': '/builds/slave/test', 12:55:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:55:21 INFO - 'SHELL': '/bin/bash', 12:55:21 INFO - 'SHLVL': '1', 12:55:21 INFO - 'TERM': 'linux', 12:55:21 INFO - 'TMOUT': '86400', 12:55:21 INFO - 'USER': 'cltbld', 12:55:21 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1472500115.148332-892760239', 12:55:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:55:21 INFO - '_': '/tools/buildbot/bin/python'} 12:55:21 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MNjN4BJaSziOsauQkbuxWA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 12:55:22 INFO - mozversion application_buildid: 20160829120534 12:55:22 INFO - mozversion application_changeset: f91e6ea2609b042516ede688859cfcb02b7e4415 12:55:22 INFO - mozversion application_display_name: Nightly 12:55:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:55:22 INFO - mozversion application_name: Firefox 12:55:22 INFO - mozversion application_remotingname: firefox 12:55:22 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 12:55:22 INFO - mozversion application_vendor: Mozilla 12:55:22 INFO - mozversion application_version: 51.0a1 12:55:22 INFO - mozversion platform_buildid: 20160829120534 12:55:22 INFO - mozversion platform_changeset: f91e6ea2609b042516ede688859cfcb02b7e4415 12:55:22 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 12:55:22 INFO - mozversion platform_version: 51.0a1 12:55:22 INFO - using testdate: 1472500522 12:55:22 INFO - actual date: 1472500522 12:55:22 INFO - starting webserver on 'localhost:54418' 12:55:22 INFO - SUITE-START | Running 2 tests 12:55:22 INFO - TEST-START | dromaeo_css 12:55:22 INFO - operating with platform_type : linux_ 12:55:22 INFO - Initialising browser for dromaeo_css test... 12:55:22 INFO - TEST-INFO | started process 3320 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxfbZQP/profile http://localhost:54418/getInfo.html) 12:55:28 INFO - PROCESS | 3320 | __metrics Screen width/height:1600/1200 12:55:28 INFO - PROCESS | 3320 | colorDepth:24 12:55:28 INFO - PROCESS | 3320 | Browser inner width/height: 1024/697 12:55:28 INFO - PROCESS | 3320 | __metrics 12:55:28 INFO - PROCESS | 3320 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 12:55:28 INFO - PROCESS | 3320 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:55:29 INFO - PROCESS | 3320 | console.error: PushService: 12:55:29 INFO - PROCESS | 3320 | stateChangeProcessEnqueue: Error transitioning state 12:55:29 INFO - PROCESS | 3320 | UnknownError 12:55:29 INFO - TEST-INFO | 3320: exit 0 12:55:29 INFO - Browser initialized. 12:55:29 INFO - Running cycle 1/1 for dromaeo_css test... 12:55:29 INFO - TEST-INFO | started process 3403 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxfbZQP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:55:42 INFO - PROCESS | 3403 | RSS: Main: 181723136 12:55:42 INFO - PROCESS | 3403 | 12:56:32 INFO - PROCESS | 3403 | 1472500592955 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:58:46 INFO - PROCESS | 3403 | Cycle 1(1): loaded http://localhost:54418/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54418/tests/dromaeo/cssquery-ext.html) 12:58:47 INFO - PROCESS | 3403 | RSS: Main: 266375168 12:58:47 INFO - PROCESS | 3403 | 13:01:50 INFO - PROCESS | 3403 | Cycle 1(1): loaded http://localhost:54418/tests/dromaeo/cssquery-ext.html (next: http://localhost:54418/tests/dromaeo/cssquery-jquery.html) 13:01:50 INFO - PROCESS | 3403 | RSS: Main: 279527424 13:01:50 INFO - PROCESS | 3403 | 13:04:53 INFO - PROCESS | 3403 | Cycle 1(1): loaded http://localhost:54418/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54418/tests/dromaeo/cssquery-mootools.html) 13:04:53 INFO - PROCESS | 3403 | RSS: Main: 219004928 13:04:53 INFO - PROCESS | 3403 | 13:07:56 INFO - PROCESS | 3403 | Cycle 1(1): loaded http://localhost:54418/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54418/tests/dromaeo/cssquery-prototype.html) 13:07:56 INFO - PROCESS | 3403 | RSS: Main: 218890240 13:07:56 INFO - PROCESS | 3403 | 13:10:59 INFO - PROCESS | 3403 | Cycle 1(1): loaded http://localhost:54418/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54418/tests/dromaeo/cssquery-yui.html) 13:11:00 INFO - PROCESS | 3403 | RSS: Main: 218673152 13:11:00 INFO - PROCESS | 3403 | 13:14:03 INFO - PROCESS | 3403 | Cycle 1(1): loaded http://localhost:54418/tests/dromaeo/cssquery-yui.html (next: http://localhost:54418/tests/dromaeo/cssquery-dojo.html) 13:14:03 INFO - PROCESS | 3403 | RSS: Main: 310706176 13:14:03 INFO - PROCESS | 3403 | 13:14:03 INFO - PROCESS | 3403 | __start_tp_report 13:14:03 INFO - PROCESS | 3403 | _x_x_mozilla_page_load 13:14:03 INFO - PROCESS | 3403 | _x_x_mozilla_page_load_details 13:14:03 INFO - PROCESS | 3403 | |i|pagename|runs| 13:14:03 INFO - PROCESS | 3403 | |0;dojo.html;2548.082690231517;2553.527597394483;2563.397601563632;2580.238829545284;2586.301698541395;4597.195490789107;4604.11442025652;4657.743824089674;4681.063787242552;4742.620590352768;4673.509281525442;4678.485366609679;4706.223473126938;4718.952810471894;4780.426348838144;4290.957090429102;4326.394304797331;4352.521222665504;4354.281543545311;4364.105358401536;4316.136772645467;4338.479382474107;4349.69552131351;4384.145091707102;4447.35513350564;4375.387445757597;4379.562043795611;4399.890002749925;4418.028033832552;4425.291953287475;4242.53332133465;4270.124624452011;4309.224339618867;4342.804573794171;4364.018095928391;4200.873973780792;4202.285611446062;4209.852655157055;4222.113356195203;4230.090530535918;4590.793414296365;4622.791974361162;4644.2801365788355;4660.300954856764;4669.369635099286;4857.344258525124;4957.281194226853;4992.201247800371;5001.499850015006;5054.7472626368535;4894.583960363373;4971;5020.246962955549;5022.824201152942;5067.619928505377;4664.5568670976545;4677.368555244999;4680.648951328664;4698.201305778026;4735.431748190239;5000.499950004971;5083.135866902636;5136.614753893473;5143.254228136899;5149.510796474329;4834.734089625104;4847.394075740533;4857.587105096107;4917.286993385939;4918.139325618003;4964.404271487445;4980.12847751642;4985.102681517289;4989.501049894981;5040.39515258164;4803.447603525639;4853.0779151961015;4947.777350019258;4948.480409557017;5010.924836127461;4878.853634390903;4908.4846091160625;4935.457099719028;5009.373828271466;5013.724245166551;4304.268274393361;4309.676774241944;4315;4315.741055536678;4363.127374525107;3763.8870833875026;3768.9246215075545;3783.1487915219404;3784.2053168834304;3795.1081495848453;4225.281702110648;4285.935710964338;4289.013526888771;4300.333448315453;4355.324924636687;4981.676191047571;4987.202047672427;5004.824831130893;5007.148784706608;5047.343845300161;4285.314349704033;4294.463192100988;4299.1831552005015;4311.590398912098;4352.107817897323;4445.911081778347;4464.6428285737065;4533.478649955231;4537.8184872604725;4593.54064593538;4679.227927391942;4697.694649847749;4704.411948506437;4710.858674239778;4748.358971538798;4992.051510213048;5004.049230646166;5015.072211640858;5017.297578339108;5075.593952483719;4541.772911354486;4634.976825115853;4665.883352916204;4699.882502937454;4748.643851711066;4885.951140488692;4891.388576427947;4918.852434426973;4924.975375123101;4971.254311853251;4978.751062446936;4986.15235409974;4994.32576602154;4994.650374473752;5056.089903817348;4751.311059896365;4845.8061677533915;4848.61211103118;4849.660523763303;4911.68074075184;4828.879278017937;4854.029194161252;4854.732989685601;4858.854234372974;4914.852554423373;4685.718856868462;4752.2158843790385;4763.928541071818;4774.188387974123;4855.150348689036;4810.975945120252;4878.07316609843;4901.313816065683;4921.876953076202;5003.374578177728;4809.78355973975;4833.613310935187;4836.951630483791;4839;4901.166801643658 13:14:03 INFO - PROCESS | 3403 | |1;ext.html;567.6083502383356;574.293618848816;577.7053702611666;579.623244890821;583.3116922032002;28358.432831343387;40380;42091.368629470584;42139.57860421399;42174.15651686965;39605.40591891124;39907.40138897919;40001.599944001966;40024;40059.39910901331;7571.9621401893055;7718.343940765014;7719.035120609924;7719.228077192292;7722.343600793911;7597.696092156307;7647.885281720779;7658.808529786744;7687.423443241752;7689.077310722721;7671.961640191791;7727.304542591166;7756.883646745303;7799.922000780005;7802.570858602775;7752.728654497094;7789.3768498519985;7799.025121859768;7799.688012479494;7800.141984381742;7527.6236188190915;7558;7569.697212111509;7570.659320330543;7571.659275332623;36419.63580364189;36810.447843282374;36875.446868297;36944;36966.63033369659;2917.7811664125065;2951.8081324713826;3018.8792448302042;3175.872965081394;3266.3467306538787;27800.582991254945;28001.299967500974;28074.578881316796;28272.85863570669;29550.26124346887;3412.283420481702;3468.670476304747;3496.7901925884275;3504.7721898076798;3626.6373362663785;229070;229126;229284;230897;231046;48546.514534854905;48903.86509416531;49037;49067.75466122646;49133;31561.36877262442;32320;32597;34247;51785.44643660696;13392.665183370495;13658.04393692432;13675;13677.726445471035;13679.726405471834;10044.949775251076;10108.494575271206;10114.747131321776;10116.08955194036;10120.342177758423;17502.649947000988;17706.937583745017;17707.203175857117;17766.64717144308;17781;6890.896636550356;6938.653067346612;6964.815981283194;6971.755988540377;7121.92878071223;735.3822788857385;864.3646919514152;879.9560021999002;912.8585069314134;937.6202637931649;26862.462750745268;26968.730312697015;27062.86468567684;27688.446231075264;27939.720602793714;781.2226834299794;894.1594900793234;935.5602866652663;972.5623469438781;987.1107835129567;13527.45890164402;14618.926905365617;14742.778858317133;14830.406783728746;15136.318865651072;352727;354060;355717;356069;356250;47482.76258618754;47711.5228847714;47740.283895741595;47776.28335574969;47885.28172077422;1018.8013337399284;1104.2104895000114;1105.9778804423865;1138.7836311100864;1184.9644510664693;20057.29512991412;28931.421371572873;30703.846480767454;31095.378092438477;31362.52956205613;44421;45054.324185137906;45078.54921450744;45105.32342014938;45162;312628;316217;316411;316641;318500;24374.634380483953;24741.25776226644;25259.368515787253;25327.493450131264;25353.619695704212;40586.594134059465;41049.1790164201;41641;41902;42172;34296.485552717226;34599.4810077844;34701.652983469845;35138.648613513535;35723.28553428865;34871.47692784661;34965.30069398547;35353.46969795404;35430.645693542734;35709.46435803413;33693.32613347768;33781;34462.827685862416;34884.82557587297;34961.65038349584;29531.409371812013;31911.68088319087;32525.837370812995;32529.34941301208;32605.228555572092;24214.128550639034;24404.267871963868;24631.52138791511;24666.753332466447;24712 13:14:03 INFO - PROCESS | 3403 | |2;jquery.html;329.2361720807727;351.70105410401163;367.16103703038556;367.70399828138346;377.9603141670125;12639.431225594848;15422.537323880288;17288.308467661278;17366.82633173671;17576.648467030653;13561.796573051412;16009.439669611565;16519.83480165198;16563.751543726852;16605.83394166058;5503.559715222783;5855.941440585603;5863;5875.794347197849;5877.2065771121;4028.516578010628;5771.884562308751;5860.384659610743;5864.5894787364905;6701.4303784178155;6977.860442791167;7143.107111611049;7150.642467876612;7153.785386438415;7157.570545767245;6880.69036893341;7075.080239568823;7077.5399599025895;7091.219965803757;7097.254788247212;6572.967135164341;6844.863102737917;6848.212455567624;6849.452043836481;6906.06768086312;23708.88145559261;23781.643275350885;23880.522389552112;23887.283381498582;23955.520889582112;1916.8945707986056;2129.105775574247;2199.538096999632;2271.0121097322553;2451.8038556915403;13405.46378144873;14549.345279462344;14669.853301467063;15115.622109447242;15281.694366112726;1682.1832420985306;1795.3446991848011;1902.7906930237664;1905.3617038292189;1917.3768525229357;52414.47585524134;64213;69718.3028169722;77659;81075;15043.924780376028;16359.182040897907;16567.781148938047;16823.915880420518;16842.494725158263;28584;28590.142295730744;28615.71384286172;28627.28431789222;28669.28326791805;7978.800529986681;8001.759947201594;8245.381596380295;8267.049289331684;8475.533845638549;6476.093346931433;6539.2479864815205;6586.769463068769;6812;6856.485763567753;8297.792555186168;8315.750527484186;8391.748247552583;8525.950173667583;8561.700340488052;2633.710291867893;2899.594056832045;3198.168476196159;3220.8711651534145;3226.709596136359;803.445622520459;816.3102178659024;832.4755404095503;846.8729690546344;885.8449771289999;15597.298121584556;15713.38592123818;17397.826021739875;17478.563035923948;18760.061996900375;810.3517186251094;820.9630566624517;831.1024093978489;840.5923127283263;893.2184338703635;9270.887493500823;9816.901830981742;9840.803183936281;9903.45530995802;10006.499675016366;389747;392821;393390;397741;400175;76802.61598692082;77818;78428.21571784209;78625.60687196642;78693;902.8871391076246;911.996803516127;938.9014153513783;939.4457270210609;942.5146049784366;15100.169490678118;15140.318685658951;15410.69178616399;15817.209139543207;15929.645980091822;36922;36927.63072369242;37893.81053094717;38236.235275294894;38344.80827595844;50443.49556504388;50663.746681266355;50675.23987140122;50842.74578627083;52196.73901630467;7442.181360050282;7522.623868806647;7542.811429714301;7740.922590774246;7747.1090824555895;8888.64445422176;11654.65036048886;11780.764384712087;11903.46434410471;11924.523019079139;9935.850962235716;10076.345037572535;10381.584736610452;10434.739131521468;10477.842832357674;10032.64885728996;10375.481225938824;10423.21825863048;10509.474526273809;10536.15710743154;10170.898291016994;10406.739831504274;10494.580216791242;10531.262811603114;10646.8402973957;7558.206388329147;7577.355924746238;7635.312821846061;7733.806654833449;7798.6490607923915;9994.500274986367;10342.5345859435;10607.681769546925;10761.192910531585;11063.225574209728 13:14:03 INFO - PROCESS | 3403 | |3;mootools.html;1309.9738005239894;1342.91942483451;1379.593020059083;1608.2441252611268;1631.6981358448681;6730;7113.928860711398;7535.246475352462;7582.848343033136;7714.112877019137;7576.318131368176;7925.722599708997;7941.7617471475805;7944.801379965504;7950.721724739621;2165.7834216578335;2185.9781402186013;2195.5938151441956;2196.3081629286803;2197.2968650031994;1871.4759867237128;2096.2767845093417;2156.7304086989125;2165.263810304496;2192.5943700415396;2158.6330323844986;2182.71624688791;2185.442712108418;2187.3109970359365;2190.496185877249;2048.283100914683;2053;2053.435305291042;2094.9266775662854;2123.2674727219087;2115.788421157887;2131.5417185305078;2132.1897678882083;2137.0917360122044;2144.8498605097648;7889.447738658297;7923.207679232089;7939.126696063428;7940.2059794020715;7946.880796788053;4290.077633308822;4325.52419233884;4327.459067616548;4339.71791833533;4345.565443455661;2762.3646561290816;2867.5411934090653;2897.8551072446294;2902.3614804742924;2908.7382135607895;917.2295271971576;956.9425784508088;962.7544976031137;970.0590427285522;978.0757184460688;10603.310784798963;10648.893511064867;10654.893451065467;10694.518746656342;10707.785844283071;3742.176721121349;4057.634812866797;4288.399624052635;4303.182395344875;4304.397384366192;9165.81668366629;9183.265338772882;9266.907330926739;9280.953595232115;9287.90712092884;4394.714343567658;4399.010222699867;4406.27296496081;4407;4410.117976404732;3949.881503554898;3963.6432721055244;3964.72246942717;3965.345717956505;3970.821313040862;3496.5104885316077;3621.4386770050683;3647.598764135943;3658.9817050914576;3679.6688298053305;1076.3918386111823;1118.3234143343323;1159.5709587452698;1160.4139909345727;1206.1135065726685;671.8992151177265;766.4864540757706;779.8674225381699;786.7482405630143;806.1575653442167;4900.485449027872;5038.546530812245;5069.188929771292;5078.619103567247;5265.078611243017;787.8345547435102;832.4589017138787;837.1293854391487;849.9490030598184;859.4198915731981;3382.8477718502727;3410.2326976430104;3429.176997520577;3436.570428696413;3544.4328907374697;8786.780330491662;9142.680006199884;9337.066293370608;9341.859872101924;9352.672656457127;9221.400608960395;9265.2124569411;9269.582868770922;9271.536423178813;9276.443413395218;7053.858922821618;7073.610951397723;7103.857922841617;7125.572465652078;7146.892796608055;4708.576228139484;4764.2615394613895;4786.210275304675;4885.682430641997;4906.190478570996;8463.915360846313;8605.182507661762;8635.784105397415;8645.308375330083;8689.435186712843;8568.914310856811;8784.033756286675;8860.911390886009;8934.553272336487;8997.415168014059;6466.353364663684;6601.966990165019;6662.167229096363;6669.366410191024;6744.258131605618;7457.291557302047;7531.962340188264;7538.585377804274;7538.886916696364;7554.093508778982;6588.472922166311;6643.202815661958;6717.261101278953;6789.355011273921;6905.861882762417;6506.349365063646;6655.035019922181;6682.431993280626;6698.028785826125;6712.731490740511;5921.348651648402;6008.54935879802;6017.608855424383;6018.067199584071;6022.728977196124;4348.195583817004;4464.709793863389;4479.910401792011;4508.616767574793;4562.36126942235;4224.957750422579;4368.85490118187;4497.460304763318;4522.615577675934;4578.656600755024 13:14:03 INFO - PROCESS | 3403 | |4;prototype.html;291.24567370510374;298.5506812247567;299.34742261869116;299.98950036748715;304.70443669640446;4814.4222693276815;4815.686980346275;4820.39745031871;4838.733869637173;4854.296127061579;4753.548412900777;4759.690620109691;4761.666683332168;4761.952380476194;4770.522947705228;3574.7676401033914;3660.7620504667243;3767.7550959187565;3781.8109094545302;3813.9809300953457;3807.733458657895;3810.4474851146565;3811.1996480739076;3823.1780167264033;3832.5784163741964;3784.6186142058227;3798.772073675588;3800.144967382331;3801.1257410795533;3804.7526910750853;3602.963970360289;3635.1275693833422;3747.156889699823;3757.981210093932;3764.7176461765475;3322.6178989416044;3329.6004479462617;3337.716294115003;3343.4650455926935;3349.7822641528464;4647.18674232008;4649.325847752057;4655.115528049693;4655.4878963314;4695.366125573072;4174.91650166998;4268.59448352406;4272.397850805948;4305.526392096898;4306.20335237982;4941.604671626261;4950.653454258203;4952.479989601076;4961.330220420269;4967.205247160473;3662.926741465156;3667.21154951684;3667.5965643779164;3670.4310831821113;3671.6047901797415;5076.13705670037;5124.718140502271;5210.739463026872;5226.947730522684;5249.343832020997;3644.3804553226014;3679.5400574928135;3692.390755525308;3695.4087346024507;3697.354677168688;3745.4569087482164;3747.6439738224826;3750.774953502799;3751.212245428436;3754.8310326035394;4253.659707223414;4257.254980378421;4264.123785534355;4267.722598031118;4267.97866010668;4834;4884.986761420115;4910.386201724785;4924.852254432301;4980.626453016038;1295.5659853949032;1308.770965081126;1311.4164196932275;1312.9409176586885;1313.1661395014235;811.7158994351929;849.1550906847726;862.7411776467035;866.207420210513;867.4968518259394;4304.978475107604;4421.9336709949375;4430.42404487421;4435.804276882964;4436.292027569344;5110.565601923878;5128.281995553194;5130.692158470503;5150;5154.092985595279;4407.716251392669;4450.1296663651765;4465.955340446554;4467.352233926063;4467.977660111678;2593.5087324788324;2729.7816174705977;2735.193118030186;2748.8900443982016;2757.648752111451;4829.468758436569;4835.799711131427;4862.610991120772;4863.319135321058;4882.6826256293225;5054;5257.4764113225865;5272.762725677354;5287.41838397776;5312.840614781563;4835.87221622485;4877.6585639004925;4890.168671325883;4898.608111351155;4899.804007839646;5180.896382072413;5184.740762961912;5186.481351864783;5212.9739351303;5219.634625576326;4826.0830442215865;5043.672161309503;5054.721990290569;5103.902660927918;5107.565856902205;4897.975510122426;4914.803407863646;4919.926201106915;4921.237208232729;4928.408590969107;3686.686631636234;3692.8367564217187;3701.777893326409;3703.685186759156;3708.554973403209;4925.532074452921;5225.372955245395;5235.162374020291;5240.842774716764;5245.66235609917;5023.824166154167;5031.314509639312;5055.764310840991;5057.241413787961;5064.746762661778;5024.723640199678;5032.874178145576;5035.899282014266;5048.469910659328;5056.924146137737;4832.710037397767;4970.527799859007;4975.527324904128;4983.775730092227;4988.5260900214425;4835.637327200404;4945.604351651931;5025.497450254945;5050.242463630485;5071.518205770446;4898.53463920927;4905.7792399342825;4912.287718280901;4923.65534412602;4934.235193545006 13:14:03 INFO - PROCESS | 3403 | |5;yui.html;581.6277582347295;592.7717828635975;622.3123448589312;672.63341478894;706.3678008182677;11211.215214934948;11766.529338826447;11772.529098836047;11795.528178872857;11844;11589.246698964562;11658.300501969889;11662.708432289197;11682.35747033915;12206.084543659217;726.6112629743088;743.8623854586891;745.1021519069508;746.3954197100367;746.9253074692541;606.2512796696077;729.6278897762153;738.9741359052434;741.5624781378986;746.8207630168747;777.2887807655987;779.8284377436955;780.6994307191744;780.7345502529139;780.8438312337555;773.157258588136;776.9728059517889;777.1102088109084;777.793884620576;777.9805504862367;466.5847395817691;555.8804856955734;561.2899681902396;561.8483009587429;563.892860356535;11819.704507387383;11881.108916831272;11905.4642541085;11979.520819167223;11988.400579971054;11114.22200445969;11135.832962505569;11513.884861151366;11588.826167607493;12131.757364852654;11289.266197697205;11372.658820235407;11388.956676345035;11647.184697071209;11724.765504689944;3797.012776678056;3831.8467261309515;3839.520059992501;3850.152966347399;3922.2155568886337;57746;66210.66894665544;66526.66736666382;66977;68745.65627171882;8722.520261385685;8870.556472176366;9372.937953650322;9457.43255404678;9672.903270967341;15243.390264389522;15536.145511996723;15543;15546.84453155454;15567;6678;6704.229013663491;6826.180858297036;7057;7062.540934839219;3425.72594192464;3583.569971603424;3640.5449318835144;3660.890173294805;3681.079730067483;2817.21118086936;2938.074506530436;2943.528235882059;2945.0428610701606;2945.6759756426777;506.235584267751;512.823076038766;515.1114327784617;517.2319106127397;524.9212618107238;481.94698583155827;493.60264986686065;513.1188377261723;538.5449295345427;559.6921693068796;7192.604406757574;7403.555786652711;7471.8505629887095;7474.177840437547;7977.5612341321785;522.7020598258956;544.7221916822369;553.6318348298418;560.873803394233;575.2751533068364;3532.682058614737;3743.3823419136083;3902.824372903226;3925.842966281317;3943.6253555912144;59022.40977590169;59550;59620.40379596149;59656.40343596508;78090.6095469519;64684.676576617756;70914.64542677357;74169;76110;77948;49194.508054918995;66423;66471;68904.38695163105;70577.64711176412;7508.9862868512055;7595.278448547379;7726.266004729542;7922.564258965812;8026.1171271158955;31655.52516712205;37694;38173.236535269694;38259.42610860783;42731.78634106934;39856.402153968294;53366.73316633392;53767.46232537625;58909.70545147418;59256.70371648114;10661.147108231478;10674.83987740169;10813.891861081289;10831.458427078456;11061.11511079128;11729.47217375203;11834.82247766267;12438.81341779856;12538.56115036006;12750.61748147557;9897.752556186153;9980.251481139088;9990.850137247802;10111.494425278854;10334;8782.253508451598;9007.369484136048;9223.861642075508;9259.953700231456;10583.4708264588;10516.68449946503;10925.562977480811;10982.395968221825;11139.273412621056;11204.719882003015;9893.950530247303;10004.349717268355;10226.386416815016;10316.793664126526;10680.889312654865;8639.91360086391;8658.7233703977;9495.097965693249;9564.856527151958;9645.614175433186 13:14:03 INFO - PROCESS | 3403 | __end_tp_report 13:14:03 INFO - PROCESS | 3403 | __start_cc_report 13:14:03 INFO - PROCESS | 3403 | _x_x_mozilla_cycle_collect,1031 13:14:03 INFO - PROCESS | 3403 | __end_cc_report 13:14:03 INFO - PROCESS | 3403 | __startTimestamp1472501643635__endTimestamp 13:14:03 INFO - PROCESS | 3403 | 13:14:03 INFO - PROCESS | 3403 | ------- Summary: start ------- 13:14:03 INFO - PROCESS | 3403 | Number of tests: 6 13:14:03 INFO - PROCESS | 3403 | 13:14:03 INFO - PROCESS | 3403 | [#0] dojo.html Cycles:165 Average:4619.14 Median:4742.62 stddev:477.17 (10.1%) stddev-sans-first:450.12 13:14:03 INFO - PROCESS | 3403 | Values: 2548.1 2553.5 2563.4 2580.2 2586.3 4597.2 4604.1 4657.7 4681.1 4742.6 4673.5 4678.5 4706.2 4719.0 4780.4 4291.0 4326.4 4352.5 4354.3 4364.1 4316.1 4338.5 4349.7 4384.1 4447.4 4375.4 4379.6 4399.9 4418.0 4425.3 4242.5 4270.1 4309.2 4342.8 4364.0 4200.9 4202.3 4209.9 4222.1 4230.1 4590.8 4622.8 4644.3 4660.3 4669.4 4857.3 4957.3 4992.2 5001.5 5054.7 4894.6 4971.0 5020.2 5022.8 5067.6 4664.6 4677.4 4680.6 4698.2 4735.4 5000.5 5083.1 5136.6 5143.3 5149.5 4834.7 4847.4 4857.6 4917.3 4918.1 4964.4 4980.1 4985.1 4989.5 5040.4 4803.4 4853.1 4947.8 4948.5 5010.9 4878.9 4908.5 4935.5 5009.4 5013.7 4304.3 4309.7 4315.0 4315.7 4363.1 3763.9 3768.9 3783.1 3784.2 3795.1 4225.3 4285.9 4289.0 4300.3 4355.3 4981.7 4987.2 5004.8 5007.1 5047.3 4285.3 4294.5 4299.2 4311.6 4352.1 4445.9 4464.6 4533.5 4537.8 4593.5 4679.2 4697.7 4704.4 4710.9 4748.4 4992.1 5004.0 5015.1 5017.3 5075.6 4541.8 4635.0 4665.9 4699.9 4748.6 4886.0 4891.4 4918.9 4925.0 4971.3 4978.8 4986.2 4994.3 4994.7 5056.1 4751.3 4845.8 4848.6 4849.7 4911.7 4828.9 4854.0 4854.7 4858.9 4914.9 4685.7 4752.2 4763.9 4774.2 4855.2 4811.0 4878.1 4901.3 4921.9 5003.4 4809.8 4833.6 4837.0 4839.0 4901.2 13:14:03 INFO - PROCESS | 3403 | 13:14:03 INFO - PROCESS | 3403 | [#1] ext.html Cycles:180 Average:44935.02 Median:194040.23 stddev:80121.59 (41.3%) stddev-sans-first:80277.10 13:14:03 INFO - PROCESS | 3403 | Values: 567.6 574.3 577.7 579.6 583.3 28358.4 40380.0 42091.4 42139.6 42174.2 39605.4 39907.4 40001.6 40024.0 40059.4 7572.0 7718.3 7719.0 7719.2 7722.3 7597.7 7647.9 7658.8 7687.4 7689.1 7672.0 7727.3 7756.9 7799.9 7802.6 7752.7 7789.4 7799.0 7799.7 7800.1 7527.6 7558.0 7569.7 7570.7 7571.7 36419.6 36810.4 36875.4 36944.0 36966.6 2917.8 2951.8 3018.9 3175.9 3266.3 27800.6 28001.3 28074.6 28272.9 29550.3 3412.3 3468.7 3496.8 3504.8 3626.6 229070.0 229126.0 229284.0 230897.0 231046.0 48546.5 48903.9 49037.0 49067.8 49133.0 31561.4 32320.0 32597.0 34247.0 51785.4 13392.7 13658.0 13675.0 13677.7 13679.7 10044.9 10108.5 10114.7 10116.1 10120.3 17502.6 17706.9 17707.2 17766.6 17781.0 6890.9 6938.7 6964.8 6971.8 7121.9 735.4 864.4 880.0 912.9 937.6 26862.5 26968.7 27062.9 27688.4 27939.7 781.2 894.2 935.6 972.6 987.1 13527.5 14618.9 14742.8 14830.4 15136.3 352727.0 354060.0 355717.0 356069.0 356250.0 47482.8 47711.5 47740.3 47776.3 47885.3 1018.8 1104.2 1106.0 1138.8 1185.0 20057.3 28931.4 30703.8 31095.4 31362.5 44421.0 45054.3 45078.5 45105.3 45162.0 312628.0 316217.0 316411.0 316641.0 318500.0 24374.6 24741.3 25259.4 25327.5 25353.6 40586.6 41049.2 41641.0 41902.0 42172.0 34296.5 34599.5 34701.7 35138.6 35723.3 34871.5 34965.3 35353.5 35430.6 35709.5 33693.3 33781.0 34462.8 34884.8 34961.7 29531.4 31911.7 32525.8 32529.3 32605.2 24214.1 24404.3 24631.5 24666.8 24712.0 13:14:03 INFO - PROCESS | 3403 | 13:14:03 INFO - PROCESS | 3403 | [#2] jquery.html Cycles:180 Average:25607.45 Median:395565.50 stddev:65017.06 (16.4%) stddev-sans-first:65171.75 13:14:03 INFO - PROCESS | 3403 | Values: 329.2 351.7 367.2 367.7 378.0 12639.4 15422.5 17288.3 17366.8 17576.6 13561.8 16009.4 16519.8 16563.8 16605.8 5503.6 5855.9 5863.0 5875.8 5877.2 4028.5 5771.9 5860.4 5864.6 6701.4 6977.9 7143.1 7150.6 7153.8 7157.6 6880.7 7075.1 7077.5 7091.2 7097.3 6573.0 6844.9 6848.2 6849.5 6906.1 23708.9 23781.6 23880.5 23887.3 23955.5 1916.9 2129.1 2199.5 2271.0 2451.8 13405.5 14549.3 14669.9 15115.6 15281.7 1682.2 1795.3 1902.8 1905.4 1917.4 52414.5 64213.0 69718.3 77659.0 81075.0 15043.9 16359.2 16567.8 16823.9 16842.5 28584.0 28590.1 28615.7 28627.3 28669.3 7978.8 8001.8 8245.4 8267.0 8475.5 6476.1 6539.2 6586.8 6812.0 6856.5 8297.8 8315.8 8391.7 8526.0 8561.7 2633.7 2899.6 3198.2 3220.9 3226.7 803.4 816.3 832.5 846.9 885.8 15597.3 15713.4 17397.8 17478.6 18760.1 810.4 821.0 831.1 840.6 893.2 9270.9 9816.9 9840.8 9903.5 10006.5 389747.0 392821.0 393390.0 397741.0 400175.0 76802.6 77818.0 78428.2 78625.6 78693.0 902.9 912.0 938.9 939.4 942.5 15100.2 15140.3 15410.7 15817.2 15929.6 36922.0 36927.6 37893.8 38236.2 38344.8 50443.5 50663.7 50675.2 50842.7 52196.7 7442.2 7522.6 7542.8 7740.9 7747.1 8888.6 11654.7 11780.8 11903.5 11924.5 9935.9 10076.3 10381.6 10434.7 10477.8 10032.6 10375.5 10423.2 10509.5 10536.2 10170.9 10406.7 10494.6 10531.3 10646.8 7558.2 7577.4 7635.3 7733.8 7798.6 9994.5 10342.5 10607.7 10761.2 11063.2 13:14:03 INFO - PROCESS | 3403 | 13:14:03 INFO - PROCESS | 3403 | [#3] mootools.html Cycles:180 Average:5025.75 Median:4972.37 stddev:2838.80 (57.1%) stddev-sans-first:2833.03 13:14:03 INFO - PROCESS | 3403 | Values: 1310.0 1342.9 1379.6 1608.2 1631.7 6730.0 7113.9 7535.2 7582.8 7714.1 7576.3 7925.7 7941.8 7944.8 7950.7 2165.8 2186.0 2195.6 2196.3 2197.3 1871.5 2096.3 2156.7 2165.3 2192.6 2158.6 2182.7 2185.4 2187.3 2190.5 2048.3 2053.0 2053.4 2094.9 2123.3 2115.8 2131.5 2132.2 2137.1 2144.8 7889.4 7923.2 7939.1 7940.2 7946.9 4290.1 4325.5 4327.5 4339.7 4345.6 2762.4 2867.5 2897.9 2902.4 2908.7 917.2 956.9 962.8 970.1 978.1 10603.3 10648.9 10654.9 10694.5 10707.8 3742.2 4057.6 4288.4 4303.2 4304.4 9165.8 9183.3 9266.9 9281.0 9287.9 4394.7 4399.0 4406.3 4407.0 4410.1 3949.9 3963.6 3964.7 3965.3 3970.8 3496.5 3621.4 3647.6 3659.0 3679.7 1076.4 1118.3 1159.6 1160.4 1206.1 671.9 766.5 779.9 786.7 806.2 4900.5 5038.5 5069.2 5078.6 5265.1 787.8 832.5 837.1 849.9 859.4 3382.8 3410.2 3429.2 3436.6 3544.4 8786.8 9142.7 9337.1 9341.9 9352.7 9221.4 9265.2 9269.6 9271.5 9276.4 7053.9 7073.6 7103.9 7125.6 7146.9 4708.6 4764.3 4786.2 4885.7 4906.2 8463.9 8605.2 8635.8 8645.3 8689.4 8568.9 8784.0 8860.9 8934.6 8997.4 6466.4 6602.0 6662.2 6669.4 6744.3 7457.3 7532.0 7538.6 7538.9 7554.1 6588.5 6643.2 6717.3 6789.4 6905.9 6506.3 6655.0 6682.4 6698.0 6712.7 5921.3 6008.5 6017.6 6018.1 6022.7 4348.2 4464.7 4479.9 4508.6 4562.4 4225.0 4368.9 4497.5 4522.6 4578.7 13:14:03 INFO - PROCESS | 3403 | 13:14:03 INFO - PROCESS | 3403 | [#4] prototype.html Cycles:180 Average:4177.15 Median:4815.05 stddev:1202.41 (25.0%) stddev-sans-first:1169.87 13:14:03 INFO - PROCESS | 3403 | Values: 291.2 298.6 299.3 300.0 304.7 4814.4 4815.7 4820.4 4838.7 4854.3 4753.5 4759.7 4761.7 4762.0 4770.5 3574.8 3660.8 3767.8 3781.8 3814.0 3807.7 3810.4 3811.2 3823.2 3832.6 3784.6 3798.8 3800.1 3801.1 3804.8 3603.0 3635.1 3747.2 3758.0 3764.7 3322.6 3329.6 3337.7 3343.5 3349.8 4647.2 4649.3 4655.1 4655.5 4695.4 4174.9 4268.6 4272.4 4305.5 4306.2 4941.6 4950.7 4952.5 4961.3 4967.2 3662.9 3667.2 3667.6 3670.4 3671.6 5076.1 5124.7 5210.7 5226.9 5249.3 3644.4 3679.5 3692.4 3695.4 3697.4 3745.5 3747.6 3750.8 3751.2 3754.8 4253.7 4257.3 4264.1 4267.7 4268.0 4834.0 4885.0 4910.4 4924.9 4980.6 1295.6 1308.8 1311.4 1312.9 1313.2 811.7 849.2 862.7 866.2 867.5 4305.0 4421.9 4430.4 4435.8 4436.3 5110.6 5128.3 5130.7 5150.0 5154.1 4407.7 4450.1 4466.0 4467.4 4468.0 2593.5 2729.8 2735.2 2748.9 2757.6 4829.5 4835.8 4862.6 4863.3 4882.7 5054.0 5257.5 5272.8 5287.4 5312.8 4835.9 4877.7 4890.2 4898.6 4899.8 5180.9 5184.7 5186.5 5213.0 5219.6 4826.1 5043.7 5054.7 5103.9 5107.6 4898.0 4914.8 4919.9 4921.2 4928.4 3686.7 3692.8 3701.8 3703.7 3708.6 4925.5 5225.4 5235.2 5240.8 5245.7 5023.8 5031.3 5055.8 5057.2 5064.7 5024.7 5032.9 5035.9 5048.5 5056.9 4832.7 4970.5 4975.5 4983.8 4988.5 4835.6 4945.6 5025.5 5050.2 5071.5 4898.5 4905.8 4912.3 4923.7 4934.2 13:14:03 INFO - PROCESS | 3403 | 13:14:03 INFO - PROCESS | 3403 | [#5] yui.html Cycles:180 Average:15395.42 Median:27153.00 stddev:20865.18 (76.8%) stddev-sans-first:20894.06 13:14:03 INFO - PROCESS | 3403 | Values: 581.6 592.8 622.3 672.6 706.4 11211.2 11766.5 11772.5 11795.5 11844.0 11589.2 11658.3 11662.7 11682.4 12206.1 726.6 743.9 745.1 746.4 746.9 606.3 729.6 739.0 741.6 746.8 777.3 779.8 780.7 780.7 780.8 773.2 777.0 777.1 777.8 778.0 466.6 555.9 561.3 561.8 563.9 11819.7 11881.1 11905.5 11979.5 11988.4 11114.2 11135.8 11513.9 11588.8 12131.8 11289.3 11372.7 11389.0 11647.2 11724.8 3797.0 3831.8 3839.5 3850.2 3922.2 57746.0 66210.7 66526.7 66977.0 68745.7 8722.5 8870.6 9372.9 9457.4 9672.9 15243.4 15536.1 15543.0 15546.8 15567.0 6678.0 6704.2 6826.2 7057.0 7062.5 3425.7 3583.6 3640.5 3660.9 3681.1 2817.2 2938.1 2943.5 2945.0 2945.7 506.2 512.8 515.1 517.2 524.9 481.9 493.6 513.1 538.5 559.7 7192.6 7403.6 7471.9 7474.2 7977.6 522.7 544.7 553.6 560.9 575.3 3532.7 3743.4 3902.8 3925.8 3943.6 59022.4 59550.0 59620.4 59656.4 78090.6 64684.7 70914.6 74169.0 76110.0 77948.0 49194.5 66423.0 66471.0 68904.4 70577.6 7509.0 7595.3 7726.3 7922.6 8026.1 31655.5 37694.0 38173.2 38259.4 42731.8 39856.4 53366.7 53767.5 58909.7 59256.7 10661.1 10674.8 10813.9 10831.5 11061.1 11729.5 11834.8 12438.8 12538.6 12750.6 9897.8 9980.3 9990.9 10111.5 10334.0 8782.3 9007.4 9223.9 9260.0 10583.5 10516.7 10925.6 10982.4 11139.3 11204.7 9894.0 10004.3 10226.4 10316.8 10680.9 8639.9 8658.7 9495.1 9564.9 9645.6 13:14:03 INFO - PROCESS | 3403 | -------- Summary: end -------- 13:14:03 INFO - PROCESS | 3403 | 13:14:04 INFO - TEST-INFO | 3403: exit 0 13:14:04 INFO - TEST-OK | dromaeo_css | took 1122619ms 13:14:04 INFO - TEST-START | kraken 13:14:04 INFO - operating with platform_type : linux_ 13:14:04 INFO - Initialising browser for kraken test... 13:14:04 INFO - TEST-INFO | started process 3706 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcB7SD6/profile http://localhost:54418/getInfo.html) 13:14:09 INFO - PROCESS | 3706 | __metrics Screen width/height:1600/1200 13:14:09 INFO - PROCESS | 3706 | colorDepth:24 13:14:09 INFO - PROCESS | 3706 | Browser inner width/height: 1024/697 13:14:09 INFO - PROCESS | 3706 | __metrics 13:14:09 INFO - PROCESS | 3706 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 13:14:09 INFO - PROCESS | 3706 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:14:10 INFO - PROCESS | 3706 | console.error: PushService: 13:14:10 INFO - PROCESS | 3706 | stateChangeProcessEnqueue: Error transitioning state 13:14:10 INFO - PROCESS | 3706 | UnknownError 13:14:10 INFO - TEST-INFO | 3706: exit 0 13:14:10 INFO - Browser initialized. 13:14:10 INFO - Running cycle 1/1 for kraken test... 13:14:10 INFO - TEST-INFO | started process 3788 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcB7SD6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:14:23 INFO - PROCESS | 3788 | RSS: Main: 182366208 13:14:23 INFO - PROCESS | 3788 | 13:14:25 INFO - PROCESS | 3788 | Cycle 1(1): loaded http://localhost:54418/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54418/tests/kraken/driver.html?testName=audio-beat-detection) 13:14:26 INFO - PROCESS | 3788 | RSS: Main: 235778048 13:14:26 INFO - PROCESS | 3788 | 13:14:29 INFO - PROCESS | 3788 | Cycle 1(1): loaded http://localhost:54418/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54418/tests/kraken/driver.html?testName=audio-dft) 13:14:30 INFO - PROCESS | 3788 | RSS: Main: 226562048 13:14:30 INFO - PROCESS | 3788 | 13:14:33 INFO - PROCESS | 3788 | Cycle 1(1): loaded http://localhost:54418/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54418/tests/kraken/driver.html?testName=audio-fft) 13:14:34 INFO - PROCESS | 3788 | RSS: Main: 303964160 13:14:34 INFO - PROCESS | 3788 | 13:14:36 INFO - PROCESS | 3788 | Cycle 1(1): loaded http://localhost:54418/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54418/tests/kraken/driver.html?testName=audio-oscillator) 13:14:36 INFO - PROCESS | 3788 | RSS: Main: 213889024 13:14:36 INFO - PROCESS | 3788 | 13:14:39 INFO - PROCESS | 3788 | Cycle 1(1): loaded http://localhost:54418/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54418/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:14:39 INFO - PROCESS | 3788 | RSS: Main: 215818240 13:14:39 INFO - PROCESS | 3788 | 13:14:42 INFO - PROCESS | 3788 | Cycle 1(1): loaded http://localhost:54418/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54418/tests/kraken/driver.html?testName=imaging-darkroom) 13:14:43 INFO - PROCESS | 3788 | RSS: Main: 253636608 13:14:43 INFO - PROCESS | 3788 | 13:14:46 INFO - PROCESS | 3788 | Cycle 1(1): loaded http://localhost:54418/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54418/tests/kraken/driver.html?testName=imaging-desaturate) 13:14:47 INFO - PROCESS | 3788 | RSS: Main: 253276160 13:14:47 INFO - PROCESS | 3788 | 13:14:50 INFO - PROCESS | 3788 | Cycle 1(1): loaded http://localhost:54418/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54418/tests/kraken/driver.html?testName=json-parse-financial) 13:14:50 INFO - PROCESS | 3788 | RSS: Main: 253059072 13:14:50 INFO - PROCESS | 3788 | 13:14:52 INFO - PROCESS | 3788 | Cycle 1(1): loaded http://localhost:54418/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54418/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:14:53 INFO - PROCESS | 3788 | RSS: Main: 215511040 13:14:53 INFO - PROCESS | 3788 | 13:14:55 INFO - PROCESS | 3788 | Cycle 1(1): loaded http://localhost:54418/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54418/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:14:55 INFO - PROCESS | 3788 | RSS: Main: 223744000 13:14:55 INFO - PROCESS | 3788 | 13:14:57 INFO - PROCESS | 3788 | Cycle 1(1): loaded http://localhost:54418/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54418/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:14:58 INFO - PROCESS | 3788 | RSS: Main: 224182272 13:14:58 INFO - PROCESS | 3788 | 13:15:01 INFO - PROCESS | 3788 | Cycle 1(1): loaded http://localhost:54418/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54418/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:15:02 INFO - PROCESS | 3788 | RSS: Main: 224780288 13:15:02 INFO - PROCESS | 3788 | 13:15:05 INFO - PROCESS | 3788 | Cycle 1(1): loaded http://localhost:54418/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54418/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:15:05 INFO - PROCESS | 3788 | RSS: Main: 222466048 13:15:05 INFO - PROCESS | 3788 | 13:15:07 INFO - PROCESS | 3788 | Cycle 1(1): loaded http://localhost:54418/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54418/tests/kraken/driver.html?testName=ai-astar) 13:15:07 INFO - PROCESS | 3788 | RSS: Main: 273907712 13:15:07 INFO - PROCESS | 3788 | 13:15:07 INFO - PROCESS | 3788 | __start_tp_report 13:15:07 INFO - PROCESS | 3788 | _x_x_mozilla_page_load 13:15:07 INFO - PROCESS | 3788 | _x_x_mozilla_page_load_details 13:15:07 INFO - PROCESS | 3788 | |i|pagename|runs| 13:15:07 INFO - PROCESS | 3788 | |0;ai-astar;117;116;138;116;115;118;117;115;114;114 13:15:07 INFO - PROCESS | 3788 | |1;audio-beat-detection;151;126;150;180;123;148;148;127;188;124 13:15:07 INFO - PROCESS | 3788 | |2;audio-dft;161;162;161;162;163;160;161;161;161;162 13:15:07 INFO - PROCESS | 3788 | |3;audio-fft;75;75;77;159;77;77;75;76;161;77 13:15:07 INFO - PROCESS | 3788 | |4;audio-oscillator;84;84;139;85;84;83;150;83;83;132 13:15:07 INFO - PROCESS | 3788 | |5;imaging-gaussian-blur;117;117;116;116;117;117;117;117;116;117 13:15:07 INFO - PROCESS | 3788 | |6;imaging-darkroom;146;147;145;146;146;146;146;147;147;146 13:15:07 INFO - PROCESS | 3788 | |7;imaging-desaturate;95;95;95;95;96;95;95;95;95;95 13:15:07 INFO - PROCESS | 3788 | |8;json-parse-financial;64;70;64;65;64;65;65;66;65;65 13:15:07 INFO - PROCESS | 3788 | |9;json-stringify-tinderbox;65;65;65;66;65;65;65;66;65;66 13:15:07 INFO - PROCESS | 3788 | |10;stanford-crypto-aes;83;82;82;82;91;85;82;85;91;82 13:15:07 INFO - PROCESS | 3788 | |11;stanford-crypto-ccm;132;132;131;138;132;133;133;128;168;144 13:15:07 INFO - PROCESS | 3788 | |12;stanford-crypto-pbkdf2;175;175;178;176;175;175;173;177;175;182 13:15:07 INFO - PROCESS | 3788 | |13;stanford-crypto-sha256-iterative;70;69;72;70;68;73;68;70;71;71 13:15:07 INFO - PROCESS | 3788 | __end_tp_report 13:15:07 INFO - PROCESS | 3788 | __start_cc_report 13:15:07 INFO - PROCESS | 3788 | _x_x_mozilla_cycle_collect,1975 13:15:07 INFO - PROCESS | 3788 | __end_cc_report 13:15:07 INFO - PROCESS | 3788 | __startTimestamp1472501707824__endTimestamp 13:15:07 INFO - PROCESS | 3788 | 13:15:07 INFO - PROCESS | 3788 | ------- Summary: start ------- 13:15:07 INFO - PROCESS | 3788 | Number of tests: 14 13:15:07 INFO - PROCESS | 3788 | 13:15:07 INFO - PROCESS | 3788 | [#0] ai-astar Cycles:10 Average:118.00 Median:116.50 stddev:7.15 (6.1%) stddev-sans-first:7.57 13:15:07 INFO - PROCESS | 3788 | Values: 117.0 116.0 138.0 116.0 115.0 118.0 117.0 115.0 114.0 114.0 13:15:07 INFO - PROCESS | 3788 | 13:15:07 INFO - PROCESS | 3788 | [#1] audio-beat-detection Cycles:10 Average:146.50 Median:149.00 stddev:22.95 (15.4%) stddev-sans-first:24.28 13:15:07 INFO - PROCESS | 3788 | Values: 151.0 126.0 150.0 180.0 123.0 148.0 148.0 127.0 188.0 124.0 13:15:07 INFO - PROCESS | 3788 | 13:15:07 INFO - PROCESS | 3788 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.50 stddev:0.84 (0.5%) stddev-sans-first:0.88 13:15:07 INFO - PROCESS | 3788 | Values: 161.0 162.0 161.0 162.0 163.0 160.0 161.0 161.0 161.0 162.0 13:15:07 INFO - PROCESS | 3788 | 13:15:07 INFO - PROCESS | 3788 | [#3] audio-fft Cycles:10 Average:92.90 Median:76.50 stddev:35.38 (46.2%) stddev-sans-first:36.93 13:15:07 INFO - PROCESS | 3788 | Values: 75.0 75.0 77.0 159.0 77.0 77.0 75.0 76.0 161.0 77.0 13:15:07 INFO - PROCESS | 3788 | 13:15:07 INFO - PROCESS | 3788 | [#4] audio-oscillator Cycles:10 Average:100.70 Median:83.50 stddev:27.69 (33.2%) stddev-sans-first:28.70 13:15:07 INFO - PROCESS | 3788 | Values: 84.0 84.0 139.0 85.0 84.0 83.0 150.0 83.0 83.0 132.0 13:15:07 INFO - PROCESS | 3788 | 13:15:07 INFO - PROCESS | 3788 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 13:15:07 INFO - PROCESS | 3788 | Values: 117.0 117.0 116.0 116.0 117.0 117.0 117.0 117.0 116.0 117.0 13:15:07 INFO - PROCESS | 3788 | 13:15:07 INFO - PROCESS | 3788 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 13:15:07 INFO - PROCESS | 3788 | Values: 146.0 147.0 145.0 146.0 146.0 146.0 146.0 147.0 147.0 146.0 13:15:07 INFO - PROCESS | 3788 | 13:15:07 INFO - PROCESS | 3788 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 13:15:07 INFO - PROCESS | 3788 | Values: 95.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 13:15:07 INFO - PROCESS | 3788 | 13:15:07 INFO - PROCESS | 3788 | [#8] json-parse-financial Cycles:10 Average:65.30 Median:65.00 stddev:1.77 (2.7%) stddev-sans-first:1.81 13:15:07 INFO - PROCESS | 3788 | Values: 64.0 70.0 64.0 65.0 64.0 65.0 65.0 66.0 65.0 65.0 13:15:07 INFO - PROCESS | 3788 | 13:15:07 INFO - PROCESS | 3788 | [#9] json-stringify-tinderbox Cycles:10 Average:65.30 Median:65.00 stddev:0.48 (0.7%) stddev-sans-first:0.50 13:15:07 INFO - PROCESS | 3788 | Values: 65.0 65.0 65.0 66.0 65.0 65.0 65.0 66.0 65.0 66.0 13:15:07 INFO - PROCESS | 3788 | 13:15:07 INFO - PROCESS | 3788 | [#10] stanford-crypto-aes Cycles:10 Average:84.50 Median:84.00 stddev:3.63 (4.3%) stddev-sans-first:3.81 13:15:07 INFO - PROCESS | 3788 | Values: 83.0 82.0 82.0 82.0 91.0 85.0 82.0 85.0 91.0 82.0 13:15:07 INFO - PROCESS | 3788 | 13:15:07 INFO - PROCESS | 3788 | [#11] stanford-crypto-ccm Cycles:10 Average:137.10 Median:133.00 stddev:11.71 (8.8%) stddev-sans-first:12.28 13:15:07 INFO - PROCESS | 3788 | Values: 132.0 132.0 131.0 138.0 132.0 133.0 133.0 128.0 168.0 144.0 13:15:07 INFO - PROCESS | 3788 | 13:15:07 INFO - PROCESS | 3788 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.10 Median:175.50 stddev:2.47 (1.4%) stddev-sans-first:2.59 13:15:07 INFO - PROCESS | 3788 | Values: 175.0 175.0 178.0 176.0 175.0 175.0 173.0 177.0 175.0 182.0 13:15:07 INFO - PROCESS | 3788 | 13:15:07 INFO - PROCESS | 3788 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.20 Median:70.50 stddev:1.62 (2.3%) stddev-sans-first:1.72 13:15:07 INFO - PROCESS | 3788 | Values: 70.0 69.0 72.0 70.0 68.0 73.0 68.0 70.0 71.0 71.0 13:15:07 INFO - PROCESS | 3788 | -------- Summary: end -------- 13:15:07 INFO - PROCESS | 3788 | 13:15:08 INFO - TEST-INFO | 3788: exit 0 13:15:09 INFO - TEST-OK | kraken | took 64391ms 13:15:09 INFO - SUITE-END | took 1187s 13:15:09 INFO - Completed test suite (00:19:47) 13:15:09 INFO - javascript benchmark 13:15:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2548.082690231517, 2553.527597394483, 2563.397601563632, 2580.238829545284, 2586.301698541395, 4597.195490789107, 4604.11442025652, 4657.743824089674, 4681.063787242552, 4742.620590352768, 4673.509281525442, 4678.485366609679, 4706.223473126938, 4718.952810471894, 4780.426348838144, 4290.957090429102, 4326.394304797331, 4352.521222665504, 4354.281543545311, 4364.105358401536, 4316.136772645467, 4338.479382474107, 4349.69552131351, 4384.145091707102, 4447.35513350564, 4375.387445757597, 4379.562043795611, 4399.890002749925, 4418.028033832552, 4425.291953287475, 4242.53332133465, 4270.124624452011, 4309.224339618867, 4342.804573794171, 4364.018095928391, 4200.873973780792, 4202.285611446062, 4209.852655157055, 4222.113356195203, 4230.090530535918, 4590.793414296365, 4622.791974361162, 4644.2801365788355, 4660.300954856764, 4669.369635099286, 4857.344258525124, 4957.281194226853, 4992.201247800371, 5001.499850015006, 5054.7472626368535, 4894.583960363373, 4971.0, 5020.246962955549, 5022.824201152942, 5067.619928505377, 4664.5568670976545, 4677.368555244999, 4680.648951328664, 4698.201305778026, 4735.431748190239, 5000.499950004971, 5083.135866902636, 5136.614753893473, 5143.254228136899, 5149.510796474329, 4834.734089625104, 4847.394075740533, 4857.587105096107, 4917.286993385939, 4918.139325618003, 4964.404271487445, 4980.12847751642, 4985.102681517289, 4989.501049894981, 5040.39515258164, 4803.447603525639, 4853.0779151961015, 4947.777350019258, 4948.480409557017, 5010.924836127461, 4878.853634390903, 4908.4846091160625, 4935.457099719028, 5009.373828271466, 5013.724245166551, 4304.268274393361, 4309.676774241944, 4315.0, 4315.741055536678, 4363.127374525107, 3763.8870833875026, 3768.9246215075545, 3783.1487915219404, 3784.2053168834304, 3795.1081495848453, 4225.281702110648, 4285.935710964338, 4289.013526888771, 4300.333448315453, 4355.324924636687, 4981.676191047571, 4987.202047672427, 5004.824831130893, 5007.148784706608, 5047.343845300161, 4285.314349704033, 4294.463192100988, 4299.1831552005015, 4311.590398912098, 4352.107817897323, 4445.911081778347, 4464.6428285737065, 4533.478649955231, 4537.8184872604725, 4593.54064593538, 4679.227927391942, 4697.694649847749, 4704.411948506437, 4710.858674239778, 4748.358971538798, 4992.051510213048, 5004.049230646166, 5015.072211640858, 5017.297578339108, 5075.593952483719, 4541.772911354486, 4634.976825115853, 4665.883352916204, 4699.882502937454, 4748.643851711066, 4885.951140488692, 4891.388576427947, 4918.852434426973, 4924.975375123101, 4971.254311853251, 4978.751062446936, 4986.15235409974, 4994.32576602154, 4994.650374473752, 5056.089903817348, 4751.311059896365, 4845.8061677533915, 4848.61211103118, 4849.660523763303, 4911.68074075184, 4828.879278017937, 4854.029194161252, 4854.732989685601, 4858.854234372974, 4914.852554423373, 4685.718856868462, 4752.2158843790385, 4763.928541071818, 4774.188387974123, 4855.150348689036, 4810.975945120252, 4878.07316609843, 4901.313816065683, 4921.876953076202, 5003.374578177728, 4809.78355973975, 4833.613310935187, 4836.951630483791, 4839.0, 4901.166801643658], "value": 4588.529693254578, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [567.6083502383356, 574.293618848816, 577.7053702611666, 579.623244890821, 583.3116922032002, 28358.432831343387, 40380.0, 42091.368629470584, 42139.57860421399, 42174.15651686965, 39605.40591891124, 39907.40138897919, 40001.599944001966, 40024.0, 40059.39910901331, 7571.9621401893055, 7718.343940765014, 7719.035120609924, 7719.228077192292, 7722.343600793911, 7597.696092156307, 7647.885281720779, 7658.808529786744, 7687.423443241752, 7689.077310722721, 7671.961640191791, 7727.304542591166, 7756.883646745303, 7799.922000780005, 7802.570858602775, 7752.728654497094, 7789.3768498519985, 7799.025121859768, 7799.688012479494, 7800.141984381742, 7527.6236188190915, 7558.0, 7569.697212111509, 7570.659320330543, 7571.659275332623, 36419.63580364189, 36810.447843282374, 36875.446868297, 36944.0, 36966.63033369659, 2917.7811664125065, 2951.8081324713826, 3018.8792448302042, 3175.872965081394, 3266.3467306538787, 27800.582991254945, 28001.299967500974, 28074.578881316796, 28272.85863570669, 29550.26124346887, 3412.283420481702, 3468.670476304747, 3496.7901925884275, 3504.7721898076798, 3626.6373362663785, 229070.0, 229126.0, 229284.0, 230897.0, 231046.0, 48546.514534854905, 48903.86509416531, 49037.0, 49067.75466122646, 49133.0, 31561.36877262442, 32320.0, 32597.0, 34247.0, 51785.44643660696, 13392.665183370495, 13658.04393692432, 13675.0, 13677.726445471035, 13679.726405471834, 10044.949775251076, 10108.494575271206, 10114.747131321776, 10116.08955194036, 10120.342177758423, 17502.649947000988, 17706.937583745017, 17707.203175857117, 17766.64717144308, 17781.0, 6890.896636550356, 6938.653067346612, 6964.815981283194, 6971.755988540377, 7121.92878071223, 735.3822788857385, 864.3646919514152, 879.9560021999002, 912.8585069314134, 937.6202637931649, 26862.462750745268, 26968.730312697015, 27062.86468567684, 27688.446231075264, 27939.720602793714, 781.2226834299794, 894.1594900793234, 935.5602866652663, 972.5623469438781, 987.1107835129567, 13527.45890164402, 14618.926905365617, 14742.778858317133, 14830.406783728746, 15136.318865651072, 352727.0, 354060.0, 355717.0, 356069.0, 356250.0, 47482.76258618754, 47711.5228847714, 47740.283895741595, 47776.28335574969, 47885.28172077422, 1018.8013337399284, 1104.2104895000114, 1105.9778804423865, 1138.7836311100864, 1184.9644510664693, 20057.29512991412, 28931.421371572873, 30703.846480767454, 31095.378092438477, 31362.52956205613, 44421.0, 45054.324185137906, 45078.54921450744, 45105.32342014938, 45162.0, 312628.0, 316217.0, 316411.0, 316641.0, 318500.0, 24374.634380483953, 24741.25776226644, 25259.368515787253, 25327.493450131264, 25353.619695704212, 40586.594134059465, 41049.1790164201, 41641.0, 41902.0, 42172.0, 34296.485552717226, 34599.4810077844, 34701.652983469845, 35138.648613513535, 35723.28553428865, 34871.47692784661, 34965.30069398547, 35353.46969795404, 35430.645693542734, 35709.46435803413, 33693.32613347768, 33781.0, 34462.827685862416, 34884.82557587297, 34961.65038349584, 29531.409371812013, 31911.68088319087, 32525.837370812995, 32529.34941301208, 32605.228555572092, 24214.128550639034, 24404.267871963868, 24631.52138791511, 24666.753332466447, 24712.0], "value": 16885.833719922295, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [329.2361720807727, 351.70105410401163, 367.16103703038556, 367.70399828138346, 377.9603141670125, 12639.431225594848, 15422.537323880288, 17288.308467661278, 17366.82633173671, 17576.648467030653, 13561.796573051412, 16009.439669611565, 16519.83480165198, 16563.751543726852, 16605.83394166058, 5503.559715222783, 5855.941440585603, 5863.0, 5875.794347197849, 5877.2065771121, 4028.516578010628, 5771.884562308751, 5860.384659610743, 5864.5894787364905, 6701.4303784178155, 6977.860442791167, 7143.107111611049, 7150.642467876612, 7153.785386438415, 7157.570545767245, 6880.69036893341, 7075.080239568823, 7077.5399599025895, 7091.219965803757, 7097.254788247212, 6572.967135164341, 6844.863102737917, 6848.212455567624, 6849.452043836481, 6906.06768086312, 23708.88145559261, 23781.643275350885, 23880.522389552112, 23887.283381498582, 23955.520889582112, 1916.8945707986056, 2129.105775574247, 2199.538096999632, 2271.0121097322553, 2451.8038556915403, 13405.46378144873, 14549.345279462344, 14669.853301467063, 15115.622109447242, 15281.694366112726, 1682.1832420985306, 1795.3446991848011, 1902.7906930237664, 1905.3617038292189, 1917.3768525229357, 52414.47585524134, 64213.0, 69718.3028169722, 77659.0, 81075.0, 15043.924780376028, 16359.182040897907, 16567.781148938047, 16823.915880420518, 16842.494725158263, 28584.0, 28590.142295730744, 28615.71384286172, 28627.28431789222, 28669.28326791805, 7978.800529986681, 8001.759947201594, 8245.381596380295, 8267.049289331684, 8475.533845638549, 6476.093346931433, 6539.2479864815205, 6586.769463068769, 6812.0, 6856.485763567753, 8297.792555186168, 8315.750527484186, 8391.748247552583, 8525.950173667583, 8561.700340488052, 2633.710291867893, 2899.594056832045, 3198.168476196159, 3220.8711651534145, 3226.709596136359, 803.445622520459, 816.3102178659024, 832.4755404095503, 846.8729690546344, 885.8449771289999, 15597.298121584556, 15713.38592123818, 17397.826021739875, 17478.563035923948, 18760.061996900375, 810.3517186251094, 820.9630566624517, 831.1024093978489, 840.5923127283263, 893.2184338703635, 9270.887493500823, 9816.901830981742, 9840.803183936281, 9903.45530995802, 10006.499675016366, 389747.0, 392821.0, 393390.0, 397741.0, 400175.0, 76802.61598692082, 77818.0, 78428.21571784209, 78625.60687196642, 78693.0, 902.8871391076246, 911.996803516127, 938.9014153513783, 939.4457270210609, 942.5146049784366, 15100.169490678118, 15140.318685658951, 15410.69178616399, 15817.209139543207, 15929.645980091822, 36922.0, 36927.63072369242, 37893.81053094717, 38236.235275294894, 38344.80827595844, 50443.49556504388, 50663.746681266355, 50675.23987140122, 50842.74578627083, 52196.73901630467, 7442.181360050282, 7522.623868806647, 7542.811429714301, 7740.922590774246, 7747.1090824555895, 8888.64445422176, 11654.65036048886, 11780.764384712087, 11903.46434410471, 11924.523019079139, 9935.850962235716, 10076.345037572535, 10381.584736610452, 10434.739131521468, 10477.842832357674, 10032.64885728996, 10375.481225938824, 10423.21825863048, 10509.474526273809, 10536.15710743154, 10170.898291016994, 10406.739831504274, 10494.580216791242, 10531.262811603114, 10646.8402973957, 7558.206388329147, 7577.355924746238, 7635.312821846061, 7733.806654833449, 7798.6490607923915, 9994.500274986367, 10342.5345859435, 10607.681769546925, 10761.192910531585, 11063.225574209728], "value": 9197.551698646006, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1309.9738005239894, 1342.91942483451, 1379.593020059083, 1608.2441252611268, 1631.6981358448681, 6730.0, 7113.928860711398, 7535.246475352462, 7582.848343033136, 7714.112877019137, 7576.318131368176, 7925.722599708997, 7941.7617471475805, 7944.801379965504, 7950.721724739621, 2165.7834216578335, 2185.9781402186013, 2195.5938151441956, 2196.3081629286803, 2197.2968650031994, 1871.4759867237128, 2096.2767845093417, 2156.7304086989125, 2165.263810304496, 2192.5943700415396, 2158.6330323844986, 2182.71624688791, 2185.442712108418, 2187.3109970359365, 2190.496185877249, 2048.283100914683, 2053.0, 2053.435305291042, 2094.9266775662854, 2123.2674727219087, 2115.788421157887, 2131.5417185305078, 2132.1897678882083, 2137.0917360122044, 2144.8498605097648, 7889.447738658297, 7923.207679232089, 7939.126696063428, 7940.2059794020715, 7946.880796788053, 4290.077633308822, 4325.52419233884, 4327.459067616548, 4339.71791833533, 4345.565443455661, 2762.3646561290816, 2867.5411934090653, 2897.8551072446294, 2902.3614804742924, 2908.7382135607895, 917.2295271971576, 956.9425784508088, 962.7544976031137, 970.0590427285522, 978.0757184460688, 10603.310784798963, 10648.893511064867, 10654.893451065467, 10694.518746656342, 10707.785844283071, 3742.176721121349, 4057.634812866797, 4288.399624052635, 4303.182395344875, 4304.397384366192, 9165.81668366629, 9183.265338772882, 9266.907330926739, 9280.953595232115, 9287.90712092884, 4394.714343567658, 4399.010222699867, 4406.27296496081, 4407.0, 4410.117976404732, 3949.881503554898, 3963.6432721055244, 3964.72246942717, 3965.345717956505, 3970.821313040862, 3496.5104885316077, 3621.4386770050683, 3647.598764135943, 3658.9817050914576, 3679.6688298053305, 1076.3918386111823, 1118.3234143343323, 1159.5709587452698, 1160.4139909345727, 1206.1135065726685, 671.8992151177265, 766.4864540757706, 779.8674225381699, 786.7482405630143, 806.1575653442167, 4900.485449027872, 5038.546530812245, 5069.188929771292, 5078.619103567247, 5265.078611243017, 787.8345547435102, 832.4589017138787, 837.1293854391487, 849.9490030598184, 859.4198915731981, 3382.8477718502727, 3410.2326976430104, 3429.176997520577, 3436.570428696413, 3544.4328907374697, 8786.780330491662, 9142.680006199884, 9337.066293370608, 9341.859872101924, 9352.672656457127, 9221.400608960395, 9265.2124569411, 9269.582868770922, 9271.536423178813, 9276.443413395218, 7053.858922821618, 7073.610951397723, 7103.857922841617, 7125.572465652078, 7146.892796608055, 4708.576228139484, 4764.2615394613895, 4786.210275304675, 4885.682430641997, 4906.190478570996, 8463.915360846313, 8605.182507661762, 8635.784105397415, 8645.308375330083, 8689.435186712843, 8568.914310856811, 8784.033756286675, 8860.911390886009, 8934.553272336487, 8997.415168014059, 6466.353364663684, 6601.966990165019, 6662.167229096363, 6669.366410191024, 6744.258131605618, 7457.291557302047, 7531.962340188264, 7538.585377804274, 7538.886916696364, 7554.093508778982, 6588.472922166311, 6643.202815661958, 6717.261101278953, 6789.355011273921, 6905.861882762417, 6506.349365063646, 6655.035019922181, 6682.431993280626, 6698.028785826125, 6712.731490740511, 5921.348651648402, 6008.54935879802, 6017.608855424383, 6018.067199584071, 6022.728977196124, 4348.195583817004, 4464.709793863389, 4479.910401792011, 4508.616767574793, 4562.36126942235, 4224.957750422579, 4368.85490118187, 4497.460304763318, 4522.615577675934, 4578.656600755024], "value": 4039.5184430493077, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [291.24567370510374, 298.5506812247567, 299.34742261869116, 299.98950036748715, 304.70443669640446, 4814.4222693276815, 4815.686980346275, 4820.39745031871, 4838.733869637173, 4854.296127061579, 4753.548412900777, 4759.690620109691, 4761.666683332168, 4761.952380476194, 4770.522947705228, 3574.7676401033914, 3660.7620504667243, 3767.7550959187565, 3781.8109094545302, 3813.9809300953457, 3807.733458657895, 3810.4474851146565, 3811.1996480739076, 3823.1780167264033, 3832.5784163741964, 3784.6186142058227, 3798.772073675588, 3800.144967382331, 3801.1257410795533, 3804.7526910750853, 3602.963970360289, 3635.1275693833422, 3747.156889699823, 3757.981210093932, 3764.7176461765475, 3322.6178989416044, 3329.6004479462617, 3337.716294115003, 3343.4650455926935, 3349.7822641528464, 4647.18674232008, 4649.325847752057, 4655.115528049693, 4655.4878963314, 4695.366125573072, 4174.91650166998, 4268.59448352406, 4272.397850805948, 4305.526392096898, 4306.20335237982, 4941.604671626261, 4950.653454258203, 4952.479989601076, 4961.330220420269, 4967.205247160473, 3662.926741465156, 3667.21154951684, 3667.5965643779164, 3670.4310831821113, 3671.6047901797415, 5076.13705670037, 5124.718140502271, 5210.739463026872, 5226.947730522684, 5249.343832020997, 3644.3804553226014, 3679.5400574928135, 3692.390755525308, 3695.4087346024507, 3697.354677168688, 3745.4569087482164, 3747.6439738224826, 3750.774953502799, 3751.212245428436, 3754.8310326035394, 4253.659707223414, 4257.254980378421, 4264.123785534355, 4267.722598031118, 4267.97866010668, 4834.0, 4884.986761420115, 4910.386201724785, 4924.852254432301, 4980.626453016038, 1295.5659853949032, 1308.770965081126, 1311.4164196932275, 1312.9409176586885, 1313.1661395014235, 811.7158994351929, 849.1550906847726, 862.7411776467035, 866.207420210513, 867.4968518259394, 4304.978475107604, 4421.9336709949375, 4430.42404487421, 4435.804276882964, 4436.292027569344, 5110.565601923878, 5128.281995553194, 5130.692158470503, 5150.0, 5154.092985595279, 4407.716251392669, 4450.1296663651765, 4465.955340446554, 4467.352233926063, 4467.977660111678, 2593.5087324788324, 2729.7816174705977, 2735.193118030186, 2748.8900443982016, 2757.648752111451, 4829.468758436569, 4835.799711131427, 4862.610991120772, 4863.319135321058, 4882.6826256293225, 5054.0, 5257.4764113225865, 5272.762725677354, 5287.41838397776, 5312.840614781563, 4835.87221622485, 4877.6585639004925, 4890.168671325883, 4898.608111351155, 4899.804007839646, 5180.896382072413, 5184.740762961912, 5186.481351864783, 5212.9739351303, 5219.634625576326, 4826.0830442215865, 5043.672161309503, 5054.721990290569, 5103.902660927918, 5107.565856902205, 4897.975510122426, 4914.803407863646, 4919.926201106915, 4921.237208232729, 4928.408590969107, 3686.686631636234, 3692.8367564217187, 3701.777893326409, 3703.685186759156, 3708.554973403209, 4925.532074452921, 5225.372955245395, 5235.162374020291, 5240.842774716764, 5245.66235609917, 5023.824166154167, 5031.314509639312, 5055.764310840991, 5057.241413787961, 5064.746762661778, 5024.723640199678, 5032.874178145576, 5035.899282014266, 5048.469910659328, 5056.924146137737, 4832.710037397767, 4970.527799859007, 4975.527324904128, 4983.775730092227, 4988.5260900214425, 4835.637327200404, 4945.604351651931, 5025.497450254945, 5050.242463630485, 5071.518205770446, 4898.53463920927, 4905.7792399342825, 4912.287718280901, 4923.65534412602, 4934.235193545006], "value": 3794.9463955896276, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [581.6277582347295, 592.7717828635975, 622.3123448589312, 672.63341478894, 706.3678008182677, 11211.215214934948, 11766.529338826447, 11772.529098836047, 11795.528178872857, 11844.0, 11589.246698964562, 11658.300501969889, 11662.708432289197, 11682.35747033915, 12206.084543659217, 726.6112629743088, 743.8623854586891, 745.1021519069508, 746.3954197100367, 746.9253074692541, 606.2512796696077, 729.6278897762153, 738.9741359052434, 741.5624781378986, 746.8207630168747, 777.2887807655987, 779.8284377436955, 780.6994307191744, 780.7345502529139, 780.8438312337555, 773.157258588136, 776.9728059517889, 777.1102088109084, 777.793884620576, 777.9805504862367, 466.5847395817691, 555.8804856955734, 561.2899681902396, 561.8483009587429, 563.892860356535, 11819.704507387383, 11881.108916831272, 11905.4642541085, 11979.520819167223, 11988.400579971054, 11114.22200445969, 11135.832962505569, 11513.884861151366, 11588.826167607493, 12131.757364852654, 11289.266197697205, 11372.658820235407, 11388.956676345035, 11647.184697071209, 11724.765504689944, 3797.012776678056, 3831.8467261309515, 3839.520059992501, 3850.152966347399, 3922.2155568886337, 57746.0, 66210.66894665544, 66526.66736666382, 66977.0, 68745.65627171882, 8722.520261385685, 8870.556472176366, 9372.937953650322, 9457.43255404678, 9672.903270967341, 15243.390264389522, 15536.145511996723, 15543.0, 15546.84453155454, 15567.0, 6678.0, 6704.229013663491, 6826.180858297036, 7057.0, 7062.540934839219, 3425.72594192464, 3583.569971603424, 3640.5449318835144, 3660.890173294805, 3681.079730067483, 2817.21118086936, 2938.074506530436, 2943.528235882059, 2945.0428610701606, 2945.6759756426777, 506.235584267751, 512.823076038766, 515.1114327784617, 517.2319106127397, 524.9212618107238, 481.94698583155827, 493.60264986686065, 513.1188377261723, 538.5449295345427, 559.6921693068796, 7192.604406757574, 7403.555786652711, 7471.8505629887095, 7474.177840437547, 7977.5612341321785, 522.7020598258956, 544.7221916822369, 553.6318348298418, 560.873803394233, 575.2751533068364, 3532.682058614737, 3743.3823419136083, 3902.824372903226, 3925.842966281317, 3943.6253555912144, 59022.40977590169, 59550.0, 59620.40379596149, 59656.40343596508, 78090.6095469519, 64684.676576617756, 70914.64542677357, 74169.0, 76110.0, 77948.0, 49194.508054918995, 66423.0, 66471.0, 68904.38695163105, 70577.64711176412, 7508.9862868512055, 7595.278448547379, 7726.266004729542, 7922.564258965812, 8026.1171271158955, 31655.52516712205, 37694.0, 38173.236535269694, 38259.42610860783, 42731.78634106934, 39856.402153968294, 53366.73316633392, 53767.46232537625, 58909.70545147418, 59256.70371648114, 10661.147108231478, 10674.83987740169, 10813.891861081289, 10831.458427078456, 11061.11511079128, 11729.47217375203, 11834.82247766267, 12438.81341779856, 12538.56115036006, 12750.61748147557, 9897.752556186153, 9980.251481139088, 9990.850137247802, 10111.494425278854, 10334.0, 8782.253508451598, 9007.369484136048, 9223.861642075508, 9259.953700231456, 10583.4708264588, 10516.68449946503, 10925.562977480811, 10982.395968221825, 11139.273412621056, 11204.719882003015, 9893.950530247303, 10004.349717268355, 10226.386416815016, 10316.793664126526, 10680.889312654865, 8639.91360086391, 8658.7233703977, 9495.097965693249, 9564.856527151958, 9645.614175433186], "value": 6067.614576554908, "unit": "score"}], "name": "dromaeo_css", "value": 6361.7827863283055, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 138.0, 116.0, 115.0, 118.0, 117.0, 115.0, 114.0, 114.0], "value": 118.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 126.0, 150.0, 180.0, 123.0, 148.0, 148.0, 127.0, 188.0, 124.0], "value": 146.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 161.0, 162.0, 163.0, 160.0, 161.0, 161.0, 161.0, 162.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 77.0, 159.0, 77.0, 77.0, 75.0, 76.0, 161.0, 77.0], "value": 92.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 139.0, 85.0, 84.0, 83.0, 150.0, 83.0, 83.0, 132.0], "value": 100.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 145.0, 146.0, 146.0, 146.0, 146.0, 147.0, 147.0, 146.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 70.0, 64.0, 65.0, 64.0, 65.0, 65.0, 66.0, 65.0, 65.0], "value": 65.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 66.0, 65.0, 65.0, 65.0, 66.0, 65.0, 66.0], "value": 65.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 82.0, 82.0, 91.0, 85.0, 82.0, 85.0, 91.0, 82.0], "value": 84.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 132.0, 131.0, 138.0, 132.0, 133.0, 133.0, 128.0, 168.0, 144.0], "value": 137.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 175.0, 178.0, 176.0, 175.0, 175.0, 173.0, 177.0, 175.0, 182.0], "value": 176.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 69.0, 72.0, 70.0, 68.0, 73.0, 68.0, 70.0, 71.0, 71.0], "value": 70.2, "unit": "score"}], "name": "kraken", "value": 1576.0, "alertThreshold": 2.0}]} 13:15:09 INFO - Return code: 0 13:15:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:15:09 INFO - # TBPL SUCCESS # 13:15:09 INFO - Running post-action listener: _resource_record_post_action 13:15:09 INFO - [mozharness: 2016-08-29 20:15:09.600627Z] Finished run-tests step (success) 13:15:09 INFO - Running post-run listener: _resource_record_post_run 13:15:09 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 7843840; Write bytes: 435441664; Read time: 1940; Write time: 294204 13:15:09 INFO - TinderboxPrint: CPU usage
13.0% 13:15:09 INFO - TinderboxPrint: I/O read bytes / time
7,843,840 / 1,940 13:15:09 INFO - TinderboxPrint: I/O write bytes / time
435,441,664 / 294,204 13:15:09 INFO - TinderboxPrint: CPU idle
8,355.8 (87.0%) 13:15:09 INFO - TinderboxPrint: CPU user
1,198.7 (12.5%) 13:15:09 INFO - TinderboxPrint: Swap in / out
0 / 0 13:15:09 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 4096; Write bytes: 69292032; Read time: 44; Write time: 32320 13:15:09 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 5599232; Write bytes: 342622208; Read time: 1720; Write time: 235016 13:15:10 INFO - Running post-run listener: _upload_blobber_files 13:15:10 INFO - Blob upload gear active. 13:15:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:15:10 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 13:15:10 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'] 13:15:10 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 13:15:10 INFO - (blobuploader) - INFO - Open directory for files ... 13:15:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:15:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:15:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:15:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:15:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:15:11 INFO - (blobuploader) - INFO - Done attempting. 13:15:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:15:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:15:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:15:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:15:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:15:16 INFO - (blobuploader) - INFO - Done attempting. 13:15:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:15:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:15:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:15:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:15:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:15:17 INFO - (blobuploader) - INFO - Done attempting. 13:15:17 INFO - (blobuploader) - INFO - Iteration through files over. 13:15:17 INFO - Return code: 0 13:15:17 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:15:17 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:15:17 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/7e834d33bfb720373271cd58ad67b7c5ccf07c4c85ee7d6b9c0a7d1209d28af029d0f580e7beec10d663f9e25aaa2220eaa51f5741c7d91de361074aac5ddc49", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/c86e3cbdae54946df16e27df3dc1cfca15fd65a13bf508766c680cbcbfec5bcc103aa180eb371903c91d7d1c6cd380970e2b8674eab67b870a4ba9f4f67cd7f6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/1d2efa8d5010bf58917f8861367dcd143f59a5aee969b643def5d846e360b962a7fcdb8beabc7172455ce629557499cb7490b70e84e6cf5ccdb60fd6a6cca726"} 13:15:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:15:17 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:15:17 INFO - Contents: 13:15:17 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/7e834d33bfb720373271cd58ad67b7c5ccf07c4c85ee7d6b9c0a7d1209d28af029d0f580e7beec10d663f9e25aaa2220eaa51f5741c7d91de361074aac5ddc49", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/c86e3cbdae54946df16e27df3dc1cfca15fd65a13bf508766c680cbcbfec5bcc103aa180eb371903c91d7d1c6cd380970e2b8674eab67b870a4ba9f4f67cd7f6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/1d2efa8d5010bf58917f8861367dcd143f59a5aee969b643def5d846e360b962a7fcdb8beabc7172455ce629557499cb7490b70e84e6cf5ccdb60fd6a6cca726"} 13:15:17 INFO - Running post-run listener: copy_logs_to_upload_dir 13:15:17 INFO - Copying logs to upload dir... 13:15:17 INFO - mkdir: /builds/slave/test/build/upload/logs 13:15:17 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.256807 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-08-29 13:15:17.507831) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-29 13:15:17.511495) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=31acecf42b6a79ec49471d4a000001bb-1472500115.148332-892760239 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/7e834d33bfb720373271cd58ad67b7c5ccf07c4c85ee7d6b9c0a7d1209d28af029d0f580e7beec10d663f9e25aaa2220eaa51f5741c7d91de361074aac5ddc49", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/c86e3cbdae54946df16e27df3dc1cfca15fd65a13bf508766c680cbcbfec5bcc103aa180eb371903c91d7d1c6cd380970e2b8674eab67b870a4ba9f4f67cd7f6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/1d2efa8d5010bf58917f8861367dcd143f59a5aee969b643def5d846e360b962a7fcdb8beabc7172455ce629557499cb7490b70e84e6cf5ccdb60fd6a6cca726"} build_url:https://queue.taskcluster.net/v1/task/MNjN4BJaSziOsauQkbuxWA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011271 build_url: 'https://queue.taskcluster.net/v1/task/MNjN4BJaSziOsauQkbuxWA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/7e834d33bfb720373271cd58ad67b7c5ccf07c4c85ee7d6b9c0a7d1209d28af029d0f580e7beec10d663f9e25aaa2220eaa51f5741c7d91de361074aac5ddc49", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/c86e3cbdae54946df16e27df3dc1cfca15fd65a13bf508766c680cbcbfec5bcc103aa180eb371903c91d7d1c6cd380970e2b8674eab67b870a4ba9f4f67cd7f6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/1d2efa8d5010bf58917f8861367dcd143f59a5aee969b643def5d846e360b962a7fcdb8beabc7172455ce629557499cb7490b70e84e6cf5ccdb60fd6a6cca726"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-29 13:15:17.536623) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 13:15:17.536943) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=31acecf42b6a79ec49471d4a000001bb-1472500115.148332-892760239 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004340 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 13:15:17.620820) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-29 13:15:17.621145) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-29 13:15:17.621417) ========= ========= Total master_lag: 0.31 =========